builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1469727855.64 results: success (0) buildid: 20160728070523 builduid: 62b5ec94122c4d369086bc4b6fc7af93 revision: db8d264de7e3ed62616a1b36bf7a037273faea58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:15.641503) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:15.642126) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:15.642497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:15.657470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:15.657858) ========= 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=8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 10:44:15-- 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% 40.3M=0s 2016-07-28 10:44:16 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:15.784963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:15.785685) ========= 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=8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017335 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:15.837320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:15.837834) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev db8d264de7e3ed62616a1b36bf7a037273faea58 --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 db8d264de7e3ed62616a1b36bf7a037273faea58 --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=8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 10:44:16,211 truncating revision to first 12 chars 2016-07-28 10:44:16,211 Setting DEBUG logging. 2016-07-28 10:44:16,211 attempt 1/10 2016-07-28 10:44:16,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/db8d264de7e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 10:44:16,519 unpacking tar archive at: mozilla-aurora-db8d264de7e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:16.496040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:16.496396) ========= script_repo_revision: db8d264de7e3ed62616a1b36bf7a037273faea58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:16.497052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:16.497381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:44:16.508150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-28 10:44:16.508471) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:44:16 INFO - MultiFileLogger online at 20160728 10:44:16 in /builds/slave/test 10:44:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:44:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:44:16 INFO - {'append_to_log': False, 10:44:16 INFO - 'base_work_dir': '/builds/slave/test', 10:44:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:44:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:44:16 INFO - 'branch': 'Mozilla-Aurora', 10:44:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:44:16 INFO - 'config_files': ('talos/linux_config.py',), 10:44:16 INFO - 'default_actions': ('clobber', 10:44:16 INFO - 'read-buildbot-config', 10:44:16 INFO - 'download-and-extract', 10:44:16 INFO - 'populate-webroot', 10:44:16 INFO - 'create-virtualenv', 10:44:16 INFO - 'install', 10:44:16 INFO - 'run-tests'), 10:44:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:44:16 INFO - 'download_minidump_stackwalk': True, 10:44:16 INFO - 'download_symbols': 'ondemand', 10:44:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:44:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:44:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:44:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:44:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:44:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:44:16 INFO - 'installer_path': 'installer.exe', 10:44:16 INFO - 'log_level': 'info', 10:44:16 INFO - 'log_name': 'talos', 10:44:16 INFO - 'log_to_console': True, 10:44:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:44:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:44:16 INFO - 'opt_config_files': (), 10:44:16 INFO - 'pip_index': False, 10:44:16 INFO - 'sps_profile': False, 10:44:16 INFO - 'sps_profile_interval': 0, 10:44:16 INFO - 'suite': 'dromaeojs-e10s', 10:44:16 INFO - 'system_bits': '32', 10:44:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:44:16 INFO - 'title': 'talos-linux64-ix-038', 10:44:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:44:16 INFO - 'use_talos_json': True, 10:44:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:44:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:44:16 INFO - 'work_dir': 'build'} 10:44:16 INFO - ##### 10:44:16 INFO - ##### Running clobber step. 10:44:16 INFO - ##### 10:44:16 INFO - Running pre-action listener: _resource_record_pre_action 10:44:16 INFO - Running main action method: clobber 10:44:16 INFO - rmtree: /builds/slave/test/build 10:44:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:44:17 INFO - Running post-action listener: _resource_record_post_action 10:44:17 INFO - ##### 10:44:17 INFO - ##### Finished clobber step (success) 10:44:17 INFO - ##### 10:44:17 INFO - ##### 10:44:17 INFO - ##### Running read-buildbot-config step. 10:44:17 INFO - ##### 10:44:17 INFO - Running pre-action listener: _resource_record_pre_action 10:44:17 INFO - Running main action method: read_buildbot_config 10:44:17 INFO - Using buildbot properties: 10:44:17 INFO - { 10:44:17 INFO - "project": "", 10:44:17 INFO - "product": "firefox", 10:44:17 INFO - "script_repo_revision": "production", 10:44:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:44:17 INFO - "repository": "", 10:44:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:44:17 INFO - "buildid": "20160728070523", 10:44:17 INFO - "pgo_build": "True", 10:44:17 INFO - "basedir": "/builds/slave/test", 10:44:17 INFO - "buildnumber": 415, 10:44:17 INFO - "slavename": "talos-linux64-ix-038", 10:44:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:44:17 INFO - "platform": "ubuntu64_hw", 10:44:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:44:17 INFO - "branch": "mozilla-aurora", 10:44:17 INFO - "repo_path": "releases/mozilla-aurora", 10:44:17 INFO - "revision": "db8d264de7e3ed62616a1b36bf7a037273faea58", 10:44:17 INFO - "stage_platform": "linux64-pgo", 10:44:17 INFO - "builduid": "62b5ec94122c4d369086bc4b6fc7af93", 10:44:17 INFO - "slavebuilddir": "test" 10:44:17 INFO - } 10:44:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 10:44:17 INFO - Running post-action listener: _resource_record_post_action 10:44:17 INFO - ##### 10:44:17 INFO - ##### Finished read-buildbot-config step (success) 10:44:17 INFO - ##### 10:44:17 INFO - ##### 10:44:17 INFO - ##### Running download-and-extract step. 10:44:17 INFO - ##### 10:44:17 INFO - Running pre-action listener: _resource_record_pre_action 10:44:17 INFO - Running main action method: download_and_extract 10:44:17 INFO - mkdir: /builds/slave/test/build/tests 10:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:17 INFO - https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:44:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:44:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:44:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:18 INFO - Downloaded 1361 bytes. 10:44:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:44:18 INFO - Using the following test package requirements: 10:44:18 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:44:18 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:44:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:44:18 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:44:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:44:18 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:44:18 INFO - u'jsshell-linux-x86_64.zip'], 10:44:18 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:44:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:44:18 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:44:18 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:44:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:44:18 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:44:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:44:18 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:44:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:44:18 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:44:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:44:18 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:18 INFO - https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:44:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:44:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:44:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:19 INFO - Downloaded 24494012 bytes. 10:44:19 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'] 10:44:19 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 10:44:20 INFO - Return code: 0 10:44:20 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 10:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:20 INFO - https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:21 INFO - Downloaded 24494012 bytes. 10:44:21 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'] 10:44:21 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 10:44:23 INFO - Return code: 0 10:44: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')]} 10:44:23 INFO - https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:44:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:44:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:44:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:24 INFO - Downloaded 10833369 bytes. 10:44:24 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'] 10:44:24 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 10:44:24 INFO - Return code: 0 10:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:24 INFO - https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:44:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:44:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:44:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/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 10:44:25 INFO - Downloaded 63650015 bytes. 10:44:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:44:25 INFO - mkdir: /builds/slave/test/properties 10:44:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:44:25 INFO - Writing to file /builds/slave/test/properties/build_url 10:44:25 INFO - Contents: 10:44:25 INFO - build_url:https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:44:26 INFO - Running post-action listener: _resource_record_post_action 10:44:26 INFO - Running post-action listener: set_extra_try_arguments 10:44:26 INFO - ##### 10:44:26 INFO - ##### Finished download-and-extract step (success) 10:44:26 INFO - ##### 10:44:26 INFO - ##### 10:44:26 INFO - ##### Running populate-webroot step. 10:44:26 INFO - ##### 10:44:26 INFO - Running pre-action listener: _resource_record_pre_action 10:44:26 INFO - Running main action method: populate_webroot 10:44:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:44:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:44:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:44:26 INFO - '--tppagecycles', 10:44:26 INFO - '7'], 10:44:26 INFO - 'tests': ['tsvgm']}}, 10:44:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:44:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:44:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:44:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:44:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:26 INFO - 'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:26 INFO - 'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['damp', 'tps']}, 10:44:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:26 INFO - 'tests': ['damp', 'tps']}, 10:44:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['dromaeo_dom']}, 10:44:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:44:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['a11yr', 10:44:26 INFO - 'ts_paint', 10:44:26 INFO - 'tpaint', 10:44:26 INFO - 'sessionrestore', 10:44:26 INFO - 'sessionrestore_no_auto_restore', 10:44:26 INFO - 'tabpaint']}, 10:44:26 INFO - 'other-e10s': {'tests': ['a11yr', 10:44:26 INFO - 'ts_paint', 10:44:26 INFO - 'tpaint', 10:44:26 INFO - 'sessionrestore', 10:44:26 INFO - 'sessionrestore_no_auto_restore', 10:44:26 INFO - 'tabpaint']}, 10:44:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:44:26 INFO - 'ts_paint', 10:44:26 INFO - 'tpaint', 10:44:26 INFO - 'sessionrestore', 10:44:26 INFO - 'sessionrestore_no_auto_restore', 10:44:26 INFO - 'tabpaint']}, 10:44:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:44:26 INFO - 'ts_paint', 10:44:26 INFO - 'tpaint', 10:44:26 INFO - 'sessionrestore', 10:44:26 INFO - 'sessionrestore_no_auto_restore', 10:44:26 INFO - 'tabpaint']}, 10:44:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['a11yr', 10:44:26 INFO - 'ts_paint', 10:44:26 INFO - 'tpaint', 10:44:26 INFO - 'sessionrestore', 10:44:26 INFO - 'sessionrestore_no_auto_restore', 10:44:26 INFO - 'tabpaint']}, 10:44:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['a11yr', 10:44:26 INFO - 'ts_paint', 10:44:26 INFO - 'tpaint', 10:44:26 INFO - 'sessionrestore', 10:44:26 INFO - 'sessionrestore_no_auto_restore', 10:44:26 INFO - 'tabpaint']}, 10:44:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['tsvgx', 10:44:26 INFO - 'tsvgr_opacity', 10:44:26 INFO - 'tart', 10:44:26 INFO - 'tscrollx', 10:44:26 INFO - 'cart']}, 10:44:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:44:26 INFO - 'tsvgr_opacity', 10:44:26 INFO - 'tart', 10:44:26 INFO - 'tscrollx', 10:44:26 INFO - 'cart']}, 10:44:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:26 INFO - 'talos_options': ['--disable-e10s'], 10:44:26 INFO - 'tests': ['tp5o']}, 10:44:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:26 INFO - 'tests': ['tp5o']}, 10:44:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:26 INFO - 'talos_options': ['--disable-e10s', 10:44:26 INFO - '--xperf_path', 10:44:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:26 INFO - 'tests': ['tp5n']}, 10:44:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:26 INFO - 'talos_options': ['--xperf_path', 10:44:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:26 INFO - 'tests': ['tp5n']}}, 10:44:26 INFO - 'talos.zip': {'path': '', 10:44:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:44:26 INFO - Running post-action listener: _resource_record_post_action 10:44:26 INFO - ##### 10:44:26 INFO - ##### Finished populate-webroot step (success) 10:44:26 INFO - ##### 10:44:26 INFO - ##### 10:44:26 INFO - ##### Running create-virtualenv step. 10:44:26 INFO - ##### 10:44:26 INFO - Running pre-action listener: _resource_record_pre_action 10:44:26 INFO - Running main action method: create_virtualenv 10:44:26 INFO - Creating virtualenv /builds/slave/test/build/venv 10:44:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:44:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:44:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:44:26 INFO - Using real prefix '/usr' 10:44:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:44:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:44:29 INFO - Installing pip.................done. 10:44:29 INFO - Return code: 0 10:44:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:29 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 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:44:29 INFO - Using env: {'DISPLAY': ':0', 10:44:29 INFO - 'HOME': '/home/cltbld', 10:44:29 INFO - 'LANG': 'en_US.UTF-8', 10:44:29 INFO - 'LANGUAGE': 'en_US:en', 10:44:29 INFO - 'LOGNAME': 'cltbld', 10:44:29 INFO - 'MAIL': '/var/mail/cltbld', 10:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:29 INFO - 'MOZ_NO_REMOTE': '1', 10:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:29 INFO - 'NO_EM_RESTART': '1', 10:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:29 INFO - 'PWD': '/builds/slave/test', 10:44:29 INFO - 'SHELL': '/bin/bash', 10:44:29 INFO - 'SHLVL': '1', 10:44:29 INFO - 'TERM': 'linux', 10:44:29 INFO - 'TMOUT': '86400', 10:44:29 INFO - 'USER': 'cltbld', 10:44:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:29 INFO - '_': '/tools/buildbot/bin/python'} 10:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:44:29 INFO - Cleaning up... 10:44:29 INFO - Return code: 0 10:44:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:29 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 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:44:29 INFO - Using env: {'DISPLAY': ':0', 10:44:29 INFO - 'HOME': '/home/cltbld', 10:44:29 INFO - 'LANG': 'en_US.UTF-8', 10:44:29 INFO - 'LANGUAGE': 'en_US:en', 10:44:29 INFO - 'LOGNAME': 'cltbld', 10:44:29 INFO - 'MAIL': '/var/mail/cltbld', 10:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:29 INFO - 'MOZ_NO_REMOTE': '1', 10:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:29 INFO - 'NO_EM_RESTART': '1', 10:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:29 INFO - 'PWD': '/builds/slave/test', 10:44:29 INFO - 'SHELL': '/bin/bash', 10:44:29 INFO - 'SHLVL': '1', 10:44:29 INFO - 'TERM': 'linux', 10:44:29 INFO - 'TMOUT': '86400', 10:44:29 INFO - 'USER': 'cltbld', 10:44:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:29 INFO - '_': '/tools/buildbot/bin/python'} 10:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:29 INFO - Downloading/unpacking psutil>=3.1.1 10:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:44:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:31 INFO - Installing collected packages: psutil 10:44:31 INFO - Running setup.py install for psutil 10:44:31 INFO - building 'psutil._psutil_linux' extension 10:44:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:44:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:44:31 INFO - building 'psutil._psutil_posix' extension 10:44:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:44:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:44:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:31 INFO - Successfully installed psutil 10:44:31 INFO - Cleaning up... 10:44:32 INFO - Return code: 0 10:44:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:32 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 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:44:32 INFO - Using env: {'DISPLAY': ':0', 10:44:32 INFO - 'HOME': '/home/cltbld', 10:44:32 INFO - 'LANG': 'en_US.UTF-8', 10:44:32 INFO - 'LANGUAGE': 'en_US:en', 10:44:32 INFO - 'LOGNAME': 'cltbld', 10:44:32 INFO - 'MAIL': '/var/mail/cltbld', 10:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:32 INFO - 'MOZ_NO_REMOTE': '1', 10:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:32 INFO - 'NO_EM_RESTART': '1', 10:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:32 INFO - 'PWD': '/builds/slave/test', 10:44:32 INFO - 'SHELL': '/bin/bash', 10:44:32 INFO - 'SHLVL': '1', 10:44:32 INFO - 'TERM': 'linux', 10:44:32 INFO - 'TMOUT': '86400', 10:44:32 INFO - 'USER': 'cltbld', 10:44:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:32 INFO - '_': '/tools/buildbot/bin/python'} 10:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:44:34 INFO - Installing collected packages: mozsystemmonitor 10:44:34 INFO - Running setup.py install for mozsystemmonitor 10:44:34 INFO - Successfully installed mozsystemmonitor 10:44:34 INFO - Cleaning up... 10:44:34 INFO - Return code: 0 10:44:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:44: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')]} 10:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44: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')]} 10:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44: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', '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 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:44: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 jsonschema==2.5.1 10:44:34 INFO - Using env: {'DISPLAY': ':0', 10:44:34 INFO - 'HOME': '/home/cltbld', 10:44:34 INFO - 'LANG': 'en_US.UTF-8', 10:44:34 INFO - 'LANGUAGE': 'en_US:en', 10:44:34 INFO - 'LOGNAME': 'cltbld', 10:44:34 INFO - 'MAIL': '/var/mail/cltbld', 10:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:34 INFO - 'MOZ_NO_REMOTE': '1', 10:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:34 INFO - 'NO_EM_RESTART': '1', 10:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:34 INFO - 'PWD': '/builds/slave/test', 10:44:34 INFO - 'SHELL': '/bin/bash', 10:44:34 INFO - 'SHLVL': '1', 10:44:34 INFO - 'TERM': 'linux', 10:44:34 INFO - 'TMOUT': '86400', 10:44:34 INFO - 'USER': 'cltbld', 10:44:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:34 INFO - '_': '/tools/buildbot/bin/python'} 10:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:34 INFO - Downloading/unpacking jsonschema==2.5.1 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:44:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:44:36 INFO - warning: no files found matching '*.txt' 10:44:36 INFO - no previously-included directories found matching 'build' 10:44:36 INFO - no previously-included directories found matching 'dist' 10:44:36 INFO - no previously-included directories found matching '.git*' 10:44:36 INFO - Installing collected packages: jsonschema, functools32 10:44:36 INFO - Running setup.py install for functools32 10:44:36 INFO - warning: no files found matching '*.txt' 10:44:36 INFO - no previously-included directories found matching 'build' 10:44:36 INFO - no previously-included directories found matching 'dist' 10:44:36 INFO - no previously-included directories found matching '.git*' 10:44:36 INFO - Successfully installed jsonschema functools32 10:44:36 INFO - Cleaning up... 10:44:36 INFO - Return code: 0 10:44:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:36 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 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:44:36 INFO - Using env: {'DISPLAY': ':0', 10:44:36 INFO - 'HOME': '/home/cltbld', 10:44:36 INFO - 'LANG': 'en_US.UTF-8', 10:44:36 INFO - 'LANGUAGE': 'en_US:en', 10:44:36 INFO - 'LOGNAME': 'cltbld', 10:44:36 INFO - 'MAIL': '/var/mail/cltbld', 10:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:36 INFO - 'MOZ_NO_REMOTE': '1', 10:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:36 INFO - 'NO_EM_RESTART': '1', 10:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:36 INFO - 'PWD': '/builds/slave/test', 10:44:36 INFO - 'SHELL': '/bin/bash', 10:44:36 INFO - 'SHLVL': '1', 10:44:36 INFO - 'TERM': 'linux', 10:44:36 INFO - 'TMOUT': '86400', 10:44:36 INFO - 'USER': 'cltbld', 10:44:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:36 INFO - '_': '/tools/buildbot/bin/python'} 10:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44:38 INFO - Downloading blobuploader-1.2.4.tar.gz 10:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:44:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:44:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:39 INFO - Downloading docopt-0.6.1.tar.gz 10:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:44:39 INFO - Installing collected packages: blobuploader, requests, docopt 10:44:39 INFO - Running setup.py install for blobuploader 10:44:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:44:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:44:39 INFO - Running setup.py install for requests 10:44:40 INFO - Running setup.py install for docopt 10:44:40 INFO - Successfully installed blobuploader requests docopt 10:44:40 INFO - Cleaning up... 10:44:40 INFO - Return code: 0 10:44:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:40 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 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:44:40 INFO - Using env: {'DISPLAY': ':0', 10:44:40 INFO - 'HOME': '/home/cltbld', 10:44:40 INFO - 'LANG': 'en_US.UTF-8', 10:44:40 INFO - 'LANGUAGE': 'en_US:en', 10:44:40 INFO - 'LOGNAME': 'cltbld', 10:44:40 INFO - 'MAIL': '/var/mail/cltbld', 10:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:40 INFO - 'MOZ_NO_REMOTE': '1', 10:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:40 INFO - 'NO_EM_RESTART': '1', 10:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:40 INFO - 'PWD': '/builds/slave/test', 10:44:40 INFO - 'SHELL': '/bin/bash', 10:44:40 INFO - 'SHLVL': '1', 10:44:40 INFO - 'TERM': 'linux', 10:44:40 INFO - 'TMOUT': '86400', 10:44:40 INFO - 'USER': 'cltbld', 10:44:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:40 INFO - '_': '/tools/buildbot/bin/python'} 10:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:40 INFO - Running setup.py (path:/tmp/pip-2ZaVZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:40 INFO - Running setup.py (path:/tmp/pip-bI4Uvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:44:40 INFO - Running setup.py (path:/tmp/pip-NE9pdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:44:40 INFO - Running setup.py (path:/tmp/pip-RtcaW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:44:40 INFO - Running setup.py (path:/tmp/pip-lOdW0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:44:40 INFO - Running setup.py (path:/tmp/pip-D4miZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:44:41 INFO - Running setup.py (path:/tmp/pip-khWZa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:44:41 INFO - Running setup.py (path:/tmp/pip-cLLjZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:44:41 INFO - Running setup.py (path:/tmp/pip-zELbJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:44:41 INFO - Running setup.py (path:/tmp/pip-qQeIwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:44:41 INFO - Running setup.py (path:/tmp/pip-nvu84e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:44:41 INFO - Running setup.py (path:/tmp/pip-qY1_Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:44:41 INFO - Running setup.py (path:/tmp/pip-itbn3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:44:41 INFO - Running setup.py (path:/tmp/pip-ToMtPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:41 INFO - Running setup.py (path:/tmp/pip-kKrHqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:44:41 INFO - Running setup.py (path:/tmp/pip-zsvz8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:44:41 INFO - Running setup.py (path:/tmp/pip-01ymCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:44:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:44:41 INFO - Running setup.py install for manifestparser 10:44:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:44:41 INFO - Running setup.py install for mozcrash 10:44:42 INFO - Running setup.py install for mozdebug 10:44:42 INFO - Running setup.py install for mozdevice 10:44:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Running setup.py install for mozfile 10:44:42 INFO - Running setup.py install for mozhttpd 10:44:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Running setup.py install for mozinfo 10:44:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Running setup.py install for mozInstall 10:44:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Running setup.py install for mozleak 10:44:42 INFO - Running setup.py install for mozlog 10:44:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Running setup.py install for moznetwork 10:44:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:44:42 INFO - Running setup.py install for mozprocess 10:44:43 INFO - Running setup.py install for mozprofile 10:44:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:44:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:44:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:44:43 INFO - Running setup.py install for mozrunner 10:44:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:44:43 INFO - Running setup.py install for mozscreenshot 10:44:43 INFO - Running setup.py install for moztest 10:44:43 INFO - Running setup.py install for mozversion 10:44:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:44:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:44:43 INFO - Cleaning up... 10:44:43 INFO - Return code: 0 10:44:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44: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')]} 10:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44: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')]} 10:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:43 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 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:44:43 INFO - Using env: {'DISPLAY': ':0', 10:44:43 INFO - 'HOME': '/home/cltbld', 10:44:43 INFO - 'LANG': 'en_US.UTF-8', 10:44:43 INFO - 'LANGUAGE': 'en_US:en', 10:44:43 INFO - 'LOGNAME': 'cltbld', 10:44:43 INFO - 'MAIL': '/var/mail/cltbld', 10:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:43 INFO - 'MOZ_NO_REMOTE': '1', 10:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:43 INFO - 'NO_EM_RESTART': '1', 10:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:43 INFO - 'PWD': '/builds/slave/test', 10:44:43 INFO - 'SHELL': '/bin/bash', 10:44:43 INFO - 'SHLVL': '1', 10:44:43 INFO - 'TERM': 'linux', 10:44:43 INFO - 'TMOUT': '86400', 10:44:43 INFO - 'USER': 'cltbld', 10:44:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:43 INFO - '_': '/tools/buildbot/bin/python'} 10:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:43 INFO - Running setup.py (path:/tmp/pip-WsPg1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:43 INFO - Running setup.py (path:/tmp/pip-msHpwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:44:43 INFO - Running setup.py (path:/tmp/pip-EDfTmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:44:44 INFO - Running setup.py (path:/tmp/pip-lRCRKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:44:44 INFO - Running setup.py (path:/tmp/pip-Z5uLbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:44:44 INFO - Running setup.py (path:/tmp/pip-QLZNcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:44:44 INFO - Running setup.py (path:/tmp/pip-gx3rTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:44:44 INFO - Running setup.py (path:/tmp/pip-mWGLAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:44:44 INFO - Running setup.py (path:/tmp/pip-JI1_Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:44:44 INFO - Running setup.py (path:/tmp/pip-fZFOiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:44:44 INFO - Running setup.py (path:/tmp/pip-K5JyxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:44:44 INFO - Running setup.py (path:/tmp/pip-9dsZQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:44:44 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)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:44:44 INFO - Running setup.py (path:/tmp/pip-IPM6x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:44:44 INFO - Running setup.py (path:/tmp/pip-JcmnDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:44:44 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)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:44 INFO - Running setup.py (path:/tmp/pip-lh22Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:44:44 INFO - Running setup.py (path:/tmp/pip-O48G7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:44:45 INFO - Running setup.py (path:/tmp/pip-MAGmkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:44:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:46 INFO - Downloading blessings-1.6.tar.gz 10:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:44:47 INFO - Installing collected packages: blessings 10:44:47 INFO - Running setup.py install for blessings 10:44:47 INFO - Successfully installed blessings 10:44:47 INFO - Cleaning up... 10:44:47 INFO - Return code: 0 10:44:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:44:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:44:47 INFO - Reading from file tmpfile_stdout 10:44:47 INFO - Current package versions: 10:44:47 INFO - argparse == 1.2.1 10:44:47 INFO - blessings == 1.6 10:44:47 INFO - blobuploader == 1.2.4 10:44:47 INFO - docopt == 0.6.1 10:44:47 INFO - functools32 == 3.2.3-2 10:44:47 INFO - jsonschema == 2.5.1 10:44:47 INFO - manifestparser == 1.1 10:44:47 INFO - mozInstall == 1.12 10:44:47 INFO - mozcrash == 0.17 10:44:47 INFO - mozdebug == 0.1 10:44:47 INFO - mozdevice == 0.48 10:44:47 INFO - mozfile == 1.2 10:44:47 INFO - mozhttpd == 0.7 10:44:47 INFO - mozinfo == 0.9 10:44:47 INFO - mozleak == 0.1 10:44:47 INFO - mozlog == 3.2 10:44:47 INFO - moznetwork == 0.27 10:44:47 INFO - mozprocess == 0.23 10:44:47 INFO - mozprofile == 0.28 10:44:47 INFO - mozrunner == 6.12 10:44:47 INFO - mozscreenshot == 0.1 10:44:47 INFO - mozsystemmonitor == 0.3 10:44:47 INFO - moztest == 0.7 10:44:47 INFO - mozversion == 1.4 10:44:47 INFO - psutil == 3.1.1 10:44:47 INFO - requests == 1.2.3 10:44:47 INFO - wsgiref == 0.1.2 10:44:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:47 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 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:44:47 INFO - Using env: {'DISPLAY': ':0', 10:44:47 INFO - 'HOME': '/home/cltbld', 10:44:47 INFO - 'LANG': 'en_US.UTF-8', 10:44:47 INFO - 'LANGUAGE': 'en_US:en', 10:44:47 INFO - 'LOGNAME': 'cltbld', 10:44:47 INFO - 'MAIL': '/var/mail/cltbld', 10:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:47 INFO - 'MOZ_NO_REMOTE': '1', 10:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:47 INFO - 'NO_EM_RESTART': '1', 10:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:47 INFO - 'PWD': '/builds/slave/test', 10:44:47 INFO - 'SHELL': '/bin/bash', 10:44:47 INFO - 'SHLVL': '1', 10:44:47 INFO - 'TERM': 'linux', 10:44:47 INFO - 'TMOUT': '86400', 10:44:47 INFO - 'USER': 'cltbld', 10:44:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:47 INFO - '_': '/tools/buildbot/bin/python'} 10:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:44:47 INFO - Cleaning up... 10:44:47 INFO - Return code: 0 10:44:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:44:47 INFO - Using env: {'DISPLAY': ':0', 10:44:47 INFO - 'HOME': '/home/cltbld', 10:44:47 INFO - 'LANG': 'en_US.UTF-8', 10:44:47 INFO - 'LANGUAGE': 'en_US:en', 10:44:47 INFO - 'LOGNAME': 'cltbld', 10:44:47 INFO - 'MAIL': '/var/mail/cltbld', 10:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:47 INFO - 'MOZ_NO_REMOTE': '1', 10:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:47 INFO - 'NO_EM_RESTART': '1', 10:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:47 INFO - 'PWD': '/builds/slave/test', 10:44:47 INFO - 'SHELL': '/bin/bash', 10:44:47 INFO - 'SHLVL': '1', 10:44:47 INFO - 'TERM': 'linux', 10:44:47 INFO - 'TMOUT': '86400', 10:44:47 INFO - 'USER': 'cltbld', 10:44:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:47 INFO - '_': '/tools/buildbot/bin/python'} 10:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:44:47 INFO - Cleaning up... 10:44:47 INFO - Return code: 0 10:44:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c2974df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, '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': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:44:47 INFO - Using env: {'DISPLAY': ':0', 10:44:47 INFO - 'HOME': '/home/cltbld', 10:44:47 INFO - 'LANG': 'en_US.UTF-8', 10:44:47 INFO - 'LANGUAGE': 'en_US:en', 10:44:47 INFO - 'LOGNAME': 'cltbld', 10:44:47 INFO - 'MAIL': '/var/mail/cltbld', 10:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:47 INFO - 'MOZ_NO_REMOTE': '1', 10:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:47 INFO - 'NO_EM_RESTART': '1', 10:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:47 INFO - 'PWD': '/builds/slave/test', 10:44:47 INFO - 'SHELL': '/bin/bash', 10:44:47 INFO - 'SHLVL': '1', 10:44:47 INFO - 'TERM': 'linux', 10:44:47 INFO - 'TMOUT': '86400', 10:44:47 INFO - 'USER': 'cltbld', 10:44:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:47 INFO - '_': '/tools/buildbot/bin/python'} 10:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:48 INFO - Downloading/unpacking flake8 10:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:44:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:44:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:44:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:44:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:44:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:44:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:44:50 INFO - no previously-included directories found matching 'docs/_build' 10:44:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:44:50 INFO - Running setup.py install for pep8 10:44:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:44:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:44:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:44:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:44:50 INFO - no previously-included directories found matching 'docs/_build' 10:44:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:44:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:44:50 INFO - Cleaning up... 10:44:50 INFO - Return code: 0 10:44:50 INFO - Running post-action listener: _resource_record_post_action 10:44:50 INFO - Running post-action listener: _start_resource_monitoring 10:44:51 INFO - Starting resource monitoring. 10:44:51 INFO - ##### 10:44:51 INFO - ##### Finished create-virtualenv step (success) 10:44:51 INFO - ##### 10:44:51 INFO - ##### 10:44:51 INFO - ##### Running install step. 10:44:51 INFO - ##### 10:44:51 INFO - Running pre-action listener: _resource_record_pre_action 10:44:51 INFO - Running main action method: install 10:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:44:51 INFO - Reading from file tmpfile_stdout 10:44:51 INFO - Detecting whether we're running mozinstall >=1.0... 10:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:44:51 INFO - Reading from file tmpfile_stdout 10:44:51 INFO - Output received: 10:44:51 INFO - Usage: mozinstall [options] installer 10:44:51 INFO - Options: 10:44:51 INFO - -h, --help show this help message and exit 10:44:51 INFO - -d DEST, --destination=DEST 10:44:51 INFO - Directory to install application into. [default: 10:44:51 INFO - "/builds/slave/test"] 10:44:51 INFO - --app=APP Application being installed. [default: firefox] 10:44:51 INFO - mkdir: /builds/slave/test/build/application 10:44:51 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'] 10:44:51 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 10:45:13 INFO - Reading from file tmpfile_stdout 10:45:13 INFO - Output received: 10:45:13 INFO - /builds/slave/test/build/application/firefox/firefox 10:45:13 INFO - Running post-action listener: _resource_record_post_action 10:45:13 INFO - ##### 10:45:13 INFO - ##### Finished install step (success) 10:45:13 INFO - ##### 10:45:13 INFO - ##### 10:45:13 INFO - ##### Running run-tests step. 10:45:13 INFO - ##### 10:45:13 INFO - Running pre-action listener: _resource_record_pre_action 10:45:13 INFO - Running main action method: run_tests 10:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:45:13 INFO - Python 2.7.3 10:45:13 INFO - Return code: 0 10:45:13 INFO - grabbing minidump binary from tooltool 10:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:13 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 0x224e1c0>, '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 0x224f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:45:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:45:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:45:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:45:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:45:13 INFO - Return code: 0 10:45:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:45:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:45:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:45:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:45:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:45:14 INFO - Return code: 0 10:45:14 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:45:14 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:45:14 INFO - Using env: {'DISPLAY': ':0', 10:45:14 INFO - 'HOME': '/home/cltbld', 10:45:14 INFO - 'LANG': 'en_US.UTF-8', 10:45:14 INFO - 'LANGUAGE': 'en_US:en', 10:45:14 INFO - 'LOGNAME': 'cltbld', 10:45:14 INFO - 'MAIL': '/var/mail/cltbld', 10:45:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:45:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:14 INFO - 'MOZ_NO_REMOTE': '1', 10:45:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:14 INFO - 'NO_EM_RESTART': '1', 10:45:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:14 INFO - 'PWD': '/builds/slave/test', 10:45:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:45:14 INFO - 'SHELL': '/bin/bash', 10:45:14 INFO - 'SHLVL': '1', 10:45:14 INFO - 'TERM': 'linux', 10:45:14 INFO - 'TMOUT': '86400', 10:45:14 INFO - 'USER': 'cltbld', 10:45:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000', 10:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:14 INFO - '_': '/tools/buildbot/bin/python'} 10:45:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:45:14 INFO - mozversion application_buildid: 20160728070523 10:45:14 INFO - mozversion application_changeset: db8d264de7e3ed62616a1b36bf7a037273faea58 10:45:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:45:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:45:14 INFO - mozversion application_name: Firefox 10:45:14 INFO - mozversion application_remotingname: firefox-dev 10:45:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:45:14 INFO - mozversion application_vendor: Mozilla 10:45:14 INFO - mozversion application_version: 49.0a2 10:45:14 INFO - mozversion platform_buildid: 20160728070523 10:45:14 INFO - mozversion platform_changeset: db8d264de7e3ed62616a1b36bf7a037273faea58 10:45:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:45:14 INFO - mozversion platform_version: 49.0a2 10:45:14 INFO - using testdate: 1469727914 10:45:14 INFO - actual date: 1469727914 10:45:14 INFO - starting webserver on 'localhost:43638' 10:45:14 INFO - SUITE-START | Running 2 tests 10:45:14 INFO - TEST-START | dromaeo_css 10:45:14 INFO - operating with platform_type : linux_ 10:45:14 INFO - Initialising browser for dromaeo_css test... 10:45:14 INFO - TEST-INFO | started process 12217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqUSkhJ/profile http://localhost:43638/getInfo.html) 10:45:20 INFO - PROCESS | 12217 | __metrics Screen width/height:1600/1200 10:45:20 INFO - PROCESS | 12217 | colorDepth:24 10:45:20 INFO - PROCESS | 12217 | Browser inner width/height: 1024/697 10:45:20 INFO - PROCESS | 12217 | __metrics 10:45:21 ERROR - PROCESS | 12217 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 10:45:22 INFO - TEST-INFO | 12217: exit 0 10:45:22 INFO - Browser initialized. 10:45:22 INFO - Running cycle 1/1 for dromaeo_css test... 10:45:22 INFO - TEST-INFO | started process 12347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqUSkhJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:34 INFO - PROCESS | 12347 | RSS: Main: 155955200 10:45:34 INFO - PROCESS | 12347 | 10:46:23 INFO - PROCESS | 12347 | 1469727983729 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:48:31 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:43638/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43638/tests/dromaeo/cssquery-ext.html) 10:48:32 INFO - PROCESS | 12347 | RSS: Main: 160296960 10:48:32 INFO - PROCESS | 12347 | 10:51:34 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:43638/tests/dromaeo/cssquery-ext.html (next: http://localhost:43638/tests/dromaeo/cssquery-jquery.html) 10:51:35 INFO - PROCESS | 12347 | RSS: Main: 157503488 10:51:35 INFO - PROCESS | 12347 | 10:54:36 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:43638/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43638/tests/dromaeo/cssquery-mootools.html) 10:54:37 INFO - PROCESS | 12347 | RSS: Main: 157364224 10:54:37 INFO - PROCESS | 12347 | 10:57:39 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:43638/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43638/tests/dromaeo/cssquery-prototype.html) 10:57:39 INFO - PROCESS | 12347 | RSS: Main: 156823552 10:57:39 INFO - PROCESS | 12347 | 11:00:42 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:43638/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43638/tests/dromaeo/cssquery-yui.html) 11:00:42 INFO - PROCESS | 12347 | RSS: Main: 158691328 11:00:42 INFO - PROCESS | 12347 | 11:03:45 INFO - PROCESS | 12347 | Cycle 1(1): loaded http://localhost:43638/tests/dromaeo/cssquery-yui.html (next: http://localhost:43638/tests/dromaeo/cssquery-dojo.html) 11:03:45 INFO - PROCESS | 12347 | RSS: Main: 159350784 11:03:45 INFO - PROCESS | 12347 | 11:03:45 INFO - PROCESS | 12347 | __start_tp_report 11:03:45 INFO - PROCESS | 12347 | _x_x_mozilla_page_load 11:03:45 INFO - PROCESS | 12347 | _x_x_mozilla_page_load_details 11:03:45 INFO - PROCESS | 12347 | |i|pagename|runs| 11:03:45 INFO - PROCESS | 12347 | |0;dojo.html;3372.291818718069;3375.7130643895252;3386;3405.233822389962;3411.3177364527087;5478.698671573062;5496;5562.860928476795;5566.443355664442;5574.442555744424;5729.713514324288;5772.480476757091;5795.681237531945;5822.446867547576;5841.415858414167;5215.035218484583;5244.895102097956;5271.2356708277275;5285.418603953562;5309.309789727349;5136.845894623168;5150.639455238135;5184.196449550326;5292.497212764782;5349.010433069894;5134.25553294772;5144.8971020579565;5186.7147306898105;5254.4220135785035;5286.524212820846;5145.022445735298;5157.174852023677;5175.611829112794;5187.325647665779;5212.139996900507;4962.255661650745;5038.143515602356;5113.411957624847;5121.487851214886;5167.6641018333685;5475.835724928259;5510.311211098613;5543.334799824047;5553.8333849984565;5591.10542313232;6041.758329666808;6082.635041897501;6085.847853803691;6096.359882212349;6106.755729770804;6053.061775424816;6131.315499379007;6134.263888333428;6147.293061297919;6151.323354431009;5800.303963524404;5801.158831969383;5801.564882633777;5822.97088514559;5857.355690874043;6364.649944253018;6370.872582548323;6370.968145159337;6380.968095159495;6386.425221730066;5866.266716660418;5997.340292567814;6008.279006519246;6029.035354343284;6110.572259941761;6137.769204764619;6161.476274516626;6167.259928808482;6167.383261673886;6168.167297414791;6057.97014507526;6096.237970253718;6109.327973922865;6119.296280927751;6180.072989051679;5945.970270148621;6087.360827113178;6110.419510146529;6133.202683651186;6154.753809847556;4700.647451441156;4701.106789709944;4705.95294047062;4719.59883409914;4767.261074533453;4151.564085771011;4198.916021679549;4206.0326124991425;4210.347396153601;4235.661147108224;5755.050416681284;5773.451522105393;5808.82573522795;5843.970780146157;5875.970620146872;6132.69706892425;6133.4264757247465;6232.25212974446;6246.469050130699;6258.843528911813;5746.770129194869;5964.522838172936;5978.282606087298;5979.133025711248;6009.338972712998;5203.063448579216;5214.400343960418;5230.529252367305;5250.868728281824;5276.208568714646;6443.838904027343;6452.677366131675;6456.741730330828;6458.257300410419;6460.806175814733;5955.464008239279;6117.724702388492;6204.5967012144065;6205.28639206488;6216.813495595139;6313.3686631336495;6435.935640643534;6438.549301548846;6458.192725909262;6468.967655161694;6043.848903777441;6068.848278793065;6073.210482637229;6092.329843717099;6116.66358350295;5976.462118409364;6134.6625935573975;6139.001538246313;6198.504119670325;6214.316425193135;5914.2311499504785;6007.189029481139;6009.128676341993;6011.248593925759;6033.668148251712;5985.162077309267;6003.429674180946;6003.609765365237;6010.789622363196;6016.308124565731;5810.302763668386;5881.529477641864;5907.793227237026;5919.792807251725;5948.613340132878;6114.296855861633;6118.877622447437;6120.204373431426;6129.84675383119;6182.227221597301;5982.162497250301;5985.461308482258;5989.610675306091;6001.789937352171;6002.219711437485 11:03:45 INFO - PROCESS | 12347 | |1;ext.html;603.5835273661173;659.7427003468647;660.3858411677141;682.072381561077;688.2738710660251;41897.371539426895;46165;46331.305030424526;46412.303815442756;46443.76778116105;48108;48779.26831097536;48813.267800982925;48825.51174488254;48848.75575622126;8946.955265223665;9027.187553120219;9122.22461090808;9125.087491250855;9143.817123657524;8873.467591944504;8885.777855553599;8888.06675299094;8949.284057275436;8975.416597921114;8883.422577532472;8960.775980600472;8983.550822458883;8990.100989901022;8999.910000899972;8934.463932164059;8963.148500892405;8973.057828927935;8980.28157747382;8981;8936;8950.955245223797;9006;9027.187553120251;9054.320925930582;44202.778986105186;44246.77876610628;44449.77775111104;44542.777286113684;44745.77627111876;3776.169242766587;3895.357266051098;3937.232239713257;3967.107400834818;4073.2260870434525;35332.64667353345;35523.64476355229;35587.28825423503;35681.46477802835;35682.64317356845;4593.471750748673;4725.960288736507;4741.95258047422;4778.2115950868065;4791.305260737208;371720;371941;372258;372276;373460.1326993375;68070.65964670145;68968;69098.65450672715;69108.30891691119;69188;39994;40757.18485630271;40890.1821963565;42558.148837023706;42699.57300427018;19280.4215873524;19460.4161875144;19472;19536;19620.117094730773;14623.04950178235;14643.56069317922;14763.926180369244;14784;14806.333714982851;21275.680864787042;21548.35354939354;21604.675929861063;21676.45808854791;21824.563508729738;7562.395008399315;7568.772936811904;7669.923300767033;7916.683332666744;7946.715434236284;1036.212478516333;1096.4736926275273;1114.899659030691;1123.719070232442;1184.1710802438329;31938.840305798323;32394.028179154662;32400.837995810343;32562.674373255963;32575.02274931756;1199.6880810989205;1200.5017917564112;1251.217988757027;1266.0567876931561;1290.470906928155;17197.484075477754;17281.222344994505;17304.480865574053;17336.30654773795;17470.47588572345;468459;586840;603774;605326;917425;64336.678316608115;64718;65205.34794651993;65300.34699652943;65539.67230163819;1502.068717395222;1507.0656193160312;1519.3390874969646;1528.335174199227;1529.4111766969797;33650;34130.65869341275;34673.65326346805;34751.304973900886;34977.475337869444;57651;58076;58147;58303.708481457325;58370.4162958365;515348;522058;525759;526071;527550;27905.302367440978;28125.015624453863;28138.43723125567;28374.290642734097;28377.71622283751;51780;52485.21272180844;52722.47277527176;52815;53811;43821;44800.77599611981;45277.54722452865;45623;45751;43964;44243;44465.33302000408;44859;44906.77546612377;42721;43401.56598433975;43775.56224437842;44247.33628995632;44410.11179776322;37363.813180933925;37754.8112259437;38987.41518877162;39203.2159356817;39291.80354098211;29204.7079529202;29703.55444668375;29749.70250297556;29866.253343665714;29991.700082999763 11:03:45 INFO - PROCESS | 12347 | |2;jquery.html;400.867713654494;405.55996743533285;424.2999051564918;424.84705506017826;429.2745260509738;18415.63168736626;19066.809331906676;19673.21307147716;19789.140276000147;19937.3021944232;18391.356302529413;19093.23627054916;19118.52203694905;19196.136173872175;19717;5070.467600901899;5216.634835561512;5256.3955145158225;5297.602679799012;5298.973505132488;5119.1809310510325;5249.973750131263;5343.251944727741;5347.759350829222;5350.866228344284;5326.041312563756;5327.387350454708;5328.120860058105;5335.759890804923;5351.705656188928;5116.2069879168785;5278.551323137538;5304.681719096828;5304.946950530484;5315.229291752694;5140.640155189139;5145.125328694131;5179.430262671103;5188.740562971874;5205.973970130125;13210.33948302581;13479;13506.86493135066;13584.32078396086;13641.795373069412;2381.8809059547125;2407.0973384980634;2413.20364279789;2460.458699086198;2584.470183612355;9917.157041651468;10086.041826026516;10095.646652367132;10131;10330.793384132276;1842.8894266344062;1915.6743353629915;2011.416689160142;2023.7773844877051;2032.7763945965933;51893.74053129748;52590.737046314905;75442.62278688626;79829;79920.60039699764;9465.574049167804;10144.188464922789;10278.948605256926;10343.793124137475;10350.223733220038;12712;13669.179849209078;13823.447062117604;13867.098638588459;13871.653208669662;7657.310842024244;8124;8152.2662960333855;8410.074891761902;8455;8399.37004724648;8511.808346831449;8542.701005464904;8571.914280857112;8575.056743758181;4339.956600434019;4351.564843515686;4361.716488428242;4377.8248870044845;4478.328250762412;2067.79322067792;2111.5776844631137;2125.5111324395475;2132.914683412646;2152.6878602602533;1019.8419245017034;1065.3927261461047;1069.1874175626424;1142.0349804415255;1146.5643055638805;16692;19571.11929963155;19580.60838783245;19619.705704414446;19641.803581964283;1035.9119474844572;1049.5801679328176;1089.3681664634494;1102.4928532874808;1122.5902545570807;10338.689839304832;10950.835737463944;10970.286931349438;10996.725081872857;11015.83476247857;364115;365300;369225;508387;510804;95328.52335738277;102860.48569757253;102893;103516.48241758742;103745.48127259467;1080.9621663241749;1099.2854644480992;1122.5509796081633;1131.4286285425808;1140.321508702321;16326.102064386572;17586;17899.015554144647;18124.909375453037;18129.909350453163;42130.789346053076;43050;43177;44084.33873491836;44684.32973505335;56495.71752141213;56980.715096424254;57625.71187144038;57943;58006.41993580179;8505.36209784281;8672.869906951275;8801.251893589117;8812.07473215303;8876.11238876133;12566.371681416076;13495.325233738471;13683;13684.86315136836;13802.447902083804;10207.234457415576;11679.474423651127;11938.462769175234;12149.574764883188;12269.141160118706;11705.063594912557;11919.463624137108;11981.520739170335;12028.75942481163;12355.320457374572;12042.578509752117;12198.75602487963;12310.322932238812;12498.625041248777;12505.062120341192;8437;8502.659893604186;8618.138186181583;8660.004099528634;8683;11343.376114313793;11383.601573944872;11387.715307117389;11572.884271157518;11755.47100380502 11:03:45 INFO - PROCESS | 12347 | |3;mootools.html;1616.7898173237481;1622.945085694299;1847.8706490545667;1897.5635603811115;1928.3250862198224;9442.386244894076;9783.168430683383;9939.055789699985;10081.042300981404;10093.69718908433;10167.745806354846;10208.64269750559;10277.229207809425;10328.535215915283;10348.586056557748;2316.953660926785;2341.2156927429332;2346.730126035502;2351.247600767755;2355.1756885090167;2274.2608652188023;2290.5533420982915;2294.529621427603;2302.9193978210765;2317.536492701458;2276.3398614401804;2287.0965968442456;2287.233776684804;2300.64340027296;2309.4457330240707;2251.0658076898067;2268.0247493577754;2268.3308424014954;2268.5689718953345;2277.954440911181;2206.558688262338;2238.0264584905617;2246.056656204398;2248.9437764055865;2256.8871556422114;10053.145482633985;10076.647317343932;10090.243231757648;10146.23903207255;10149.949250253776;5739.339975902742;5909.497692696126;5911.379305172938;5915.319738230116;5919.5560332974765;3455.585329760445;3505.8247087645514;3612.1330880588735;3623.3296840084668;3632.128289210597;1188.5899364719157;1190.65471013406;1243.2167734327406;1258.7860063789178;1284.7687416265069;13834.93082534591;13913.23477208743;13920.582382528439;14009.439622415091;14041.859581404158;4800.903981920342;4843.660943733976;4933.309336692866;4967;4971.055499455164;10867.45662716861;10886.455677216265;10902.781944361068;10909.563617455371;10934.125269978382;5729.169270455761;5739.971300143473;5744.626599271034;5749.712514374264;5772.855678608068;4533.77331133442;5117;5199.870003249949;5211.2443695663915;5238.266642670029;4097.303458412077;4102.3909091812275;4191.826288639186;4202.285611446;4207.486748564921;1218.2994778002683;1242.67069226655;1255.4350542256022;1268.0996492490435;1270.898328133747;1020.5458570936011;1030.4641586375192;1042.8435734639713;1049.6168898352046;1051.5268129341828;6215.160953271341;6383.9361606383345;6428.8071357859335;6575.539712220194;6578.144841170713;1056.630179437191;1072.683558350273;1095.457748414524;1095.9890401096047;1102.2284400919389;4029.194161167778;4126.896827579335;4152.979235103866;4154.065335299594;4155.522114956819;12598.181118227287;12636.684082898;12917.806232906514;12988.935055324662;13051.673708157372;12771.936140319425;12855.485780568859;12863.48546058166;12866.035047371484;12896.548620798414;9047.954760226157;9256.166944974984;9364.063593640582;9443.622255109856;9512.619495220251;6238.500919926486;6247.875042499216;6329.968350158219;6344.429001389897;6379.96810015947;10925.453727313761;11397;11521.078313734713;11590.13074019435;11614.477348519506;11589.7102572433;11663.24188927717;11752.294862308288;11789.99785018283;11867.050635949276;8149.959250203711;8326.791830204293;8490.44812087237;8905.643774248958;9100.22648074921;9756.219502439646;9784.266180036384;9826.263030272616;9848.162906153057;9885.50572471388;8626.741197764077;8793.384463087523;8904.376693631384;8972.910270897208;9017.368784185044;8570.657173712982;8602;8653.69712060075;8725.083866194213;8825.470471771714;7467.850642987001;7522.247775222434;7538.057742782153;7584.203658615987;7631.1605723371495;5325.547328477122;5332.280142180911;5405.081136206775;5412;5454.836354909359;5329.307190065267;5426.240326354393;5441.911617676401;5570.637908535932;5591.329040515164 11:03:45 INFO - PROCESS | 12347 | |4;prototype.html;319.71864759012067;322.9580154579904;324.5634621434171;329.74939046324783;330.6396028329122;5674.60277780555;5749.367569567349;5785.652860828348;5802.738876750545;5806.854828629286;5635.520980716644;5666.150077488379;5688.179782469611;5700.714964251792;5724.7137643117885;4172.833086676537;4187.853425130121;4364.912701745963;4366.847160349388;4384.583464570861;4343.978280108611;4372.956270437303;4373.409589705397;4377.1683380157665;4380.605745482906;4312.202242585132;4335.848245311415;4339.132173565284;4342.131573685259;4344.544577566519;4190;4245.426867372896;4249.68127390447;4271.359296105578;4273.1240095780295;3707.7589956652732;3719.1817800083936;3728.2170744143764;3735.2716220337047;3758.3986562149926;5418.783248670088;5419.485148910847;5440.836774896759;5461.2354270402175;5520.199571062214;4849.884526558876;4943.456219815817;4972.950270497285;4974.676646017997;4992.976439829826;5830.4169583041785;5870.6477611343025;5922.548975500987;5936.1392598073035;5949.8215053548465;4115.176964607061;4163.125743593849;4171.457710497646;4187.979060104711;4199.076203235314;5942.286925568917;6050.21347224858;6099.176611157525;6146.78486252979;6226.87546249077;4223.260929337353;4263.59495847894;4264.232438161099;4273.807678654468;4286.849960251377;4288.185244803477;4293.8711838644895;4306.0957198987935;4309.655227581786;4315.978420107879;4798.869449254559;4920.261960705851;4941.72820494869;4955.752212389366;4979.128652485801;5867.6772777497645;5928.288605367384;5951.345352011275;5956.255468066492;5970.671613061323;1474.6903150338549;1490.8509149085005;1495.3046833222604;1497.4833682379563;1502.0011692224548;916.5829547555979;946.6828612414918;969.1181025266973;969.5879251318162;971.2812518736084;5760.74076666551;5764.308283005982;5785.623934444247;5791.362950075489;5826.504747096545;6086.391360863879;6088.360722124202;6096.542759293071;6099.597092668622;6163.044728067157;5483.862903427446;5724.513416359573;5783.248177736868;5783.8554036149435;5793.362730099686;3170.95358531684;3221.7744757867194;3251;3252.5121231815415;3253.6258330291844;6048.848778780566;6287.1198032275515;6295.496360291166;6297.464715499143;6323.272823625342;6193.380661933861;6209.285932117864;6214.844628884314;6220.34686357935;6263.404976527223;6032.54755893301;6274.215723034621;6280.775248826526;6315.5894866833505;6377.17096777416;6120.418560236771;6124.356942520971;6147.293061298008;6153.446189842935;6168.255126468678;6149.631022138686;6158.214117905757;6159.260888693386;6184.226971628546;6184.257889053342;6152.969235153795;6273.247210334606;6319.747210111728;6321.64084721787;6406.1031455597185;4210.431591735077;4227.091175397304;4242.618164365099;4243.554426785143;4250.447441832542;5774;5895.587308888336;6137.324894261538;6186.113235463047;6190.473809726223;5870.589058766016;5921.424180481505;5933.131063714916;5958.5828991971875;5995.86078645056;5715.885682286248;5853.443922827495;5949.553783466344;5959.970200148971;5977.432143946318;5785.392533783892;5808.593398462067;5848.4151584841175;5868.383819699041;5877.706114694333;5948.910766338595;5992.490638295793;6003.5797494174985;6035;6038.607490513103;5652.530342110998;5831.650100993954;5849.590528663123;5855.7364918579615;5880.470757631833 11:03:45 INFO - PROCESS | 12347 | |5;yui.html;705.5660768627296;727.2255048373485;773.1804287455298;782.5343920367382;909.6725178935584;16292.918535407322;17041.403550875722;17318.220680069397;17410;17419.041952692598;15984;16153.757693634576;16160.191990400463;16166.353345866151;16176.75734863978;720.7369310201778;857.2327766648846;882.898466676334;886.2466903132319;886.2732559301376;860.6213266162869;871.5772850167664;874.8862647855801;875.5140896802272;875.9605817738217;916.2990312411011;923.4505469245788;925.7824411263348;926.1340646495514;928.9907100928972;926.3654396738223;927.8144371125734;927.8515437529996;928.614624930653;928.6888892221114;676.8713944350558;679.5548915460381;680.1566058087985;683.6855046678534;686.5262968551733;15805.209739513093;15831.445899393466;15912;15921.840781592151;15971.201439927958;14332.928335358361;14821.036632618952;15277.541673749805;15344.693106137815;15439.536813895602;12479.251244925334;12809.807852882213;13147.671308217276;13386.062975591713;13685.384157712828;4031.697622678311;4078.3474644057105;4099.754014759094;4118.5057793065025;4154.875353739392;77509;78830;79565.60217198935;80380.19619803844;80653.19346806516;11937.88062119385;12093.818592721116;12257.387130643432;12329.938350308192;12603.810942835864;22480.775192248195;22587.887060564593;22645.320640380814;22659.773402265768;22664.320070397913;8637.103315799683;8715.215630593277;8825.20573148407;8971.461712297283;8979.955100224588;5096.464871188546;5185.637005409585;5193.662411943287;5214.165733482625;5219.686818790885;3838.5201849768778;3947.4670919426085;3956.9208615827524;3965.623265789803;3979.7015223858325;617.6294223465884;681.0669382945397;681.6251061916025;682.4574463301688;686.0943554508002;801.8235988082613;819.5451524403894;836.4019725896013;850.5747126436781;855.6534603485599;10214.438205898598;10427.374357538572;10435.37387756737;10451.111655509214;10473;795.5827346672195;817.5991685432114;827.4538804389194;838.7567605394489;848.4400295804862;4892.8532144035735;4924.926126108111;4987.152184128707;4991.50084991498;5023.949760502348;96634;111120.44439777911;121743;122347;124077;99082.50458747805;100710;104171.47914260531;105250;105362.99999999847;88848.5557572208;91552;91982;92170.53914730383;93137.53431232936;9049.457032578066;9145.817083658423;9315.39449935752;9352.906470935204;9490.00354962719;53632;53779;54303.45696542984;55219.72390138024;56302.718486407306;72226.63886680533;77550;78376;82480.58759706403;84104;12316.076294278144;12561.497540098659;12905.548305809252;13185.670358241121;13370.264635445144;13795.517156899461;14020.929895350459;14035.087719298213;14084.084534505224;14449.49426770058;13018.609441716764;13350.532731354357;13728.725425491633;13779.311034448037;13993.370298336802;13166.539171128965;13550.79673804874;13581.728365432833;13787.379567919668;13908.304584770518;12829.9094576962;12920.612381628565;12998.870011299767;13032.54386096482;13252.86747132555;10172.237082219011;10421.478926053818;11314.60398886035;11316.194243023498;11373.54505819758;11453.255538389978;11758.90410958904;11856;12194.756104877675;12433.254004759743 11:03:45 INFO - PROCESS | 12347 | __end_tp_report 11:03:45 INFO - PROCESS | 12347 | __start_cc_report 11:03:45 INFO - PROCESS | 12347 | _x_x_mozilla_cycle_collect,337 11:03:45 INFO - PROCESS | 12347 | __end_cc_report 11:03:45 INFO - PROCESS | 12347 | __startTimestamp1469729025376__endTimestamp 11:03:45 INFO - PROCESS | 12347 | 11:03:45 INFO - PROCESS | 12347 | ------- Summary: start ------- 11:03:45 INFO - PROCESS | 12347 | Number of tests: 6 11:03:45 INFO - PROCESS | 12347 | 11:03:45 INFO - PROCESS | 12347 | [#0] dojo.html Cycles:165 Average:5706.26 Median:5978.28 stddev:654.97 (11.0%) stddev-sans-first:630.87 11:03:45 INFO - PROCESS | 12347 | Values: 3372.3 3375.7 3386.0 3405.2 3411.3 5478.7 5496.0 5562.9 5566.4 5574.4 5729.7 5772.5 5795.7 5822.4 5841.4 5215.0 5244.9 5271.2 5285.4 5309.3 5136.8 5150.6 5184.2 5292.5 5349.0 5134.3 5144.9 5186.7 5254.4 5286.5 5145.0 5157.2 5175.6 5187.3 5212.1 4962.3 5038.1 5113.4 5121.5 5167.7 5475.8 5510.3 5543.3 5553.8 5591.1 6041.8 6082.6 6085.8 6096.4 6106.8 6053.1 6131.3 6134.3 6147.3 6151.3 5800.3 5801.2 5801.6 5823.0 5857.4 6364.6 6370.9 6371.0 6381.0 6386.4 5866.3 5997.3 6008.3 6029.0 6110.6 6137.8 6161.5 6167.3 6167.4 6168.2 6058.0 6096.2 6109.3 6119.3 6180.1 5946.0 6087.4 6110.4 6133.2 6154.8 4700.6 4701.1 4706.0 4719.6 4767.3 4151.6 4198.9 4206.0 4210.3 4235.7 5755.1 5773.5 5808.8 5844.0 5876.0 6132.7 6133.4 6232.3 6246.5 6258.8 5746.8 5964.5 5978.3 5979.1 6009.3 5203.1 5214.4 5230.5 5250.9 5276.2 6443.8 6452.7 6456.7 6458.3 6460.8 5955.5 6117.7 6204.6 6205.3 6216.8 6313.4 6435.9 6438.5 6458.2 6469.0 6043.8 6068.8 6073.2 6092.3 6116.7 5976.5 6134.7 6139.0 6198.5 6214.3 5914.2 6007.2 6009.1 6011.2 6033.7 5985.2 6003.4 6003.6 6010.8 6016.3 5810.3 5881.5 5907.8 5919.8 5948.6 6114.3 6118.9 6120.2 6129.8 6182.2 5982.2 5985.5 5989.6 6001.8 6002.2 11:03:45 INFO - PROCESS | 12347 | 11:03:45 INFO - PROCESS | 12347 | [#1] ext.html Cycles:180 Average:67436.10 Median:44429.94 stddev:141207.62 (317.8%) stddev-sans-first:141514.59 11:03:45 INFO - PROCESS | 12347 | Values: 603.6 659.7 660.4 682.1 688.3 41897.4 46165.0 46331.3 46412.3 46443.8 48108.0 48779.3 48813.3 48825.5 48848.8 8947.0 9027.2 9122.2 9125.1 9143.8 8873.5 8885.8 8888.1 8949.3 8975.4 8883.4 8960.8 8983.6 8990.1 8999.9 8934.5 8963.1 8973.1 8980.3 8981.0 8936.0 8951.0 9006.0 9027.2 9054.3 44202.8 44246.8 44449.8 44542.8 44745.8 3776.2 3895.4 3937.2 3967.1 4073.2 35332.6 35523.6 35587.3 35681.5 35682.6 4593.5 4726.0 4742.0 4778.2 4791.3 371720.0 371941.0 372258.0 372276.0 373460.1 68070.7 68968.0 69098.7 69108.3 69188.0 39994.0 40757.2 40890.2 42558.1 42699.6 19280.4 19460.4 19472.0 19536.0 19620.1 14623.0 14643.6 14763.9 14784.0 14806.3 21275.7 21548.4 21604.7 21676.5 21824.6 7562.4 7568.8 7669.9 7916.7 7946.7 1036.2 1096.5 1114.9 1123.7 1184.2 31938.8 32394.0 32400.8 32562.7 32575.0 1199.7 1200.5 1251.2 1266.1 1290.5 17197.5 17281.2 17304.5 17336.3 17470.5 468459.0 586840.0 603774.0 605326.0 917425.0 64336.7 64718.0 65205.3 65300.3 65539.7 1502.1 1507.1 1519.3 1528.3 1529.4 33650.0 34130.7 34673.7 34751.3 34977.5 57651.0 58076.0 58147.0 58303.7 58370.4 515348.0 522058.0 525759.0 526071.0 527550.0 27905.3 28125.0 28138.4 28374.3 28377.7 51780.0 52485.2 52722.5 52815.0 53811.0 43821.0 44800.8 45277.5 45623.0 45751.0 43964.0 44243.0 44465.3 44859.0 44906.8 42721.0 43401.6 43775.6 44247.3 44410.1 37363.8 37754.8 38987.4 39203.2 39291.8 29204.7 29703.6 29749.7 29866.3 29991.7 11:03:45 INFO - PROCESS | 12347 | 11:03:45 INFO - PROCESS | 12347 | [#2] jquery.html Cycles:180 Average:26751.60 Median:2028.28 stddev:71341.42 (3517.3%) stddev-sans-first:71514.12 11:03:45 INFO - PROCESS | 12347 | Values: 400.9 405.6 424.3 424.8 429.3 18415.6 19066.8 19673.2 19789.1 19937.3 18391.4 19093.2 19118.5 19196.1 19717.0 5070.5 5216.6 5256.4 5297.6 5299.0 5119.2 5250.0 5343.3 5347.8 5350.9 5326.0 5327.4 5328.1 5335.8 5351.7 5116.2 5278.6 5304.7 5304.9 5315.2 5140.6 5145.1 5179.4 5188.7 5206.0 13210.3 13479.0 13506.9 13584.3 13641.8 2381.9 2407.1 2413.2 2460.5 2584.5 9917.2 10086.0 10095.6 10131.0 10330.8 1842.9 1915.7 2011.4 2023.8 2032.8 51893.7 52590.7 75442.6 79829.0 79920.6 9465.6 10144.2 10278.9 10343.8 10350.2 12712.0 13669.2 13823.4 13867.1 13871.7 7657.3 8124.0 8152.3 8410.1 8455.0 8399.4 8511.8 8542.7 8571.9 8575.1 4340.0 4351.6 4361.7 4377.8 4478.3 2067.8 2111.6 2125.5 2132.9 2152.7 1019.8 1065.4 1069.2 1142.0 1146.6 16692.0 19571.1 19580.6 19619.7 19641.8 1035.9 1049.6 1089.4 1102.5 1122.6 10338.7 10950.8 10970.3 10996.7 11015.8 364115.0 365300.0 369225.0 508387.0 510804.0 95328.5 102860.5 102893.0 103516.5 103745.5 1081.0 1099.3 1122.6 1131.4 1140.3 16326.1 17586.0 17899.0 18124.9 18129.9 42130.8 43050.0 43177.0 44084.3 44684.3 56495.7 56980.7 57625.7 57943.0 58006.4 8505.4 8672.9 8801.3 8812.1 8876.1 12566.4 13495.3 13683.0 13684.9 13802.4 10207.2 11679.5 11938.5 12149.6 12269.1 11705.1 11919.5 11981.5 12028.8 12355.3 12042.6 12198.8 12310.3 12498.6 12505.1 8437.0 8502.7 8618.1 8660.0 8683.0 11343.4 11383.6 11387.7 11572.9 11755.5 11:03:45 INFO - PROCESS | 12347 | 11:03:45 INFO - PROCESS | 12347 | [#3] mootools.html Cycles:180 Average:6433.56 Median:2353.21 stddev:3860.39 (164.0%) stddev-sans-first:3854.25 11:03:45 INFO - PROCESS | 12347 | Values: 1616.8 1622.9 1847.9 1897.6 1928.3 9442.4 9783.2 9939.1 10081.0 10093.7 10167.7 10208.6 10277.2 10328.5 10348.6 2317.0 2341.2 2346.7 2351.2 2355.2 2274.3 2290.6 2294.5 2302.9 2317.5 2276.3 2287.1 2287.2 2300.6 2309.4 2251.1 2268.0 2268.3 2268.6 2278.0 2206.6 2238.0 2246.1 2248.9 2256.9 10053.1 10076.6 10090.2 10146.2 10149.9 5739.3 5909.5 5911.4 5915.3 5919.6 3455.6 3505.8 3612.1 3623.3 3632.1 1188.6 1190.7 1243.2 1258.8 1284.8 13834.9 13913.2 13920.6 14009.4 14041.9 4800.9 4843.7 4933.3 4967.0 4971.1 10867.5 10886.5 10902.8 10909.6 10934.1 5729.2 5740.0 5744.6 5749.7 5772.9 4533.8 5117.0 5199.9 5211.2 5238.3 4097.3 4102.4 4191.8 4202.3 4207.5 1218.3 1242.7 1255.4 1268.1 1270.9 1020.5 1030.5 1042.8 1049.6 1051.5 6215.2 6383.9 6428.8 6575.5 6578.1 1056.6 1072.7 1095.5 1096.0 1102.2 4029.2 4126.9 4153.0 4154.1 4155.5 12598.2 12636.7 12917.8 12988.9 13051.7 12771.9 12855.5 12863.5 12866.0 12896.5 9048.0 9256.2 9364.1 9443.6 9512.6 6238.5 6247.9 6330.0 6344.4 6380.0 10925.5 11397.0 11521.1 11590.1 11614.5 11589.7 11663.2 11752.3 11790.0 11867.1 8150.0 8326.8 8490.4 8905.6 9100.2 9756.2 9784.3 9826.3 9848.2 9885.5 8626.7 8793.4 8904.4 8972.9 9017.4 8570.7 8602.0 8653.7 8725.1 8825.5 7467.9 7522.2 7538.1 7584.2 7631.2 5325.5 5332.3 5405.1 5412.0 5454.8 5329.3 5426.2 5441.9 5570.6 5591.3 11:03:45 INFO - PROCESS | 12347 | 11:03:45 INFO - PROCESS | 12347 | [#4] prototype.html Cycles:180 Average:4974.91 Median:5784.62 stddev:1496.57 (25.9%) stddev-sans-first:1459.41 11:03:45 INFO - PROCESS | 12347 | Values: 319.7 323.0 324.6 329.7 330.6 5674.6 5749.4 5785.7 5802.7 5806.9 5635.5 5666.2 5688.2 5700.7 5724.7 4172.8 4187.9 4364.9 4366.8 4384.6 4344.0 4373.0 4373.4 4377.2 4380.6 4312.2 4335.8 4339.1 4342.1 4344.5 4190.0 4245.4 4249.7 4271.4 4273.1 3707.8 3719.2 3728.2 3735.3 3758.4 5418.8 5419.5 5440.8 5461.2 5520.2 4849.9 4943.5 4973.0 4974.7 4993.0 5830.4 5870.6 5922.5 5936.1 5949.8 4115.2 4163.1 4171.5 4188.0 4199.1 5942.3 6050.2 6099.2 6146.8 6226.9 4223.3 4263.6 4264.2 4273.8 4286.8 4288.2 4293.9 4306.1 4309.7 4316.0 4798.9 4920.3 4941.7 4955.8 4979.1 5867.7 5928.3 5951.3 5956.3 5970.7 1474.7 1490.9 1495.3 1497.5 1502.0 916.6 946.7 969.1 969.6 971.3 5760.7 5764.3 5785.6 5791.4 5826.5 6086.4 6088.4 6096.5 6099.6 6163.0 5483.9 5724.5 5783.2 5783.9 5793.4 3171.0 3221.8 3251.0 3252.5 3253.6 6048.8 6287.1 6295.5 6297.5 6323.3 6193.4 6209.3 6214.8 6220.3 6263.4 6032.5 6274.2 6280.8 6315.6 6377.2 6120.4 6124.4 6147.3 6153.4 6168.3 6149.6 6158.2 6159.3 6184.2 6184.3 6153.0 6273.2 6319.7 6321.6 6406.1 4210.4 4227.1 4242.6 4243.6 4250.4 5774.0 5895.6 6137.3 6186.1 6190.5 5870.6 5921.4 5933.1 5958.6 5995.9 5715.9 5853.4 5949.6 5960.0 5977.4 5785.4 5808.6 5848.4 5868.4 5877.7 5948.9 5992.5 6003.6 6035.0 6038.6 5652.5 5831.7 5849.6 5855.7 5880.5 11:03:45 INFO - PROCESS | 12347 | 11:03:45 INFO - PROCESS | 12347 | [#5] yui.html Cycles:180 Average:21631.95 Median:4109.13 stddev:31016.21 (754.8%) stddev-sans-first:31063.42 11:03:45 INFO - PROCESS | 12347 | Values: 705.6 727.2 773.2 782.5 909.7 16292.9 17041.4 17318.2 17410.0 17419.0 15984.0 16153.8 16160.2 16166.4 16176.8 720.7 857.2 882.9 886.2 886.3 860.6 871.6 874.9 875.5 876.0 916.3 923.5 925.8 926.1 929.0 926.4 927.8 927.9 928.6 928.7 676.9 679.6 680.2 683.7 686.5 15805.2 15831.4 15912.0 15921.8 15971.2 14332.9 14821.0 15277.5 15344.7 15439.5 12479.3 12809.8 13147.7 13386.1 13685.4 4031.7 4078.3 4099.8 4118.5 4154.9 77509.0 78830.0 79565.6 80380.2 80653.2 11937.9 12093.8 12257.4 12329.9 12603.8 22480.8 22587.9 22645.3 22659.8 22664.3 8637.1 8715.2 8825.2 8971.5 8980.0 5096.5 5185.6 5193.7 5214.2 5219.7 3838.5 3947.5 3956.9 3965.6 3979.7 617.6 681.1 681.6 682.5 686.1 801.8 819.5 836.4 850.6 855.7 10214.4 10427.4 10435.4 10451.1 10473.0 795.6 817.6 827.5 838.8 848.4 4892.9 4924.9 4987.2 4991.5 5023.9 96634.0 111120.4 121743.0 122347.0 124077.0 99082.5 100710.0 104171.5 105250.0 105363.0 88848.6 91552.0 91982.0 92170.5 93137.5 9049.5 9145.8 9315.4 9352.9 9490.0 53632.0 53779.0 54303.5 55219.7 56302.7 72226.6 77550.0 78376.0 82480.6 84104.0 12316.1 12561.5 12905.5 13185.7 13370.3 13795.5 14020.9 14035.1 14084.1 14449.5 13018.6 13350.5 13728.7 13779.3 13993.4 13166.5 13550.8 13581.7 13787.4 13908.3 12829.9 12920.6 12998.9 13032.5 13252.9 10172.2 10421.5 11314.6 11316.2 11373.5 11453.3 11758.9 11856.0 12194.8 12433.3 11:03:45 INFO - PROCESS | 12347 | -------- Summary: end -------- 11:03:45 INFO - PROCESS | 12347 | 11:03:46 INFO - TEST-INFO | 12347: exit 0 11:03:46 INFO - TEST-OK | dromaeo_css | took 1111834ms 11:03:46 INFO - TEST-START | kraken 11:03:46 INFO - operating with platform_type : linux_ 11:03:46 INFO - Initialising browser for kraken test... 11:03:46 INFO - TEST-INFO | started process 12594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDitTnZ/profile http://localhost:43638/getInfo.html) 11:03:51 INFO - PROCESS | 12594 | __metrics Screen width/height:1600/1200 11:03:51 INFO - PROCESS | 12594 | colorDepth:24 11:03:51 INFO - PROCESS | 12594 | Browser inner width/height: 1024/697 11:03:51 INFO - PROCESS | 12594 | __metrics 11:03:52 ERROR - PROCESS | 12594 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:03:53 INFO - TEST-INFO | 12594: exit 0 11:03:53 INFO - Browser initialized. 11:03:53 INFO - Running cycle 1/1 for kraken test... 11:03:53 INFO - TEST-INFO | started process 12726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDitTnZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:05 INFO - PROCESS | 12726 | RSS: Main: 156274688 11:04:05 INFO - PROCESS | 12726 | 11:04:07 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43638/tests/kraken/driver.html?testName=audio-beat-detection) 11:04:08 INFO - PROCESS | 12726 | RSS: Main: 161300480 11:04:08 INFO - PROCESS | 12726 | 11:04:11 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43638/tests/kraken/driver.html?testName=audio-dft) 11:04:11 INFO - PROCESS | 12726 | RSS: Main: 161067008 11:04:11 INFO - PROCESS | 12726 | 11:04:14 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43638/tests/kraken/driver.html?testName=audio-fft) 11:04:15 INFO - PROCESS | 12726 | RSS: Main: 161492992 11:04:15 INFO - PROCESS | 12726 | 11:04:17 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43638/tests/kraken/driver.html?testName=audio-oscillator) 11:04:17 INFO - PROCESS | 12726 | RSS: Main: 161132544 11:04:17 INFO - PROCESS | 12726 | 11:04:20 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43638/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:04:20 INFO - PROCESS | 12726 | RSS: Main: 160690176 11:04:20 INFO - PROCESS | 12726 | 11:04:23 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43638/tests/kraken/driver.html?testName=imaging-darkroom) 11:04:24 INFO - PROCESS | 12726 | RSS: Main: 161316864 11:04:24 INFO - PROCESS | 12726 | 11:04:27 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43638/tests/kraken/driver.html?testName=imaging-desaturate) 11:04:28 INFO - PROCESS | 12726 | RSS: Main: 157818880 11:04:28 INFO - PROCESS | 12726 | 11:04:31 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43638/tests/kraken/driver.html?testName=json-parse-financial) 11:04:31 INFO - PROCESS | 12726 | RSS: Main: 159322112 11:04:31 INFO - PROCESS | 12726 | 11:04:33 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43638/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:04:34 INFO - PROCESS | 12726 | RSS: Main: 159297536 11:04:34 INFO - PROCESS | 12726 | 11:04:35 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43638/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:04:36 INFO - PROCESS | 12726 | RSS: Main: 159436800 11:04:36 INFO - PROCESS | 12726 | 11:04:38 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43638/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:04:39 INFO - PROCESS | 12726 | RSS: Main: 159694848 11:04:39 INFO - PROCESS | 12726 | 11:04:41 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:04:42 INFO - PROCESS | 12726 | RSS: Main: 160006144 11:04:42 INFO - PROCESS | 12726 | 11:04:44 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:04:45 INFO - PROCESS | 12726 | RSS: Main: 159776768 11:04:45 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | Cycle 1(1): loaded http://localhost:43638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43638/tests/kraken/driver.html?testName=ai-astar) 11:04:47 INFO - PROCESS | 12726 | RSS: Main: 160821248 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | __start_tp_report 11:04:47 INFO - PROCESS | 12726 | _x_x_mozilla_page_load 11:04:47 INFO - PROCESS | 12726 | _x_x_mozilla_page_load_details 11:04:47 INFO - PROCESS | 12726 | |i|pagename|runs| 11:04:47 INFO - PROCESS | 12726 | |0;ai-astar;112;106;111;110;111;111;111;110;111;116 11:04:47 INFO - PROCESS | 12726 | |1;audio-beat-detection;154;126;149;172;126;154;161;129;182;127 11:04:47 INFO - PROCESS | 12726 | |2;audio-dft;161;162;162;162;164;161;163;162;163;161 11:04:47 INFO - PROCESS | 12726 | |3;audio-fft;75;75;76;182;75;74;75;76;168;74 11:04:47 INFO - PROCESS | 12726 | |4;audio-oscillator;84;84;147;84;84;84;142;85;84;144 11:04:47 INFO - PROCESS | 12726 | |5;imaging-gaussian-blur;117;118;118;117;117;118;117;117;118;118 11:04:47 INFO - PROCESS | 12726 | |6;imaging-darkroom;148;146;147;147;147;148;147;147;151;147 11:04:47 INFO - PROCESS | 12726 | |7;imaging-desaturate;95;95;97;95;95;96;96;96;96;95 11:04:47 INFO - PROCESS | 12726 | |8;json-parse-financial;52;52;52;51;56;55;53;51;53;54 11:04:47 INFO - PROCESS | 12726 | |9;json-stringify-tinderbox;60;61;60;61;60;61;60;60;61;61 11:04:47 INFO - PROCESS | 12726 | |10;stanford-crypto-aes;77;80;77;85;77;83;79;77;98;78 11:04:47 INFO - PROCESS | 12726 | |11;stanford-crypto-ccm;127;119;127;117;119;127;135;120;121;125 11:04:47 INFO - PROCESS | 12726 | |12;stanford-crypto-pbkdf2;156;153;156;158;154;153;153;156;154;151 11:04:47 INFO - PROCESS | 12726 | |13;stanford-crypto-sha256-iterative;68;67;64;62;60;61;61;59;61;64 11:04:47 INFO - PROCESS | 12726 | __end_tp_report 11:04:47 INFO - PROCESS | 12726 | __start_cc_report 11:04:47 INFO - PROCESS | 12726 | _x_x_mozilla_cycle_collect,884 11:04:47 INFO - PROCESS | 12726 | __end_cc_report 11:04:47 INFO - PROCESS | 12726 | __startTimestamp1469729087432__endTimestamp 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | ------- Summary: start ------- 11:04:47 INFO - PROCESS | 12726 | Number of tests: 14 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.42 (2.2%) stddev-sans-first:2.54 11:04:47 INFO - PROCESS | 12726 | Values: 112.0 106.0 111.0 110.0 111.0 111.0 111.0 110.0 111.0 116.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:154.00 stddev:20.40 (13.2%) stddev-sans-first:21.52 11:04:47 INFO - PROCESS | 12726 | Values: 154.0 126.0 149.0 172.0 126.0 154.0 161.0 129.0 182.0 127.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 11:04:47 INFO - PROCESS | 12726 | Values: 161.0 162.0 162.0 162.0 164.0 161.0 163.0 162.0 163.0 161.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.00 stddev:42.30 (56.4%) stddev-sans-first:44.24 11:04:47 INFO - PROCESS | 12726 | Values: 75.0 75.0 76.0 182.0 75.0 74.0 75.0 76.0 168.0 74.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:84.00 stddev:29.10 (34.6%) stddev-sans-first:30.11 11:04:47 INFO - PROCESS | 12726 | Values: 84.0 84.0 147.0 84.0 84.0 84.0 142.0 85.0 84.0 144.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:04:47 INFO - PROCESS | 12726 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 11:04:47 INFO - PROCESS | 12726 | Values: 148.0 146.0 147.0 147.0 147.0 148.0 147.0 147.0 151.0 147.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 11:04:47 INFO - PROCESS | 12726 | Values: 95.0 95.0 97.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.66 (3.1%) stddev-sans-first:1.73 11:04:47 INFO - PROCESS | 12726 | Values: 52.0 52.0 52.0 51.0 56.0 55.0 53.0 51.0 53.0 54.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:04:47 INFO - PROCESS | 12726 | Values: 60.0 61.0 60.0 61.0 60.0 61.0 60.0 60.0 61.0 61.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:79.50 stddev:6.56 (8.2%) stddev-sans-first:6.78 11:04:47 INFO - PROCESS | 12726 | Values: 77.0 80.0 77.0 85.0 77.0 83.0 79.0 77.0 98.0 78.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:126.00 stddev:5.50 (4.4%) stddev-sans-first:5.70 11:04:47 INFO - PROCESS | 12726 | Values: 127.0 119.0 127.0 117.0 119.0 127.0 135.0 120.0 121.0 125.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:155.00 stddev:2.07 (1.3%) stddev-sans-first:2.11 11:04:47 INFO - PROCESS | 12726 | Values: 156.0 153.0 156.0 158.0 154.0 153.0 153.0 156.0 154.0 151.0 11:04:47 INFO - PROCESS | 12726 | 11:04:47 INFO - PROCESS | 12726 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:2.98 (4.7%) stddev-sans-first:2.47 11:04:47 INFO - PROCESS | 12726 | Values: 68.0 67.0 64.0 62.0 60.0 61.0 61.0 59.0 61.0 64.0 11:04:47 INFO - PROCESS | 12726 | -------- Summary: end -------- 11:04:47 INFO - PROCESS | 12726 | 11:04:48 INFO - TEST-INFO | 12726: exit 0 11:04:48 INFO - TEST-OK | kraken | took 62220ms 11:04:48 INFO - SUITE-END | took 1174s 11:04:48 INFO - Completed test suite (00:19:34) 11:04:48 INFO - javascript benchmark 11:04:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7634.158964850286, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3372.291818718069, 3375.7130643895252, 3386.0, 3405.233822389962, 3411.3177364527087, 5478.698671573062, 5496.0, 5562.860928476795, 5566.443355664442, 5574.442555744424, 5729.713514324288, 5772.480476757091, 5795.681237531945, 5822.446867547576, 5841.415858414167, 5215.035218484583, 5244.895102097956, 5271.2356708277275, 5285.418603953562, 5309.309789727349, 5136.845894623168, 5150.639455238135, 5184.196449550326, 5292.497212764782, 5349.010433069894, 5134.25553294772, 5144.8971020579565, 5186.7147306898105, 5254.4220135785035, 5286.524212820846, 5145.022445735298, 5157.174852023677, 5175.611829112794, 5187.325647665779, 5212.139996900507, 4962.255661650745, 5038.143515602356, 5113.411957624847, 5121.487851214886, 5167.6641018333685, 5475.835724928259, 5510.311211098613, 5543.334799824047, 5553.8333849984565, 5591.10542313232, 6041.758329666808, 6082.635041897501, 6085.847853803691, 6096.359882212349, 6106.755729770804, 6053.061775424816, 6131.315499379007, 6134.263888333428, 6147.293061297919, 6151.323354431009, 5800.303963524404, 5801.158831969383, 5801.564882633777, 5822.97088514559, 5857.355690874043, 6364.649944253018, 6370.872582548323, 6370.968145159337, 6380.968095159495, 6386.425221730066, 5866.266716660418, 5997.340292567814, 6008.279006519246, 6029.035354343284, 6110.572259941761, 6137.769204764619, 6161.476274516626, 6167.259928808482, 6167.383261673886, 6168.167297414791, 6057.97014507526, 6096.237970253718, 6109.327973922865, 6119.296280927751, 6180.072989051679, 5945.970270148621, 6087.360827113178, 6110.419510146529, 6133.202683651186, 6154.753809847556, 4700.647451441156, 4701.106789709944, 4705.95294047062, 4719.59883409914, 4767.261074533453, 4151.564085771011, 4198.916021679549, 4206.0326124991425, 4210.347396153601, 4235.661147108224, 5755.050416681284, 5773.451522105393, 5808.82573522795, 5843.970780146157, 5875.970620146872, 6132.69706892425, 6133.4264757247465, 6232.25212974446, 6246.469050130699, 6258.843528911813, 5746.770129194869, 5964.522838172936, 5978.282606087298, 5979.133025711248, 6009.338972712998, 5203.063448579216, 5214.400343960418, 5230.529252367305, 5250.868728281824, 5276.208568714646, 6443.838904027343, 6452.677366131675, 6456.741730330828, 6458.257300410419, 6460.806175814733, 5955.464008239279, 6117.724702388492, 6204.5967012144065, 6205.28639206488, 6216.813495595139, 6313.3686631336495, 6435.935640643534, 6438.549301548846, 6458.192725909262, 6468.967655161694, 6043.848903777441, 6068.848278793065, 6073.210482637229, 6092.329843717099, 6116.66358350295, 5976.462118409364, 6134.6625935573975, 6139.001538246313, 6198.504119670325, 6214.316425193135, 5914.2311499504785, 6007.189029481139, 6009.128676341993, 6011.248593925759, 6033.668148251712, 5985.162077309267, 6003.429674180946, 6003.609765365237, 6010.789622363196, 6016.308124565731, 5810.302763668386, 5881.529477641864, 5907.793227237026, 5919.792807251725, 5948.613340132878, 6114.296855861633, 6118.877622447437, 6120.204373431426, 6129.84675383119, 6182.227221597301, 5982.162497250301, 5985.461308482258, 5989.610675306091, 6001.789937352171, 6002.219711437485], "value": 5662.300157486884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.5835273661173, 659.7427003468647, 660.3858411677141, 682.072381561077, 688.2738710660251, 41897.371539426895, 46165.0, 46331.305030424526, 46412.303815442756, 46443.76778116105, 48108.0, 48779.26831097536, 48813.267800982925, 48825.51174488254, 48848.75575622126, 8946.955265223665, 9027.187553120219, 9122.22461090808, 9125.087491250855, 9143.817123657524, 8873.467591944504, 8885.777855553599, 8888.06675299094, 8949.284057275436, 8975.416597921114, 8883.422577532472, 8960.775980600472, 8983.550822458883, 8990.100989901022, 8999.910000899972, 8934.463932164059, 8963.148500892405, 8973.057828927935, 8980.28157747382, 8981.0, 8936.0, 8950.955245223797, 9006.0, 9027.187553120251, 9054.320925930582, 44202.778986105186, 44246.77876610628, 44449.77775111104, 44542.777286113684, 44745.77627111876, 3776.169242766587, 3895.357266051098, 3937.232239713257, 3967.107400834818, 4073.2260870434525, 35332.64667353345, 35523.64476355229, 35587.28825423503, 35681.46477802835, 35682.64317356845, 4593.471750748673, 4725.960288736507, 4741.95258047422, 4778.2115950868065, 4791.305260737208, 371720.0, 371941.0, 372258.0, 372276.0, 373460.1326993375, 68070.65964670145, 68968.0, 69098.65450672715, 69108.30891691119, 69188.0, 39994.0, 40757.18485630271, 40890.1821963565, 42558.148837023706, 42699.57300427018, 19280.4215873524, 19460.4161875144, 19472.0, 19536.0, 19620.117094730773, 14623.04950178235, 14643.56069317922, 14763.926180369244, 14784.0, 14806.333714982851, 21275.680864787042, 21548.35354939354, 21604.675929861063, 21676.45808854791, 21824.563508729738, 7562.395008399315, 7568.772936811904, 7669.923300767033, 7916.683332666744, 7946.715434236284, 1036.212478516333, 1096.4736926275273, 1114.899659030691, 1123.719070232442, 1184.1710802438329, 31938.840305798323, 32394.028179154662, 32400.837995810343, 32562.674373255963, 32575.02274931756, 1199.6880810989205, 1200.5017917564112, 1251.217988757027, 1266.0567876931561, 1290.470906928155, 17197.484075477754, 17281.222344994505, 17304.480865574053, 17336.30654773795, 17470.47588572345, 468459.0, 586840.0, 603774.0, 605326.0, 917425.0, 64336.678316608115, 64718.0, 65205.34794651993, 65300.34699652943, 65539.67230163819, 1502.068717395222, 1507.0656193160312, 1519.3390874969646, 1528.335174199227, 1529.4111766969797, 33650.0, 34130.65869341275, 34673.65326346805, 34751.304973900886, 34977.475337869444, 57651.0, 58076.0, 58147.0, 58303.708481457325, 58370.4162958365, 515348.0, 522058.0, 525759.0, 526071.0, 527550.0, 27905.302367440978, 28125.015624453863, 28138.43723125567, 28374.290642734097, 28377.71622283751, 51780.0, 52485.21272180844, 52722.47277527176, 52815.0, 53811.0, 43821.0, 44800.77599611981, 45277.54722452865, 45623.0, 45751.0, 43964.0, 44243.0, 44465.33302000408, 44859.0, 44906.77546612377, 42721.0, 43401.56598433975, 43775.56224437842, 44247.33628995632, 44410.11179776322, 37363.813180933925, 37754.8112259437, 38987.41518877162, 39203.2159356817, 39291.80354098211, 29204.7079529202, 29703.55444668375, 29749.70250297556, 29866.253343665714, 29991.700082999763], "value": 21523.829760874643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.867713654494, 405.55996743533285, 424.2999051564918, 424.84705506017826, 429.2745260509738, 18415.63168736626, 19066.809331906676, 19673.21307147716, 19789.140276000147, 19937.3021944232, 18391.356302529413, 19093.23627054916, 19118.52203694905, 19196.136173872175, 19717.0, 5070.467600901899, 5216.634835561512, 5256.3955145158225, 5297.602679799012, 5298.973505132488, 5119.1809310510325, 5249.973750131263, 5343.251944727741, 5347.759350829222, 5350.866228344284, 5326.041312563756, 5327.387350454708, 5328.120860058105, 5335.759890804923, 5351.705656188928, 5116.2069879168785, 5278.551323137538, 5304.681719096828, 5304.946950530484, 5315.229291752694, 5140.640155189139, 5145.125328694131, 5179.430262671103, 5188.740562971874, 5205.973970130125, 13210.33948302581, 13479.0, 13506.86493135066, 13584.32078396086, 13641.795373069412, 2381.8809059547125, 2407.0973384980634, 2413.20364279789, 2460.458699086198, 2584.470183612355, 9917.157041651468, 10086.041826026516, 10095.646652367132, 10131.0, 10330.793384132276, 1842.8894266344062, 1915.6743353629915, 2011.416689160142, 2023.7773844877051, 2032.7763945965933, 51893.74053129748, 52590.737046314905, 75442.62278688626, 79829.0, 79920.60039699764, 9465.574049167804, 10144.188464922789, 10278.948605256926, 10343.793124137475, 10350.223733220038, 12712.0, 13669.179849209078, 13823.447062117604, 13867.098638588459, 13871.653208669662, 7657.310842024244, 8124.0, 8152.2662960333855, 8410.074891761902, 8455.0, 8399.37004724648, 8511.808346831449, 8542.701005464904, 8571.914280857112, 8575.056743758181, 4339.956600434019, 4351.564843515686, 4361.716488428242, 4377.8248870044845, 4478.328250762412, 2067.79322067792, 2111.5776844631137, 2125.5111324395475, 2132.914683412646, 2152.6878602602533, 1019.8419245017034, 1065.3927261461047, 1069.1874175626424, 1142.0349804415255, 1146.5643055638805, 16692.0, 19571.11929963155, 19580.60838783245, 19619.705704414446, 19641.803581964283, 1035.9119474844572, 1049.5801679328176, 1089.3681664634494, 1102.4928532874808, 1122.5902545570807, 10338.689839304832, 10950.835737463944, 10970.286931349438, 10996.725081872857, 11015.83476247857, 364115.0, 365300.0, 369225.0, 508387.0, 510804.0, 95328.52335738277, 102860.48569757253, 102893.0, 103516.48241758742, 103745.48127259467, 1080.9621663241749, 1099.2854644480992, 1122.5509796081633, 1131.4286285425808, 1140.321508702321, 16326.102064386572, 17586.0, 17899.015554144647, 18124.909375453037, 18129.909350453163, 42130.789346053076, 43050.0, 43177.0, 44084.33873491836, 44684.32973505335, 56495.71752141213, 56980.715096424254, 57625.71187144038, 57943.0, 58006.41993580179, 8505.36209784281, 8672.869906951275, 8801.251893589117, 8812.07473215303, 8876.11238876133, 12566.371681416076, 13495.325233738471, 13683.0, 13684.86315136836, 13802.447902083804, 10207.234457415576, 11679.474423651127, 11938.462769175234, 12149.574764883188, 12269.141160118706, 11705.063594912557, 11919.463624137108, 11981.520739170335, 12028.75942481163, 12355.320457374572, 12042.578509752117, 12198.75602487963, 12310.322932238812, 12498.625041248777, 12505.062120341192, 8437.0, 8502.659893604186, 8618.138186181583, 8660.004099528634, 8683.0, 11343.376114313793, 11383.601573944872, 11387.715307117389, 11572.884271157518, 11755.47100380502], "value": 9026.93570944709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1616.7898173237481, 1622.945085694299, 1847.8706490545667, 1897.5635603811115, 1928.3250862198224, 9442.386244894076, 9783.168430683383, 9939.055789699985, 10081.042300981404, 10093.69718908433, 10167.745806354846, 10208.64269750559, 10277.229207809425, 10328.535215915283, 10348.586056557748, 2316.953660926785, 2341.2156927429332, 2346.730126035502, 2351.247600767755, 2355.1756885090167, 2274.2608652188023, 2290.5533420982915, 2294.529621427603, 2302.9193978210765, 2317.536492701458, 2276.3398614401804, 2287.0965968442456, 2287.233776684804, 2300.64340027296, 2309.4457330240707, 2251.0658076898067, 2268.0247493577754, 2268.3308424014954, 2268.5689718953345, 2277.954440911181, 2206.558688262338, 2238.0264584905617, 2246.056656204398, 2248.9437764055865, 2256.8871556422114, 10053.145482633985, 10076.647317343932, 10090.243231757648, 10146.23903207255, 10149.949250253776, 5739.339975902742, 5909.497692696126, 5911.379305172938, 5915.319738230116, 5919.5560332974765, 3455.585329760445, 3505.8247087645514, 3612.1330880588735, 3623.3296840084668, 3632.128289210597, 1188.5899364719157, 1190.65471013406, 1243.2167734327406, 1258.7860063789178, 1284.7687416265069, 13834.93082534591, 13913.23477208743, 13920.582382528439, 14009.439622415091, 14041.859581404158, 4800.903981920342, 4843.660943733976, 4933.309336692866, 4967.0, 4971.055499455164, 10867.45662716861, 10886.455677216265, 10902.781944361068, 10909.563617455371, 10934.125269978382, 5729.169270455761, 5739.971300143473, 5744.626599271034, 5749.712514374264, 5772.855678608068, 4533.77331133442, 5117.0, 5199.870003249949, 5211.2443695663915, 5238.266642670029, 4097.303458412077, 4102.3909091812275, 4191.826288639186, 4202.285611446, 4207.486748564921, 1218.2994778002683, 1242.67069226655, 1255.4350542256022, 1268.0996492490435, 1270.898328133747, 1020.5458570936011, 1030.4641586375192, 1042.8435734639713, 1049.6168898352046, 1051.5268129341828, 6215.160953271341, 6383.9361606383345, 6428.8071357859335, 6575.539712220194, 6578.144841170713, 1056.630179437191, 1072.683558350273, 1095.457748414524, 1095.9890401096047, 1102.2284400919389, 4029.194161167778, 4126.896827579335, 4152.979235103866, 4154.065335299594, 4155.522114956819, 12598.181118227287, 12636.684082898, 12917.806232906514, 12988.935055324662, 13051.673708157372, 12771.936140319425, 12855.485780568859, 12863.48546058166, 12866.035047371484, 12896.548620798414, 9047.954760226157, 9256.166944974984, 9364.063593640582, 9443.622255109856, 9512.619495220251, 6238.500919926486, 6247.875042499216, 6329.968350158219, 6344.429001389897, 6379.96810015947, 10925.453727313761, 11397.0, 11521.078313734713, 11590.13074019435, 11614.477348519506, 11589.7102572433, 11663.24188927717, 11752.294862308288, 11789.99785018283, 11867.050635949276, 8149.959250203711, 8326.791830204293, 8490.44812087237, 8905.643774248958, 9100.22648074921, 9756.219502439646, 9784.266180036384, 9826.263030272616, 9848.162906153057, 9885.50572471388, 8626.741197764077, 8793.384463087523, 8904.376693631384, 8972.910270897208, 9017.368784185044, 8570.657173712982, 8602.0, 8653.69712060075, 8725.083866194213, 8825.470471771714, 7467.850642987001, 7522.247775222434, 7538.057742782153, 7584.203658615987, 7631.1605723371495, 5325.547328477122, 5332.280142180911, 5405.081136206775, 5412.0, 5454.836354909359, 5329.307190065267, 5426.240326354393, 5441.911617676401, 5570.637908535932, 5591.329040515164], "value": 5035.163931563805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.71864759012067, 322.9580154579904, 324.5634621434171, 329.74939046324783, 330.6396028329122, 5674.60277780555, 5749.367569567349, 5785.652860828348, 5802.738876750545, 5806.854828629286, 5635.520980716644, 5666.150077488379, 5688.179782469611, 5700.714964251792, 5724.7137643117885, 4172.833086676537, 4187.853425130121, 4364.912701745963, 4366.847160349388, 4384.583464570861, 4343.978280108611, 4372.956270437303, 4373.409589705397, 4377.1683380157665, 4380.605745482906, 4312.202242585132, 4335.848245311415, 4339.132173565284, 4342.131573685259, 4344.544577566519, 4190.0, 4245.426867372896, 4249.68127390447, 4271.359296105578, 4273.1240095780295, 3707.7589956652732, 3719.1817800083936, 3728.2170744143764, 3735.2716220337047, 3758.3986562149926, 5418.783248670088, 5419.485148910847, 5440.836774896759, 5461.2354270402175, 5520.199571062214, 4849.884526558876, 4943.456219815817, 4972.950270497285, 4974.676646017997, 4992.976439829826, 5830.4169583041785, 5870.6477611343025, 5922.548975500987, 5936.1392598073035, 5949.8215053548465, 4115.176964607061, 4163.125743593849, 4171.457710497646, 4187.979060104711, 4199.076203235314, 5942.286925568917, 6050.21347224858, 6099.176611157525, 6146.78486252979, 6226.87546249077, 4223.260929337353, 4263.59495847894, 4264.232438161099, 4273.807678654468, 4286.849960251377, 4288.185244803477, 4293.8711838644895, 4306.0957198987935, 4309.655227581786, 4315.978420107879, 4798.869449254559, 4920.261960705851, 4941.72820494869, 4955.752212389366, 4979.128652485801, 5867.6772777497645, 5928.288605367384, 5951.345352011275, 5956.255468066492, 5970.671613061323, 1474.6903150338549, 1490.8509149085005, 1495.3046833222604, 1497.4833682379563, 1502.0011692224548, 916.5829547555979, 946.6828612414918, 969.1181025266973, 969.5879251318162, 971.2812518736084, 5760.74076666551, 5764.308283005982, 5785.623934444247, 5791.362950075489, 5826.504747096545, 6086.391360863879, 6088.360722124202, 6096.542759293071, 6099.597092668622, 6163.044728067157, 5483.862903427446, 5724.513416359573, 5783.248177736868, 5783.8554036149435, 5793.362730099686, 3170.95358531684, 3221.7744757867194, 3251.0, 3252.5121231815415, 3253.6258330291844, 6048.848778780566, 6287.1198032275515, 6295.496360291166, 6297.464715499143, 6323.272823625342, 6193.380661933861, 6209.285932117864, 6214.844628884314, 6220.34686357935, 6263.404976527223, 6032.54755893301, 6274.215723034621, 6280.775248826526, 6315.5894866833505, 6377.17096777416, 6120.418560236771, 6124.356942520971, 6147.293061298008, 6153.446189842935, 6168.255126468678, 6149.631022138686, 6158.214117905757, 6159.260888693386, 6184.226971628546, 6184.257889053342, 6152.969235153795, 6273.247210334606, 6319.747210111728, 6321.64084721787, 6406.1031455597185, 4210.431591735077, 4227.091175397304, 4242.618164365099, 4243.554426785143, 4250.447441832542, 5774.0, 5895.587308888336, 6137.324894261538, 6186.113235463047, 6190.473809726223, 5870.589058766016, 5921.424180481505, 5933.131063714916, 5958.5828991971875, 5995.86078645056, 5715.885682286248, 5853.443922827495, 5949.553783466344, 5959.970200148971, 5977.432143946318, 5785.392533783892, 5808.593398462067, 5848.4151584841175, 5868.383819699041, 5877.706114694333, 5948.910766338595, 5992.490638295793, 6003.5797494174985, 6035.0, 6038.607490513103, 5652.530342110998, 5831.650100993954, 5849.590528663123, 5855.7364918579615, 5880.470757631833], "value": 4485.851909914267, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.5660768627296, 727.2255048373485, 773.1804287455298, 782.5343920367382, 909.6725178935584, 16292.918535407322, 17041.403550875722, 17318.220680069397, 17410.0, 17419.041952692598, 15984.0, 16153.757693634576, 16160.191990400463, 16166.353345866151, 16176.75734863978, 720.7369310201778, 857.2327766648846, 882.898466676334, 886.2466903132319, 886.2732559301376, 860.6213266162869, 871.5772850167664, 874.8862647855801, 875.5140896802272, 875.9605817738217, 916.2990312411011, 923.4505469245788, 925.7824411263348, 926.1340646495514, 928.9907100928972, 926.3654396738223, 927.8144371125734, 927.8515437529996, 928.614624930653, 928.6888892221114, 676.8713944350558, 679.5548915460381, 680.1566058087985, 683.6855046678534, 686.5262968551733, 15805.209739513093, 15831.445899393466, 15912.0, 15921.840781592151, 15971.201439927958, 14332.928335358361, 14821.036632618952, 15277.541673749805, 15344.693106137815, 15439.536813895602, 12479.251244925334, 12809.807852882213, 13147.671308217276, 13386.062975591713, 13685.384157712828, 4031.697622678311, 4078.3474644057105, 4099.754014759094, 4118.5057793065025, 4154.875353739392, 77509.0, 78830.0, 79565.60217198935, 80380.19619803844, 80653.19346806516, 11937.88062119385, 12093.818592721116, 12257.387130643432, 12329.938350308192, 12603.810942835864, 22480.775192248195, 22587.887060564593, 22645.320640380814, 22659.773402265768, 22664.320070397913, 8637.103315799683, 8715.215630593277, 8825.20573148407, 8971.461712297283, 8979.955100224588, 5096.464871188546, 5185.637005409585, 5193.662411943287, 5214.165733482625, 5219.686818790885, 3838.5201849768778, 3947.4670919426085, 3956.9208615827524, 3965.623265789803, 3979.7015223858325, 617.6294223465884, 681.0669382945397, 681.6251061916025, 682.4574463301688, 686.0943554508002, 801.8235988082613, 819.5451524403894, 836.4019725896013, 850.5747126436781, 855.6534603485599, 10214.438205898598, 10427.374357538572, 10435.37387756737, 10451.111655509214, 10473.0, 795.5827346672195, 817.5991685432114, 827.4538804389194, 838.7567605394489, 848.4400295804862, 4892.8532144035735, 4924.926126108111, 4987.152184128707, 4991.50084991498, 5023.949760502348, 96634.0, 111120.44439777911, 121743.0, 122347.0, 124077.0, 99082.50458747805, 100710.0, 104171.47914260531, 105250.0, 105362.99999999847, 88848.5557572208, 91552.0, 91982.0, 92170.53914730383, 93137.53431232936, 9049.457032578066, 9145.817083658423, 9315.39449935752, 9352.906470935204, 9490.00354962719, 53632.0, 53779.0, 54303.45696542984, 55219.72390138024, 56302.718486407306, 72226.63886680533, 77550.0, 78376.0, 82480.58759706403, 84104.0, 12316.076294278144, 12561.497540098659, 12905.548305809252, 13185.670358241121, 13370.264635445144, 13795.517156899461, 14020.929895350459, 14035.087719298213, 14084.084534505224, 14449.49426770058, 13018.609441716764, 13350.532731354357, 13728.725425491633, 13779.311034448037, 13993.370298336802, 13166.539171128965, 13550.79673804874, 13581.728365432833, 13787.379567919668, 13908.304584770518, 12829.9094576962, 12920.612381628565, 12998.870011299767, 13032.54386096482, 13252.86747132555, 10172.237082219011, 10421.478926053818, 11314.60398886035, 11316.194243023498, 11373.54505819758, 11453.255538389978, 11758.90410958904, 11856.0, 12194.756104877675, 12433.254004759743], "value": 7965.529050594153, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 110.0, 111.0, 111.0, 111.0, 110.0, 111.0, 116.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 149.0, 172.0, 126.0, 154.0, 161.0, 129.0, 182.0, 127.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 164.0, 161.0, 163.0, 162.0, 163.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 182.0, 75.0, 74.0, 75.0, 76.0, 168.0, 74.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 147.0, 84.0, 84.0, 84.0, 142.0, 85.0, 84.0, 144.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 151.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 51.0, 56.0, 55.0, 53.0, 51.0, 53.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 61.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 77.0, 85.0, 77.0, 83.0, 79.0, 77.0, 98.0, 78.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 119.0, 127.0, 117.0, 119.0, 127.0, 135.0, 120.0, 121.0, 125.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 156.0, 158.0, 154.0, 153.0, 153.0, 156.0, 154.0, 151.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 64.0, 62.0, 60.0, 61.0, 61.0, 59.0, 61.0, 64.0], "value": 62.7, "unit": "score"}]}]} 11:04:48 INFO - Return code: 0 11:04:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:04:48 ERROR - # TBPL SUCCESS # 11:04:48 INFO - Running post-action listener: _resource_record_post_action 11:04:48 INFO - ##### 11:04:48 INFO - ##### Finished run-tests step (success) 11:04:48 INFO - ##### 11:04:48 INFO - Running post-run listener: _resource_record_post_run 11:04:48 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 290816; Write bytes: 510062592; Read time: 60; Write time: 1707684 11:04:48 INFO - TinderboxPrint: CPU usage
13.5% 11:04:48 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 60 11:04:48 INFO - TinderboxPrint: I/O write bytes / time
510,062,592 / 1,707,684 11:04:48 INFO - TinderboxPrint: CPU idle
8,260.9 (86.5%) 11:04:48 INFO - TinderboxPrint: CPU user
1,208.4 (12.7%) 11:04:48 INFO - TinderboxPrint: Swap in / out
0 / 0 11:04:48 INFO - install - Wall time: 22s; CPU: 19.0%; Read bytes: 0; Write bytes: 263184384; Read time: 0; Write time: 961328 11:04:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246878208; Read time: 52; Write time: 746356 11:04:49 INFO - Running post-run listener: _upload_blobber_files 11:04:49 INFO - Blob upload gear active. 11:04:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:04:49 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 11:04:49 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'] 11:04:49 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 11:04:49 INFO - (blobuploader) - INFO - Open directory for files ... 11:04:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:04:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:04:50 INFO - (blobuploader) - INFO - Done attempting. 11:04:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:04:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:04:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:04:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:04:54 INFO - (blobuploader) - INFO - Done attempting. 11:04:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:04:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:04:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:04:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:04:55 INFO - (blobuploader) - INFO - Done attempting. 11:04:55 INFO - (blobuploader) - INFO - Iteration through files over. 11:04:55 INFO - Return code: 0 11:04:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:04:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:04:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1097ce1bff30d201c3eafe78ccb7c0a3517c5769ee2978e5639c7ba17dc7c0e72cc351401589a9b5712fa0734e0af21f26a849e0a49b6e27d869b5a04b2a1c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac276a87e2ef163109b880359fd2b6821dfb34f1c68afe25268035eefb381ac900bd3deb80948242b1831a76b945716d8131b56062223e6c2b62aab05faddca3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a3dfabae322191e72f27a90f556bbcd4d3b7e9aa656f5594b87d217abd52402385c45d8791eabf54413836bd56b199819f4ff831e821e57a076b1422b7973c7"} 11:04:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:04:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:04:55 INFO - Contents: 11:04:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1097ce1bff30d201c3eafe78ccb7c0a3517c5769ee2978e5639c7ba17dc7c0e72cc351401589a9b5712fa0734e0af21f26a849e0a49b6e27d869b5a04b2a1c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac276a87e2ef163109b880359fd2b6821dfb34f1c68afe25268035eefb381ac900bd3deb80948242b1831a76b945716d8131b56062223e6c2b62aab05faddca3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a3dfabae322191e72f27a90f556bbcd4d3b7e9aa656f5594b87d217abd52402385c45d8791eabf54413836bd56b199819f4ff831e821e57a076b1422b7973c7"} 11:04:55 INFO - Running post-run listener: copy_logs_to_upload_dir 11:04:55 INFO - Copying logs to upload dir... 11:04:55 INFO - mkdir: /builds/slave/test/build/upload/logs 11:04:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.546292 ========= master_lag: 1.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-28 11:04:56.312861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-28 11:04:56.316345) ========= 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=8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1097ce1bff30d201c3eafe78ccb7c0a3517c5769ee2978e5639c7ba17dc7c0e72cc351401589a9b5712fa0734e0af21f26a849e0a49b6e27d869b5a04b2a1c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac276a87e2ef163109b880359fd2b6821dfb34f1c68afe25268035eefb381ac900bd3deb80948242b1831a76b945716d8131b56062223e6c2b62aab05faddca3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a3dfabae322191e72f27a90f556bbcd4d3b7e9aa656f5594b87d217abd52402385c45d8791eabf54413836bd56b199819f4ff831e821e57a076b1422b7973c7"} build_url:https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010648 build_url: 'https://queue.taskcluster.net/v1/task/RJ1vzjZfS6aZ-cYBAmlcpQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1097ce1bff30d201c3eafe78ccb7c0a3517c5769ee2978e5639c7ba17dc7c0e72cc351401589a9b5712fa0734e0af21f26a849e0a49b6e27d869b5a04b2a1c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac276a87e2ef163109b880359fd2b6821dfb34f1c68afe25268035eefb381ac900bd3deb80948242b1831a76b945716d8131b56062223e6c2b62aab05faddca3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a3dfabae322191e72f27a90f556bbcd4d3b7e9aa656f5594b87d217abd52402385c45d8791eabf54413836bd56b199819f4ff831e821e57a076b1422b7973c7"}' ========= master_lag: 1.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-28 11:04:57.340204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-07-28 11:04:57.340559) ========= 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=8783db0840cc980e80bb0bd400000236-1469727853.285094-1651872000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 2.00 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-07-28 11:04:59.343558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 11:04:59.343941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 11:04:59.488327) ========= ========= Total master_lag: 4.33 =========