builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1461082819.57 results: success (0) buildid: 20160419065801 builduid: 7bbf17b5fd5d4b86957d66328dc335f8 revision: 73554a815d7c3ae9ba4b61ead297fb3bb7ba7b27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:19.567725) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:19.568242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:19.568556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:19.582810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:19.583146) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 09:20:20-- 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% 46.6M=0s 2016-04-19 09:20:20 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072709 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:19.669721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:19.670106) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015151 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:19.720142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 09:20:19.720541) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 73554a815d7c3ae9ba4b61ead297fb3bb7ba7b27 --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 73554a815d7c3ae9ba4b61ead297fb3bb7ba7b27 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 09:20:20,205 truncating revision to first 12 chars 2016-04-19 09:20:20,205 Setting DEBUG logging. 2016-04-19 09:20:20,205 attempt 1/10 2016-04-19 09:20:20,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/73554a815d7c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 09:20:21,452 unpacking tar archive at: mozilla-aurora-73554a815d7c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.570264 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 09:20:21.305902) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:21.306286) ========= script_repo_revision: 73554a815d7c3ae9ba4b61ead297fb3bb7ba7b27 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:21.306725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:21.307046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 09:20:21.315949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-04-19 09:20:21.316269) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:20:21 INFO - MultiFileLogger online at 20160419 09:20:21 in /builds/slave/test 09:20:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:20:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:21 INFO - {'append_to_log': False, 09:20:21 INFO - 'base_work_dir': '/builds/slave/test', 09:20:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:20:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:21 INFO - 'branch': 'Mozilla-Aurora', 09:20:21 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:21 INFO - 'config_files': ('talos/linux_config.py',), 09:20:21 INFO - 'default_actions': ('clobber', 09:20:21 INFO - 'read-buildbot-config', 09:20:21 INFO - 'download-and-extract', 09:20:21 INFO - 'populate-webroot', 09:20:21 INFO - 'create-virtualenv', 09:20:21 INFO - 'install', 09:20:21 INFO - 'run-tests'), 09:20:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:21 INFO - 'download_minidump_stackwalk': True, 09:20:21 INFO - 'download_symbols': 'ondemand', 09:20:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:21 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:21 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:21 INFO - 'installer_path': 'installer.exe', 09:20:21 INFO - 'log_level': 'info', 09:20:21 INFO - 'log_name': 'talos', 09:20:21 INFO - 'log_to_console': True, 09:20:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:20:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:20:21 INFO - 'opt_config_files': (), 09:20:21 INFO - 'pip_index': False, 09:20:21 INFO - 'sps_profile': False, 09:20:21 INFO - 'sps_profile_interval': 0, 09:20:21 INFO - 'suite': 'dromaeojs', 09:20:21 INFO - 'system_bits': '32', 09:20:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:21 INFO - 'title': 'talos-linux64-ix-041', 09:20:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:21 INFO - 'use_talos_json': True, 09:20:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:21 INFO - 'work_dir': 'build'} 09:20:21 INFO - ##### 09:20:21 INFO - ##### Running clobber step. 09:20:21 INFO - ##### 09:20:21 INFO - Running pre-action listener: _resource_record_pre_action 09:20:21 INFO - Running main action method: clobber 09:20:21 INFO - rmtree: /builds/slave/test/build 09:20:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:22 INFO - Running post-action listener: _resource_record_post_action 09:20:22 INFO - ##### 09:20:22 INFO - ##### Running read-buildbot-config step. 09:20:22 INFO - ##### 09:20:22 INFO - Running pre-action listener: _resource_record_pre_action 09:20:22 INFO - Running main action method: read_buildbot_config 09:20:22 INFO - Using buildbot properties: 09:20:22 INFO - { 09:20:22 INFO - "project": "", 09:20:22 INFO - "product": "firefox", 09:20:22 INFO - "script_repo_revision": "production", 09:20:22 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:20:22 INFO - "repository": "", 09:20:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:20:22 INFO - "buildid": "20160419065801", 09:20:22 INFO - "pgo_build": "True", 09:20:22 INFO - "basedir": "/builds/slave/test", 09:20:22 INFO - "buildnumber": 270, 09:20:22 INFO - "slavename": "talos-linux64-ix-041", 09:20:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:20:22 INFO - "platform": "ubuntu64_hw", 09:20:22 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:20:22 INFO - "branch": "mozilla-aurora", 09:20:22 INFO - "repo_path": "releases/mozilla-aurora", 09:20:22 INFO - "revision": "73554a815d7c3ae9ba4b61ead297fb3bb7ba7b27", 09:20:22 INFO - "stage_platform": "linux64-pgo", 09:20:22 INFO - "builduid": "7bbf17b5fd5d4b86957d66328dc335f8", 09:20:22 INFO - "slavebuilddir": "test" 09:20:22 INFO - } 09:20:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:20:22 INFO - Running post-action listener: _resource_record_post_action 09:20:22 INFO - ##### 09:20:22 INFO - ##### Running download-and-extract step. 09:20:22 INFO - ##### 09:20:22 INFO - Running pre-action listener: _resource_record_pre_action 09:20:22 INFO - Running main action method: download_and_extract 09:20:22 INFO - mkdir: /builds/slave/test/build/tests 09:20:22 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')]} 09:20:22 INFO - https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:20:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:20:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:20:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:20:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:20:26 INFO - Downloaded 1448 bytes. 09:20:26 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:20:26 INFO - Using the following test package requirements: 09:20:26 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:20:26 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:26 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:20:26 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:26 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:20:26 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:26 INFO - u'jsshell-linux-x86_64.zip'], 09:20:26 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:26 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:20:26 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:20:26 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:26 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:20:26 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:26 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:20:26 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:26 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:20:26 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:20:26 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:20:26 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:20:26 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:20:26 INFO - https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:20:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:20:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:20:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:06 INFO - Downloaded 23351970 bytes. 09:21:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:21:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:21:07 INFO - Return code: 0 09:21:07 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:21:07 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')]} 09:21:07 INFO - https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:21:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:21:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:21:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:18 INFO - Downloaded 23351970 bytes. 09:21:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:21:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:21:19 INFO - Return code: 0 09:21:19 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')]} 09:21:19 INFO - https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:21:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:21:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:21:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:21:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:21:37 INFO - Downloaded 10845168 bytes. 09:21:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:21:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:21:37 INFO - Return code: 0 09:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:21:37 INFO - https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:22:04 INFO - Downloaded 60602149 bytes. 09:22:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:22:04 INFO - mkdir: /builds/slave/test/properties 09:22:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:22:04 INFO - Writing to file /builds/slave/test/properties/build_url 09:22:04 INFO - Contents: 09:22:04 INFO - build_url:https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:22:05 INFO - Running post-action listener: _resource_record_post_action 09:22:05 INFO - Running post-action listener: set_extra_try_arguments 09:22:05 INFO - ##### 09:22:05 INFO - ##### Running populate-webroot step. 09:22:05 INFO - ##### 09:22:05 INFO - Running pre-action listener: _resource_record_pre_action 09:22:05 INFO - Running main action method: populate_webroot 09:22:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:22:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:22:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:22:05 INFO - '--tppagecycles', 09:22:05 INFO - '7'], 09:22:05 INFO - 'tests': ['tsvgm']}}, 09:22:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:22:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:22:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:22:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:22:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:22:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:22:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:05 INFO - 'talos_options': ['--e10s'], 09:22:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:05 INFO - 'tests': ['damp', 'tps']}, 09:22:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:05 INFO - 'talos_options': ['--e10s'], 09:22:05 INFO - 'tests': ['damp', 'tps']}, 09:22:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:22:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:22:05 INFO - 'other': {'tests': ['a11yr', 09:22:05 INFO - 'ts_paint', 09:22:05 INFO - 'tpaint', 09:22:05 INFO - 'sessionrestore', 09:22:05 INFO - 'sessionrestore_no_auto_restore', 09:22:05 INFO - 'tabpaint']}, 09:22:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:22:05 INFO - 'tests': ['a11yr', 09:22:05 INFO - 'ts_paint', 09:22:05 INFO - 'tpaint', 09:22:05 INFO - 'sessionrestore', 09:22:05 INFO - 'sessionrestore_no_auto_restore', 09:22:05 INFO - 'tabpaint']}, 09:22:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:22:05 INFO - 'tests': ['a11yr', 09:22:05 INFO - 'ts_paint', 09:22:05 INFO - 'tpaint', 09:22:05 INFO - 'sessionrestore', 09:22:05 INFO - 'sessionrestore_no_auto_restore', 09:22:05 INFO - 'tabpaint']}, 09:22:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:22:05 INFO - 'tests': ['a11yr', 09:22:05 INFO - 'ts_paint', 09:22:05 INFO - 'tpaint', 09:22:05 INFO - 'sessionrestore', 09:22:05 INFO - 'sessionrestore_no_auto_restore', 09:22:05 INFO - 'tabpaint']}, 09:22:05 INFO - 'other_l64': {'tests': ['a11yr', 09:22:05 INFO - 'ts_paint', 09:22:05 INFO - 'tpaint', 09:22:05 INFO - 'sessionrestore', 09:22:05 INFO - 'sessionrestore_no_auto_restore', 09:22:05 INFO - 'tabpaint']}, 09:22:05 INFO - 'other_nol64': {'tests': ['a11yr', 09:22:05 INFO - 'ts_paint', 09:22:05 INFO - 'tpaint', 09:22:05 INFO - 'sessionrestore', 09:22:05 INFO - 'sessionrestore_no_auto_restore', 09:22:05 INFO - 'tabpaint']}, 09:22:05 INFO - 'svgr': {'tests': ['tsvgx', 09:22:05 INFO - 'tsvgr_opacity', 09:22:05 INFO - 'tart', 09:22:05 INFO - 'tscrollx', 09:22:05 INFO - 'cart']}, 09:22:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:22:05 INFO - 'tests': ['tsvgx', 09:22:05 INFO - 'tsvgr_opacity', 09:22:05 INFO - 'tart', 09:22:05 INFO - 'tscrollx', 09:22:05 INFO - 'cart']}, 09:22:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:05 INFO - 'tests': ['tp5o']}, 09:22:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:05 INFO - 'talos_options': ['--e10s'], 09:22:05 INFO - 'tests': ['tp5o']}, 09:22:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:05 INFO - 'talos_options': ['--xperf_path', 09:22:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:05 INFO - 'tests': ['tp5n']}, 09:22:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:05 INFO - 'talos_options': ['--e10s', 09:22:05 INFO - '--xperf_path', 09:22:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:05 INFO - 'tests': ['tp5n']}}, 09:22:05 INFO - 'talos.zip': {'path': '', 09:22:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:22:05 INFO - Running post-action listener: _resource_record_post_action 09:22:05 INFO - ##### 09:22:05 INFO - ##### Running create-virtualenv step. 09:22:05 INFO - ##### 09:22:05 INFO - Running pre-action listener: _resource_record_pre_action 09:22:05 INFO - Running main action method: create_virtualenv 09:22:05 INFO - Creating virtualenv /builds/slave/test/build/venv 09:22:05 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 09:22:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:22:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:22:05 INFO - Using real prefix '/usr' 09:22:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:22:05 INFO - Installing distribute.............................................................................................................................................................................................done. 09:22:07 INFO - Installing pip.................done. 09:22:07 INFO - Return code: 0 09:22:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:22:07 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')]} 09:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:07 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')]} 09:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:07 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 0x7fed517caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', '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 09:22:07 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 09:22:07 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 09:22:07 INFO - Using env: {'DISPLAY': ':0', 09:22:07 INFO - 'HOME': '/home/cltbld', 09:22:07 INFO - 'LANG': 'en_US.UTF-8', 09:22:07 INFO - 'LANGUAGE': 'en_US:en', 09:22:07 INFO - 'LOGNAME': 'cltbld', 09:22:07 INFO - 'MAIL': '/var/mail/cltbld', 09:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:07 INFO - 'MOZ_NO_REMOTE': '1', 09:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:07 INFO - 'NO_EM_RESTART': '1', 09:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:07 INFO - 'PWD': '/builds/slave/test', 09:22:07 INFO - 'SHELL': '/bin/bash', 09:22:07 INFO - 'SHLVL': '1', 09:22:07 INFO - 'TERM': 'linux', 09:22:07 INFO - 'TMOUT': '86400', 09:22:07 INFO - 'USER': 'cltbld', 09:22:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:07 INFO - '_': '/tools/buildbot/bin/python'} 09:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:08 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 09:22:08 INFO - Cleaning up... 09:22:08 INFO - Return code: 0 09:22:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:22:08 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')]} 09:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:08 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')]} 09:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:08 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed517caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', '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 09:22:08 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>=0.7.1'] in /builds/slave/test/build 09:22:08 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>=0.7.1 09:22:08 INFO - Using env: {'DISPLAY': ':0', 09:22:08 INFO - 'HOME': '/home/cltbld', 09:22:08 INFO - 'LANG': 'en_US.UTF-8', 09:22:08 INFO - 'LANGUAGE': 'en_US:en', 09:22:08 INFO - 'LOGNAME': 'cltbld', 09:22:08 INFO - 'MAIL': '/var/mail/cltbld', 09:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:08 INFO - 'MOZ_NO_REMOTE': '1', 09:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:08 INFO - 'NO_EM_RESTART': '1', 09:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:08 INFO - 'PWD': '/builds/slave/test', 09:22:08 INFO - 'SHELL': '/bin/bash', 09:22:08 INFO - 'SHLVL': '1', 09:22:08 INFO - 'TERM': 'linux', 09:22:08 INFO - 'TMOUT': '86400', 09:22:08 INFO - 'USER': 'cltbld', 09:22:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:08 INFO - '_': '/tools/buildbot/bin/python'} 09:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:08 INFO - Downloading/unpacking psutil>=0.7.1 09:22:08 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 09:22:08 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 09:22:08 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 09:22:08 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 09:22:08 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 09:22:08 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 09:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:22:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:10 INFO - Installing collected packages: psutil 09:22:10 INFO - Running setup.py install for psutil 09:22:10 INFO - building 'psutil._psutil_linux' extension 09:22:10 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 09:22:10 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 09:22:10 INFO - building 'psutil._psutil_posix' extension 09:22:10 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 09:22:10 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 09:22:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:10 INFO - Successfully installed psutil 09:22:10 INFO - Cleaning up... 09:22:10 INFO - Return code: 0 09:22:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:10 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed517caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', '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 09:22:10 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.0.0'] in /builds/slave/test/build 09:22:10 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.0.0 09:22:10 INFO - Using env: {'DISPLAY': ':0', 09:22:10 INFO - 'HOME': '/home/cltbld', 09:22:10 INFO - 'LANG': 'en_US.UTF-8', 09:22:10 INFO - 'LANGUAGE': 'en_US:en', 09:22:10 INFO - 'LOGNAME': 'cltbld', 09:22:10 INFO - 'MAIL': '/var/mail/cltbld', 09:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:10 INFO - 'MOZ_NO_REMOTE': '1', 09:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:10 INFO - 'NO_EM_RESTART': '1', 09:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:10 INFO - 'PWD': '/builds/slave/test', 09:22:10 INFO - 'SHELL': '/bin/bash', 09:22:10 INFO - 'SHLVL': '1', 09:22:10 INFO - 'TERM': 'linux', 09:22:10 INFO - 'TMOUT': '86400', 09:22:10 INFO - 'USER': 'cltbld', 09:22:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:10 INFO - '_': '/tools/buildbot/bin/python'} 09:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:22:10 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 09:22:10 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 09:22:10 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 09:22:10 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 09:22:10 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 09:22:10 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 09:22:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:22:13 INFO - Installing collected packages: mozsystemmonitor 09:22:13 INFO - Running setup.py install for mozsystemmonitor 09:22:13 INFO - Successfully installed mozsystemmonitor 09:22:13 INFO - Cleaning up... 09:22:13 INFO - Return code: 0 09:22:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:22: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')]} 09:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:13 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 0x7fed517caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', '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 09:22:13 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 09:22:13 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 09:22:13 INFO - Using env: {'DISPLAY': ':0', 09:22:13 INFO - 'HOME': '/home/cltbld', 09:22:13 INFO - 'LANG': 'en_US.UTF-8', 09:22:13 INFO - 'LANGUAGE': 'en_US:en', 09:22:13 INFO - 'LOGNAME': 'cltbld', 09:22:13 INFO - 'MAIL': '/var/mail/cltbld', 09:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:13 INFO - 'MOZ_NO_REMOTE': '1', 09:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:13 INFO - 'NO_EM_RESTART': '1', 09:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:13 INFO - 'PWD': '/builds/slave/test', 09:22:13 INFO - 'SHELL': '/bin/bash', 09:22:13 INFO - 'SHLVL': '1', 09:22:13 INFO - 'TERM': 'linux', 09:22:13 INFO - 'TMOUT': '86400', 09:22:13 INFO - 'USER': 'cltbld', 09:22:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:13 INFO - '_': '/tools/buildbot/bin/python'} 09:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:22:13 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 09:22:13 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 09:22:13 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 09:22:13 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 09:22:13 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 09:22:13 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 09:22:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:22:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:22:15 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 09:22:15 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 09:22:15 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 09:22:15 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 09:22:15 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 09:22:15 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 09:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:22:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:22:15 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 09:22:15 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 09:22:15 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 09:22:15 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 09:22:15 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 09:22:15 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 09:22:15 INFO - Downloading docopt-0.6.1.tar.gz 09:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:22:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:22:15 INFO - Running setup.py install for blobuploader 09:22:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:22:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:22:16 INFO - Running setup.py install for requests 09:22:16 INFO - Running setup.py install for docopt 09:22:16 INFO - Successfully installed blobuploader requests docopt 09:22:16 INFO - Cleaning up... 09:22:16 INFO - Return code: 0 09:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:16 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')]} 09:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:16 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')]} 09:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:16 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 0x7fed517caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', '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 09:22:16 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 09:22:16 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 09:22:16 INFO - Using env: {'DISPLAY': ':0', 09:22:16 INFO - 'HOME': '/home/cltbld', 09:22:16 INFO - 'LANG': 'en_US.UTF-8', 09:22:16 INFO - 'LANGUAGE': 'en_US:en', 09:22:16 INFO - 'LOGNAME': 'cltbld', 09:22:16 INFO - 'MAIL': '/var/mail/cltbld', 09:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:16 INFO - 'MOZ_NO_REMOTE': '1', 09:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:16 INFO - 'NO_EM_RESTART': '1', 09:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:16 INFO - 'PWD': '/builds/slave/test', 09:22:16 INFO - 'SHELL': '/bin/bash', 09:22:16 INFO - 'SHLVL': '1', 09:22:16 INFO - 'TERM': 'linux', 09:22:16 INFO - 'TMOUT': '86400', 09:22:16 INFO - 'USER': 'cltbld', 09:22:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:16 INFO - '_': '/tools/buildbot/bin/python'} 09:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:16 INFO - Running setup.py (path:/tmp/pip-obVASN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:16 INFO - Running setup.py (path:/tmp/pip-Nk89fA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:16 INFO - Running setup.py (path:/tmp/pip-R9Tj_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:17 INFO - Running setup.py (path:/tmp/pip-NKfdjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:17 INFO - Running setup.py (path:/tmp/pip-wS1Dpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:17 INFO - Running setup.py (path:/tmp/pip-kORO9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:17 INFO - Running setup.py (path:/tmp/pip-Rrxfu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:17 INFO - Running setup.py (path:/tmp/pip-YvaXtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:17 INFO - Running setup.py (path:/tmp/pip-20hKDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:17 INFO - Running setup.py (path:/tmp/pip-awhZ0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:17 INFO - Running setup.py (path:/tmp/pip-wOyCDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:17 INFO - Running setup.py (path:/tmp/pip-3Cm2kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:17 INFO - Running setup.py (path:/tmp/pip-Cj2XJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:17 INFO - Running setup.py (path:/tmp/pip-DftuuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:17 INFO - Running setup.py (path:/tmp/pip-t3wH7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:17 INFO - Running setup.py (path:/tmp/pip-jElUU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:17 INFO - Running setup.py (path:/tmp/pip-clK6Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:22:17 INFO - Running setup.py install for manifestparser 09:22:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:22:18 INFO - Running setup.py install for mozcrash 09:22:18 INFO - Running setup.py install for mozdebug 09:22:18 INFO - Running setup.py install for mozdevice 09:22:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:22:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:22:18 INFO - Running setup.py install for mozfile 09:22:18 INFO - Running setup.py install for mozhttpd 09:22:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:22:18 INFO - Running setup.py install for mozinfo 09:22:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:22:18 INFO - Running setup.py install for mozInstall 09:22:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:22:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:22:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:22:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:22:18 INFO - Running setup.py install for mozleak 09:22:18 INFO - Running setup.py install for mozlog 09:22:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:22:19 INFO - Running setup.py install for moznetwork 09:22:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:22:19 INFO - Running setup.py install for mozprocess 09:22:19 INFO - Running setup.py install for mozprofile 09:22:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:22:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:22:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:22:19 INFO - Running setup.py install for mozrunner 09:22:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:22:19 INFO - Running setup.py install for mozscreenshot 09:22:19 INFO - Running setup.py install for moztest 09:22:19 INFO - Running setup.py install for mozversion 09:22:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:22:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:22:19 INFO - Cleaning up... 09:22:19 INFO - Return code: 0 09:22:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:19 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')]} 09:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:19 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')]} 09:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:19 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 0x7fed517caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', '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 09:22:19 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 09:22:19 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 09:22:19 INFO - Using env: {'DISPLAY': ':0', 09:22:19 INFO - 'HOME': '/home/cltbld', 09:22:19 INFO - 'LANG': 'en_US.UTF-8', 09:22:19 INFO - 'LANGUAGE': 'en_US:en', 09:22:19 INFO - 'LOGNAME': 'cltbld', 09:22:19 INFO - 'MAIL': '/var/mail/cltbld', 09:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:19 INFO - 'MOZ_NO_REMOTE': '1', 09:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:19 INFO - 'NO_EM_RESTART': '1', 09:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:19 INFO - 'PWD': '/builds/slave/test', 09:22:19 INFO - 'SHELL': '/bin/bash', 09:22:19 INFO - 'SHLVL': '1', 09:22:19 INFO - 'TERM': 'linux', 09:22:19 INFO - 'TMOUT': '86400', 09:22:19 INFO - 'USER': 'cltbld', 09:22:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:19 INFO - '_': '/tools/buildbot/bin/python'} 09:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:19 INFO - Running setup.py (path:/tmp/pip-fO5WWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:20 INFO - Running setup.py (path:/tmp/pip-_yGx_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:20 INFO - Running setup.py (path:/tmp/pip-DRIF08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:20 INFO - Running setup.py (path:/tmp/pip-syX0gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:20 INFO - Running setup.py (path:/tmp/pip-xptfJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:20 INFO - Running setup.py (path:/tmp/pip-0bxBS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:20 INFO - Running setup.py (path:/tmp/pip-GF7XBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:20 INFO - Running setup.py (path:/tmp/pip-p9H4QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:20 INFO - Running setup.py (path:/tmp/pip-swOHsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:20 INFO - Running setup.py (path:/tmp/pip-9PDusl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:20 INFO - Running setup.py (path:/tmp/pip-cxTJpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:20 INFO - Running setup.py (path:/tmp/pip-3ffvjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:20 INFO - Running setup.py (path:/tmp/pip-zIpBFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:20 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)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:20 INFO - Running setup.py (path:/tmp/pip-k2Dwro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:20 INFO - Running setup.py (path:/tmp/pip-PLYnKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:21 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)) 09:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:21 INFO - Running setup.py (path:/tmp/pip-1IjCCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:21 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)) 09:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:21 INFO - Running setup.py (path:/tmp/pip-A8FF82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:21 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)) 09:22:21 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)) 09:22:21 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)) 09:22:21 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)) 09:22:21 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)) 09:22:21 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)) 09:22:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:22:21 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 09:22:21 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 09:22:21 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 09:22:21 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 09:22:21 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 09:22:21 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 09:22:23 INFO - Downloading blessings-1.6.tar.gz 09:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:22:23 INFO - Installing collected packages: blessings 09:22:23 INFO - Running setup.py install for blessings 09:22:23 INFO - Successfully installed blessings 09:22:23 INFO - Cleaning up... 09:22:23 INFO - Return code: 0 09:22:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:22:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:23 INFO - Reading from file tmpfile_stdout 09:22:23 INFO - Current package versions: 09:22:23 INFO - argparse == 1.2.1 09:22:23 INFO - blessings == 1.6 09:22:23 INFO - blobuploader == 1.2.4 09:22:23 INFO - docopt == 0.6.1 09:22:23 INFO - manifestparser == 1.1 09:22:23 INFO - mozInstall == 1.12 09:22:23 INFO - mozcrash == 0.17 09:22:23 INFO - mozdebug == 0.1 09:22:23 INFO - mozdevice == 0.48 09:22:23 INFO - mozfile == 1.2 09:22:23 INFO - mozhttpd == 0.7 09:22:23 INFO - mozinfo == 0.9 09:22:23 INFO - mozleak == 0.1 09:22:23 INFO - mozlog == 3.1 09:22:23 INFO - moznetwork == 0.27 09:22:23 INFO - mozprocess == 0.22 09:22:23 INFO - mozprofile == 0.28 09:22:23 INFO - mozrunner == 6.11 09:22:23 INFO - mozscreenshot == 0.1 09:22:23 INFO - mozsystemmonitor == 0.0 09:22:23 INFO - moztest == 0.7 09:22:23 INFO - mozversion == 1.4 09:22:23 INFO - psutil == 3.1.1 09:22:23 INFO - requests == 1.2.3 09:22:23 INFO - wsgiref == 0.1.2 09:22:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22: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')]} 09:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:23 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 0x7fed517caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', '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 09:22:23 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 09:22:23 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 09:22:23 INFO - Using env: {'DISPLAY': ':0', 09:22:23 INFO - 'HOME': '/home/cltbld', 09:22:23 INFO - 'LANG': 'en_US.UTF-8', 09:22:23 INFO - 'LANGUAGE': 'en_US:en', 09:22:23 INFO - 'LOGNAME': 'cltbld', 09:22:23 INFO - 'MAIL': '/var/mail/cltbld', 09:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:23 INFO - 'MOZ_NO_REMOTE': '1', 09:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:23 INFO - 'NO_EM_RESTART': '1', 09:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:23 INFO - 'PWD': '/builds/slave/test', 09:22:23 INFO - 'SHELL': '/bin/bash', 09:22:23 INFO - 'SHLVL': '1', 09:22:23 INFO - 'TERM': 'linux', 09:22:23 INFO - 'TMOUT': '86400', 09:22:23 INFO - 'USER': 'cltbld', 09:22:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:23 INFO - '_': '/tools/buildbot/bin/python'} 09:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:23 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)) 09:22:23 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)) 09:22:23 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)) 09:22:23 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)) 09:22:23 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)) 09:22:23 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)) 09:22:23 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)) 09:22:23 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)) 09:22:23 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)) 09:22:23 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)) 09:22:23 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)) 09:22:23 INFO - Cleaning up... 09:22:23 INFO - Return code: 0 09:22:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:22: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')]} 09:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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')]} 09:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:23 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 0x7fed517caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', '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 09:22:23 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 09:22:23 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 09:22:23 INFO - Using env: {'DISPLAY': ':0', 09:22:23 INFO - 'HOME': '/home/cltbld', 09:22:23 INFO - 'LANG': 'en_US.UTF-8', 09:22:23 INFO - 'LANGUAGE': 'en_US:en', 09:22:23 INFO - 'LOGNAME': 'cltbld', 09:22:23 INFO - 'MAIL': '/var/mail/cltbld', 09:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:23 INFO - 'MOZ_NO_REMOTE': '1', 09:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:23 INFO - 'NO_EM_RESTART': '1', 09:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:23 INFO - 'PWD': '/builds/slave/test', 09:22:23 INFO - 'SHELL': '/bin/bash', 09:22:23 INFO - 'SHLVL': '1', 09:22:23 INFO - 'TERM': 'linux', 09:22:23 INFO - 'TMOUT': '86400', 09:22:23 INFO - 'USER': 'cltbld', 09:22:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:23 INFO - '_': '/tools/buildbot/bin/python'} 09:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:23 INFO - Downloading/unpacking jsonschema 09:22:23 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 09:22:23 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 09:22:23 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 09:22:23 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 09:22:23 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 09:22:23 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 09:22:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:22:25 INFO - Downloading/unpacking functools32 (from jsonschema) 09:22:25 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 09:22:25 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 09:22:25 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 09:22:25 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 09:22:25 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 09:22:25 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 09:22:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:22:26 INFO - warning: no files found matching '*.txt' 09:22:26 INFO - no previously-included directories found matching 'build' 09:22:26 INFO - no previously-included directories found matching 'dist' 09:22:26 INFO - no previously-included directories found matching '.git*' 09:22:26 INFO - Installing collected packages: jsonschema, functools32 09:22:26 INFO - Running setup.py install for functools32 09:22:26 INFO - warning: no files found matching '*.txt' 09:22:26 INFO - no previously-included directories found matching 'build' 09:22:26 INFO - no previously-included directories found matching 'dist' 09:22:26 INFO - no previously-included directories found matching '.git*' 09:22:26 INFO - Successfully installed jsonschema functools32 09:22:26 INFO - Cleaning up... 09:22:26 INFO - Return code: 0 09:22:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:26 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 0x7fed517caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', '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 09:22:26 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 09:22:26 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 09:22:26 INFO - Using env: {'DISPLAY': ':0', 09:22:26 INFO - 'HOME': '/home/cltbld', 09:22:26 INFO - 'LANG': 'en_US.UTF-8', 09:22:26 INFO - 'LANGUAGE': 'en_US:en', 09:22:26 INFO - 'LOGNAME': 'cltbld', 09:22:26 INFO - 'MAIL': '/var/mail/cltbld', 09:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:26 INFO - 'MOZ_NO_REMOTE': '1', 09:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:26 INFO - 'NO_EM_RESTART': '1', 09:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:26 INFO - 'PWD': '/builds/slave/test', 09:22:26 INFO - 'SHELL': '/bin/bash', 09:22:26 INFO - 'SHLVL': '1', 09:22:26 INFO - 'TERM': 'linux', 09:22:26 INFO - 'TMOUT': '86400', 09:22:26 INFO - 'USER': 'cltbld', 09:22:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:26 INFO - '_': '/tools/buildbot/bin/python'} 09:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:26 INFO - Downloading/unpacking flake8 09:22:26 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 09:22:26 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 09:22:26 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 09:22:26 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 09:22:26 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 09:22:26 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 09:22:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:22:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:22:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 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 09:22:28 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 09:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:29 INFO - no previously-included directories found matching 'docs/_build' 09:22:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:22:29 INFO - Running setup.py install for pep8 09:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:29 INFO - no previously-included directories found matching 'docs/_build' 09:22:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:22:29 INFO - Cleaning up... 09:22:29 INFO - Return code: 0 09:22:29 INFO - Running post-action listener: _resource_record_post_action 09:22:29 INFO - Running post-action listener: _start_resource_monitoring 09:22:29 INFO - Starting resource monitoring. 09:22:29 INFO - ##### 09:22:29 INFO - ##### Running install step. 09:22:29 INFO - ##### 09:22:29 INFO - Running pre-action listener: _resource_record_pre_action 09:22:29 INFO - Running main action method: install 09:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:29 INFO - Reading from file tmpfile_stdout 09:22:29 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:22:29 INFO - Reading from file tmpfile_stdout 09:22:29 INFO - Output received: 09:22:29 INFO - Usage: mozinstall [options] installer 09:22:29 INFO - Options: 09:22:29 INFO - -h, --help show this help message and exit 09:22:29 INFO - -d DEST, --destination=DEST 09:22:29 INFO - Directory to install application into. [default: 09:22:29 INFO - "/builds/slave/test"] 09:22:29 INFO - --app=APP Application being installed. [default: firefox] 09:22:29 INFO - mkdir: /builds/slave/test/build/application 09:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:22:44 INFO - Reading from file tmpfile_stdout 09:22:44 INFO - Output received: 09:22:44 INFO - /builds/slave/test/build/application/firefox/firefox 09:22:44 INFO - Running post-action listener: _resource_record_post_action 09:22:44 INFO - ##### 09:22:44 INFO - ##### Running run-tests step. 09:22:44 INFO - ##### 09:22:44 INFO - Running pre-action listener: _resource_record_pre_action 09:22:44 INFO - Running main action method: run_tests 09:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:44 INFO - Python 2.7.3 09:22:44 INFO - Return code: 0 09:22:44 INFO - grabbing minidump binary from tooltool 09:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:44 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985160>, '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 0x2986060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29864f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:44 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 09:22:44 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 09:22:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:44 INFO - Return code: 0 09:22:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:22:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:22:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:22:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:22:45 INFO - Return code: 0 09:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:22:45 INFO - Using env: {'DISPLAY': ':0', 09:22:45 INFO - 'HOME': '/home/cltbld', 09:22:45 INFO - 'LANG': 'en_US.UTF-8', 09:22:45 INFO - 'LANGUAGE': 'en_US:en', 09:22:45 INFO - 'LOGNAME': 'cltbld', 09:22:45 INFO - 'MAIL': '/var/mail/cltbld', 09:22:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:45 INFO - 'MOZ_NO_REMOTE': '1', 09:22:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:45 INFO - 'NO_EM_RESTART': '1', 09:22:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:45 INFO - 'PWD': '/builds/slave/test', 09:22:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:45 INFO - 'SHELL': '/bin/bash', 09:22:45 INFO - 'SHLVL': '1', 09:22:45 INFO - 'TERM': 'linux', 09:22:45 INFO - 'TMOUT': '86400', 09:22:45 INFO - 'USER': 'cltbld', 09:22:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059', 09:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:45 INFO - '_': '/tools/buildbot/bin/python'} 09:22:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:22:46 INFO - mozversion application_buildid: 20160419065801 09:22:46 INFO - mozversion application_changeset: 73554a815d7c3ae9ba4b61ead297fb3bb7ba7b27 09:22:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:22:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:46 INFO - mozversion application_name: Firefox 09:22:46 INFO - mozversion application_remotingname: firefox-dev 09:22:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:22:46 INFO - mozversion application_vendor: Mozilla 09:22:46 INFO - mozversion application_version: 47.0a2 09:22:46 INFO - mozversion platform_buildid: 20160419065801 09:22:46 INFO - mozversion platform_changeset: 73554a815d7c3ae9ba4b61ead297fb3bb7ba7b27 09:22:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:22:46 INFO - mozversion platform_version: 47.0a2 09:22:46 INFO - using testdate: 1461082966 09:22:46 INFO - actual date: 1461082966 09:22:46 INFO - starting webserver on 'localhost:41299' 09:22:46 INFO - SUITE-START | Running 2 tests 09:22:46 INFO - TEST-START | dromaeo_css 09:22:46 INFO - operating with platform_type : linux_ 09:22:46 INFO - Initialising browser for dromaeo_css test... 09:22:46 INFO - TEST-INFO | started process 26821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmY0LeW/profile http://localhost:41299/getInfo.html) 09:22:50 INFO - PROCESS | 26821 | __metrics Screen width/height:1600/1200 09:22:50 INFO - PROCESS | 26821 | colorDepth:24 09:22:50 INFO - PROCESS | 26821 | Browser inner width/height: 1024/697 09:22:50 INFO - PROCESS | 26821 | __metrics 09:22:51 INFO - PROCESS | 26821 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:52 INFO - TEST-INFO | 26821: exit 0 09:22:52 INFO - Browser initialized. 09:22:52 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:52 INFO - TEST-INFO | started process 26913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmY0LeW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:04 INFO - PROCESS | 26913 | RSS: Main: 141230080 09:23:04 INFO - PROCESS | 26913 | 09:23:55 INFO - PROCESS | 26913 | 1461083035335 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] 09:26:03 INFO - PROCESS | 26913 | Cycle 1(1): loaded http://localhost:41299/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41299/tests/dromaeo/cssquery-ext.html) 09:26:04 INFO - PROCESS | 26913 | RSS: Main: 249507840 09:26:04 INFO - PROCESS | 26913 | 09:29:06 INFO - PROCESS | 26913 | Cycle 1(1): loaded http://localhost:41299/tests/dromaeo/cssquery-ext.html (next: http://localhost:41299/tests/dromaeo/cssquery-jquery.html) 09:29:07 INFO - PROCESS | 26913 | RSS: Main: 225001472 09:29:07 INFO - PROCESS | 26913 | 09:32:09 INFO - PROCESS | 26913 | Cycle 1(1): loaded http://localhost:41299/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41299/tests/dromaeo/cssquery-mootools.html) 09:32:09 INFO - PROCESS | 26913 | RSS: Main: 214712320 09:32:09 INFO - PROCESS | 26913 | 09:35:11 INFO - PROCESS | 26913 | Cycle 1(1): loaded http://localhost:41299/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41299/tests/dromaeo/cssquery-prototype.html) 09:35:12 INFO - PROCESS | 26913 | RSS: Main: 191377408 09:35:12 INFO - PROCESS | 26913 | 09:38:14 INFO - PROCESS | 26913 | Cycle 1(1): loaded http://localhost:41299/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41299/tests/dromaeo/cssquery-yui.html) 09:38:15 INFO - PROCESS | 26913 | RSS: Main: 203829248 09:38:15 INFO - PROCESS | 26913 | 09:41:17 INFO - PROCESS | 26913 | Cycle 1(1): loaded http://localhost:41299/tests/dromaeo/cssquery-yui.html (next: http://localhost:41299/tests/dromaeo/cssquery-dojo.html) 09:41:17 INFO - PROCESS | 26913 | RSS: Main: 252174336 09:41:17 INFO - PROCESS | 26913 | 09:41:17 INFO - PROCESS | 26913 | __start_tp_report 09:41:17 INFO - PROCESS | 26913 | _x_x_mozilla_page_load 09:41:17 INFO - PROCESS | 26913 | _x_x_mozilla_page_load_details 09:41:17 INFO - PROCESS | 26913 | |i|pagename|runs| 09:41:17 INFO - PROCESS | 26913 | |0;dojo.html;3301.2242123101073;3340.7160391366733;3351.312980838928;3356.530085787989;3394.541736865523;5337.172738225577;5356.9196462053005;5359.973200133999;5377.139657654771;5391.81128660497;5334.973325133378;5365.03429382711;5389.434109418504;5389.5688344932405;5391.703456309901;4816.0608681306985;4894.706317620937;4908.067467181242;4908.460069392364;4983.053219888209;4874.341963834872;4893.755312234392;4953.257011448293;5041.319421878036;5086.542211200991;5019.397672279331;5103.591712662978;5108.3359163308905;5109;5117.334746482952;4963.329950456714;5021.096202683516;5030.547250747413;5040.873978150557;5047.116754567955;4795.328653988445;4855.053264613402;4926.433460152092;4937.012597480519;4940.827071052496;5331.813386531453;5354.678719276817;5357.116075847481;5361.035013697533;5368.516833484966;5888.676122813244;5903.085021821625;5905.055191169392;5906.940930590682;5920.822375328747;5739.225204597367;5917.615355001954;5975.940240597582;6014.789482368096;6023.879522409571;5491.341039075297;5492.423295553949;5493.23094766733;5493.313335833021;5499.642523235977;5799.217105690762;5919.378465261172;5974.671393073423;5977.103434484862;5994.1608174855555;5727.656340619493;5784.1902133701315;5784.479396854304;5807.245058142499;5815.098659707752;5890.087036509348;5902.085176797603;5910;5910.970445147746;5913.881722365529;5740.712964351766;5766.336871259775;5867.295924489089;5884.764609415661;5887.499562537232;5894.056950887923;5905.084711869667;5908.734106965197;5910.497607703307;5940.821775346746;4426.601605855424;4444.577765112309;4462.286034234572;4462.665300102505;4495.100979804052;3944.5660977292473;3965.7025723070883;4003.839846406111;4019.376996565537;4067.3695577185586;5603.831885043455;5621.016322143691;5625.128105143709;5625.521830644359;5637.379888212294;5920.674362910081;5930.762769489172;5955.642661440327;5958.731857066442;5960.0761881908375;5465.726713664301;5548.91676624851;5605.131204663284;5627.409122042209;5629.746661400247;5028.522290382408;5039.798408063636;5047.722375269395;5077.746112694351;5085.084684756705;6062.090686396988;6109.725062372204;6115.755369785248;6122.969385153046;6124.118392306737;5781.1328300754385;5955.344912059757;6005.099235114768;6018.458338749533;6043.425874541911;6144.354842741448;6151.231096112986;6152.969235153974;6179.104029915727;6186.969065154825;5646.576506761927;5860.912086318794;5877.265341832271;5879.617824841372;5881.3236477803885;5865.266841644794;5921.733521991607;5927.762889484545;5933.22868027171;5953.28560572734;5749.281339832521;5760.308762948473;5791.884162316815;5793.594448388741;5799.82600521985;5623.297087864017;5752.9137062943255;5773.191753154646;5780.132980052857;5784.5083167929515;5665.178549110438;5675.57433192504;5678.744456499385;5679.574031947538;5716.228309178207;5774.393688662798;5785.6817875015595;5786.363500014911;5788.363280039108;5788.392218817132;5545.889082218252;5618.85952851182;5670.092785154356;5700.201971723879;5718.685472298897 09:41:17 INFO - PROCESS | 26913 | |1;ext.html;554.9954582206204;562.5864989232914;565.2169719417036;586.1471558881827;630.5208041888163;38962.22075558491;39631.60368396315;39633.60366396335;39705.60294397055;39767;42260.36609450861;42877.14245715092;42937.78531107348;42947.78526107373;42960.35559466603;8839.16027977341;9029.322800789934;9045.140711632384;9055.95472022639;9056.184943355096;8941.284697224239;9094;9100.408473449237;9105.408148470327;9109.726708198765;9247.676331328405;9371.812563748721;9373.109554592304;9373.156415922565;9379.24966002718;9200.493972831491;9275.489848058354;9291.814163716756;9292.210162136227;9308.58111384986;9119;9249.6300147994;9268.119528644767;9278.35051546392;9279.164875161201;41878;42147.157056858996;42334.78832605848;42344.15311693749;42426.36360454596;3579.2125732338845;3625.800580968046;3659.5242618459697;3735.831887565039;3912.550056743454;29319;29505.704942950724;29795.55306670402;29828.254293642833;30101.849490752626;3812.3519001769487;3815.1606646537716;3831.4635950966886;3849.9807500962315;3886.7667939923695;219768;220747;221782;222246.88876555677;222805;45081.32378014332;45594.77202614032;66728.33271667318;66773;67368.3263167362;44041;44148.3377749334;44161;44187.77906110513;44188.55811441909;16995.150242487827;17044.14779261032;17173.914130429268;17196.570085747957;17215.56961075958;13944.302784860716;14050.297485125702;14052.227127508086;14052.789208161887;14054.086484378482;15184.164870932205;15647.452339168301;15647.68704625924;15650;15752.527424177293;5809.593328467051;5888.587798854125;5941.376155503696;6103.6032657877095;6164.291106522717;1031.3966329697212;1084.1110289562641;1114.403793970222;1136.1478890831877;1149.3965668024355;30314;30733.231669208002;30733.69266307353;30765.538516922265;30808.828644399935;1105.4141305108305;1142.7200335917587;1145.1297014269048;1196.8683444821063;1251.6745646132072;15618;15820;15934.681306373808;16136.193190340437;16167.757483637755;343061;514616;523746;524201;524447;53271.467285327424;53591;54266.99999999921;54344.72827635916;54347;1383.4120498787975;1494.1856688105008;1520.1335238913935;1520.6198450387403;1538.523057852047;28758.137255882357;29228.415431691672;29531;29867.55198672065;30268.84865575746;46756.766216168704;47528.287075694585;47531.76234118807;47555;47733.76133119312;226943;233231;234147;235319;235595;30234.84882575573;32847.67152328542;34327.31345373129;34367.48448773321;35203.82398087993;47270;47306.52693473021;47660.285095722895;47879.28181077217;48285.27572086492;39630.891680139284;39973.80013099916;40507;40783.1843363137;41231.58768412397;37971.240575188895;38618.80690596529;39406.60593394029;39986.200275994895;40266.597334026286;39655.80172099121;40486.392704110054;40915;41033.589664102976;41206.587934121475;35030.12424689403;36347.45478817767;36371.90884273476;36695.449568257034;36852.63147368492;27472.313192169557;27516.449671006067;27677.16968490868;28341.149765507067;28535.143945681662 09:41:17 INFO - PROCESS | 26913 | |2;jquery.html;354.32677911967266;365.3843274083172;371.10563541864116;372.46923134533284;374.63473113714116;17375.565610859736;18115.275388984443;18178.818211817877;18431.447056588324;18435.631287374243;16814.15929203541;17359.652806943886;17499.300027998896;17523.824761752378;17528.912355438206;5426.186072089188;5659;5705.5435565154685;5712.942870571283;5718.513926316268;4219.873403797891;5550.333959924815;5872.412758724136;6119.0209566469375;6138.478229350489;6095.481884039862;6096.542759293048;6105.175801266839;6121.908171377433;6127.754889804402;5868.178455016301;6056.788012419544;6057.454829065361;6080.817575472721;6082.270127584696;3818.1409182933617;5169.715665638389;5349.43830897754;5397.028534863763;5398.865028374283;20523.692144617842;20999.47501312464;21055.263065792777;21337;21338.359849204393;2190.6823510591034;2243.349428665685;2274.2722328854775;2543.682039745032;2653.4162484253625;13519.729605407934;13692.589222323346;13826;13991;14065.85934140666;1804.2422182683304;1867.2344338821154;1867.9813201867944;1898.1648074847024;1940.2045161483725;60775.08837367443;60903.39096609021;61174;62354.688226558574;62507;9085.682001129928;9332.39339442934;9851.704448866401;9927.602895884083;10049.849252261221;13776.724465510833;13954;13957.860421395657;13974.301284935917;14002.299885005708;8014.839703205903;8125.268725814705;8141.267285944294;8159.918400815915;8220.917790822135;8094.878576821352;8139.511629302261;8221.671133154727;8234.835303293901;8254.174582541818;6059.151718759377;6069.544784141207;6113.877722445615;6146.108814221912;6173.506119510428;1705.6332888429047;1734.5056658852166;1817.1277786662477;1864.2636158717503;1865.1628146275907;1004.4575928998405;1047.2145890582065;1078.5308390850005;1096.0628662493452;1144.8797876222877;16780.160991950353;17071;17147.971121732735;17221.7416738749;17656.82343176552;1017.6133069433567;1018.6434747838346;1027.1833892055834;1047.3925123428394;1111.1222134513805;10369.9481502592;10424.322419042737;10582.417967011888;10629.4153821539;10830.350178989285;456271;458200;461748;463603;465344;62283;65049;66445;66834.66582667152;67445;1075.736444571085;1079.3523885668692;1094.7591529863416;1105.1324710102692;1112.6161474291357;16047.117408542643;16238.431654892021;16306.918465407596;16408.507744767678;16425.17874106266;31977.520337195427;32013.199670008435;33411.33177336488;33548.49677254892;34098;38102.61897381102;40388.79805601071;46437;46546.53453465422;47118.52881471279;7693.615319233904;8144.185581441809;8652.956735216536;8837.160469755363;8885.022647508898;12663.746725065632;12677.619671409873;12975.675608109495;12994.415251313903;13139.73720525565;10887.237893347707;11299.265547739371;11346.432678366215;11374.317540947239;11389.544418223179;10940.12479001662;11102.44487775592;11147.888521114684;11421.486033128695;11502.82745758831;11284.661460156209;11548.307101573933;11599.710007249549;11760.294382337088;12226.75546489083;8482.066972633129;8498.235158835734;8540.871886921825;8678.78303042429;8734.213920747163;9161.312901532545;11102.666919992413;11466.598669046543;11531.481083351437;11951.701207469883 09:41:17 INFO - PROCESS | 26913 | |3;mootools.html;1456.4538298138198;1594.8644365228954;1624.886257961943;1898.126861643644;2002.6995950607406;8256.876146857794;8499.447535910169;8523.57382130894;8526.786830329238;8528.829423411527;8452.239298463137;8605.870911936327;8608.440451370656;8613.569321533914;8618.052014278424;2083.8124568788808;2430.234476140019;2439.853608783474;2467.1734968785477;2488.601823708207;2445.6576079348906;2461.9753802461923;2468.938276543092;2470.7158676752133;2472.6043832986725;2420.515896820634;2455.533448644761;2458.8770561471943;2460.5570997220493;2461.778439940405;2366.3965688749345;2388;2407.1574948767966;2408.903643854244;2409.734929157791;2340.871252081135;2348.694669692929;2360.610499267636;2392.7846493815464;2403.4712363280223;8708.346873984414;8781.165789250012;8786;8789.296856251485;8793.736187914374;5293.100172970604;5396.1366181410785;5408.540274076709;5447.428020057877;5452;3200.1679563313473;3293.0943990402593;3343.414902392096;3344.2809795893754;3380.746444016684;978.7553111722069;983.5819776594918;989.7179303898355;993.2401712689726;1030.1810061001522;11501.482433290523;11720.179587428884;11729.882701172965;11746.412679365998;11755;4413.668974826901;4431.8670439886855;4481.5070342262325;4505.752183629932;4532.750698711537;9533;9588.232941364675;9590.568424420917;9593.328467007383;9600.855987160197;4509.436320459942;5201.687898726089;5204.869878253074;5258.6581872178185;5263.763130659129;4628.9537104628525;4831.589314908272;4838.250071238964;4850.248211527219;4853.878653033632;3698.9075273118387;3810.6951443884423;3819.2361527694015;3836.8489453164498;3868.3423817951016;1117.100733909211;1125.3810404277615;1134.3080720760329;1147.449224372306;1148.0987424871437;1458.7447196740527;1458.9489367872075;1471.77923311502;1477.0989696285258;1500.1524138861507;8190;8224.62989165477;8237.711680091168;8273.1726827318;8275.668973241123;495.85868027611957;500.42701107232017;500.99851094876203;503.04923694217956;506.4226781469128;6049.487672826514;6100.420460056376;6133.6319820810895;6181.81454556364;6185.195924529872;10197.337173083726;10402.947985260025;10421.791564168674;10551.736206594744;10560.894391055992;10086.44524551142;10363.740906477398;10379.688609341732;10395.636152734618;10418.531166097544;8090.474119182234;8092.797680058045;8138.87791683137;8179;8192.18078192188;7744.341730952932;7750.372421791261;7755.961220193863;7819.0617125945255;7941.404394670307;9356.111169438893;9360.297977651568;9413.482258475575;9636.903630963881;9693.806123877624;9535.856962145435;9680.128788409076;10059.144972677112;10063.49682515886;10089.09198172168;6344.270408903035;7198.856022879618;7418.332350088518;7739.806504837424;7890.9605451972375;8103.027636683636;8103.756887293391;8118.715844945398;8137.511749295061;8147.470414423044;7348.853022939618;7360.926390736238;7379.372753316028;7438.739644112647;7629.46593738433;7409.962950185214;7431.071116110486;7481.551106933602;7483.663235154322;7553.206913274027;7923.801904952422;7940.761777146695;7957.084935232291;7964.522128672298;7987.121416644049;7019.719211231493;7046.048783414173;7049.365557099885;7058.505904586629;7159.8568028640175;7349.338559529668;7367.5211111277595;7397.778066658009;7407.296306850841;7411.888821667787 09:41:17 INFO - PROCESS | 26913 | |4;prototype.html;333.5580356028263;341.1369235833342;342.7378055787323;344.29247895574593;345.11478058779227;5925;5933.110033494978;5948.078047902572;5981.342052374235;6018.007028840236;5902.970485147579;5908.645481271126;5919.615225010371;5928.199693041438;5932.584719069667;4389.824407023715;4458.843940462085;4538.954610453886;4580.473245576752;4582.427196600425;4622.8150873965005;4632.606228470584;4635.652326075541;4644.489106198315;4646.303054541829;4606.493285738566;4610.423697037871;4611.976940115294;4616.676832621718;4620.607248383892;4378.781060946956;4471.7987690554;4581.5647513486165;4599.563041511051;4615.053913947632;4054.067564460161;4056.7565946043333;4061.2486689962157;4061.97969010156;4077.1641813428178;5575.52608028314;5586.804461843816;5586.888262234733;5590.86022849428;5596.1605759136455;5322.121849894763;5333.839984800462;5336.039512887679;5336.573074154058;5340.172273297645;6225.252969643627;6226.25284965807;6227.87544249117;6239.344868788758;6244.281907580641;4238.279492486285;4404.031113155101;4415.977920110411;4483.865484035484;4499.61753250974;6470.708818103197;6501.187351581052;6504.121943537609;6522.608643481359;6546.0835483032415;4441.133978874089;4448.644108471314;4451.087527056946;4456.086502267028;4462.576055274743;4509.075639493896;4519.7740112994215;4521.525239849834;4529.275315949432;4530.682852200381;5220.321358223407;5224.242484839677;5224.52979231871;5229.764660590283;5230.973845130826;6029.698515074228;6315.747370105144;6319.842003949938;6323.873522529616;6326.49388048955;1561.7032763775073;1577.897436666613;1586.7937168168064;1590.8886377953663;1591.7134915715283;979.774651830083;1009.1926458833051;1029.25893356783;1037.7872536130076;1060.1412855587;5866.6186697864505;5928.614640048383;5932.228810254725;6010.489108425745;6035.758569657252;6391.201099862517;6401.743930242738;6402.967985160044;6406.487481001509;6418.903716444257;5983.311919129269;5994.670293133832;6004.42957918997;6005.159277701126;6019.909701354483;3397.286569820316;3408.744344174197;3435.7766745161484;3437.05480992729;3445.586529616462;6511.0558968949235;6614.603123812587;6652.234992975869;6665.766698165541;6674.365935236145;6574.474042076622;6589.80230593083;6604.3395660434535;6608.8347791305605;6629.3370662934285;6604.834879127964;6612.966935165294;6614.735410583523;6621.470282377494;6625.138731964814;6383.202099737533;6386.201724784402;6390.968045159931;6399.520035997226;6402.167718196791;6173.84565385869;6314.989601663896;6321.620702757849;6325.841853953688;6329.082283069021;6589.110470086477;6594.868102638016;6616.966915165393;6629.171353580802;6647.069410282661;4398.164348773723;4398.416570034721;4403.383526306384;4414.359917811835;4420.7126536775;6389.744410223539;6390.64851433157;6396.680165991775;6433.5496515243485;6456.386643268882;6211.316755156839;6215.564910456224;6217.191765070512;6222.782202622887;6225.315215326401;6079.696015199311;6209.223847019122;6230.532710046674;6234.251889773256;6239.251289845248;6088.208532890696;6097.390260973867;6110.908336375047;6113.786017489367;6116.082587611716;6232.5637205397;6242.3133455320785;6287.434130928238;6320.115183874169;6321.020241862519;5902.498287645598;5987.700614969147;6067.059605761114;6110.541709371726;6124.816255512342 09:41:17 INFO - PROCESS | 26913 | |5;yui.html;737.4248086492536;773.4817672159652;795.8845967334737;802.9036515618127;824.7690646618948;12715.109942304043;13035.348232588356;13124.868751312484;13126;13164.802527962076;13003.934980325084;13034.934825325883;13037.348132593379;13044;13087.9529637629;748.6705849426248;914.1909410172012;936.372630337672;938.2540880000416;938.6714649872524;913.8720579118929;924.944503329799;928.0997432490507;928.331601247101;928.7120992492315;799.856025915335;969.2682025071061;972.9610815567369;975.687779910429;976.3409698453551;940.4357385568672;951.6574033347989;956.7273327101777;957.25812495316;958.4345236310576;701.7333413302963;709.4182770128497;709.5494361080699;710.2506855267691;710.5097482736895;13481.191128532222;13558.050936434454;13581.728365432637;13590.184588924696;13599.932000340033;13013;13617.046806723532;13659.795103073462;13765.105268157538;13836.377363018688;10714.142868570496;10870.510827012804;10876;10898.400587967659;11161.38612376319;3848.672862806665;3858.536975562922;3917.9608203918165;3948.605139486057;3972.7219094663387;49248;49382.25926611104;49411;49472;49509;10517.158627309796;10611.628592999363;10669.41318227505;10951.507182176661;11015.889841101487;19355.09463339186;19404.70892936579;19548.902255488916;19615.509612259808;19650;7710.383169346439;7710.498817576839;7727.729529466442;7835.569043702537;8137.308328792001;4452.933206001912;4469.843555475542;4479.417675702138;4524.276115821453;4539.5460453955;3279.5900512435946;3306.156929982887;3308.966910330866;3310.1062713067336;3310.503424486298;593.6675461741438;597.2146627185324;597.5667640960269;612.5191724496249;615.0865964043392;651.1957732200729;731.8865575835754;737.7749786315226;743.1231147246193;758.9772306830804;8844.248104590792;8859.202671759573;8967.551622418983;9067.501287429255;9169.436538423257;650.7039297119799;718.2386670129679;720.2977097330062;744.0104660801121;744.3040756892215;4118.52636946755;4209.200251952119;4209.200251952119;4323.783810809447;4402.987312918047;57911.710441447525;58133.709331453916;58951.41048589545;62951.6852415735;64776;49199;50682.23976640353;50913.745431272604;51149.74425127925;51355.74322128366;46371.5362846374;46769.766151169024;47142.5285747145;47272;47657.76171119122;9064.706586348386;9168.220701240203;9224;9356.719298421058;9462.621495140118;34788.478172827934;34913.82543087268;35042;35195;36333.0916727084;39749.80125099356;39956.80021599874;44506.777466112464;44853.10293794171;45044.32433513566;11617.128715346214;11926.224795388272;12120.151589388659;12367.443465043914;12422.192557483735;12443.93778031104;12588.181768185039;13602;13813.51652692151;13881;11823;12026.579069732517;12532.874671253536;13018.739625207632;13059.542915997894;11433.771324573629;11676.824847627122;12020.278783273032;12239.510419583474;12857.228566286052;11855.229410088317;12028.15802893789;12252.142350035412;12371.195872268274;12410.627681169579;10088.546015429176;10100.090991810772;10241.334313269614;10371.688849334532;10502.894971050497;10289.794204115726;10346.275760696679;10351.948240258751;10426.165906727596;10440.530176142243 09:41:17 INFO - PROCESS | 26913 | __end_tp_report 09:41:17 INFO - PROCESS | 26913 | __start_cc_report 09:41:17 INFO - PROCESS | 26913 | _x_x_mozilla_cycle_collect,840 09:41:17 INFO - PROCESS | 26913 | __end_cc_report 09:41:17 INFO - PROCESS | 26913 | __startTimestamp1461084077458__endTimestamp 09:41:17 INFO - PROCESS | 26913 | 09:41:17 INFO - PROCESS | 26913 | ------- Summary: start ------- 09:41:17 INFO - PROCESS | 26913 | Number of tests: 6 09:41:17 INFO - PROCESS | 26913 | 09:41:17 INFO - PROCESS | 26913 | [#0] dojo.html Cycles:165 Average:5463.37 Median:5678.74 stddev:617.58 (10.9%) stddev-sans-first:595.73 09:41:17 INFO - PROCESS | 26913 | Values: 3301.2 3340.7 3351.3 3356.5 3394.5 5337.2 5356.9 5360.0 5377.1 5391.8 5335.0 5365.0 5389.4 5389.6 5391.7 4816.1 4894.7 4908.1 4908.5 4983.1 4874.3 4893.8 4953.3 5041.3 5086.5 5019.4 5103.6 5108.3 5109.0 5117.3 4963.3 5021.1 5030.5 5040.9 5047.1 4795.3 4855.1 4926.4 4937.0 4940.8 5331.8 5354.7 5357.1 5361.0 5368.5 5888.7 5903.1 5905.1 5906.9 5920.8 5739.2 5917.6 5975.9 6014.8 6023.9 5491.3 5492.4 5493.2 5493.3 5499.6 5799.2 5919.4 5974.7 5977.1 5994.2 5727.7 5784.2 5784.5 5807.2 5815.1 5890.1 5902.1 5910.0 5911.0 5913.9 5740.7 5766.3 5867.3 5884.8 5887.5 5894.1 5905.1 5908.7 5910.5 5940.8 4426.6 4444.6 4462.3 4462.7 4495.1 3944.6 3965.7 4003.8 4019.4 4067.4 5603.8 5621.0 5625.1 5625.5 5637.4 5920.7 5930.8 5955.6 5958.7 5960.1 5465.7 5548.9 5605.1 5627.4 5629.7 5028.5 5039.8 5047.7 5077.7 5085.1 6062.1 6109.7 6115.8 6123.0 6124.1 5781.1 5955.3 6005.1 6018.5 6043.4 6144.4 6151.2 6153.0 6179.1 6187.0 5646.6 5860.9 5877.3 5879.6 5881.3 5865.3 5921.7 5927.8 5933.2 5953.3 5749.3 5760.3 5791.9 5793.6 5799.8 5623.3 5752.9 5773.2 5780.1 5784.5 5665.2 5675.6 5678.7 5679.6 5716.2 5774.4 5785.7 5786.4 5788.4 5788.4 5545.9 5618.9 5670.1 5700.2 5718.7 09:41:17 INFO - PROCESS | 26913 | 09:41:17 INFO - PROCESS | 26913 | [#1] ext.html Cycles:180 Average:48635.97 Median:39631.25 stddev:89977.80 (227.0%) stddev-sans-first:90157.79 09:41:17 INFO - PROCESS | 26913 | Values: 555.0 562.6 565.2 586.1 630.5 38962.2 39631.6 39633.6 39705.6 39767.0 42260.4 42877.1 42937.8 42947.8 42960.4 8839.2 9029.3 9045.1 9056.0 9056.2 8941.3 9094.0 9100.4 9105.4 9109.7 9247.7 9371.8 9373.1 9373.2 9379.2 9200.5 9275.5 9291.8 9292.2 9308.6 9119.0 9249.6 9268.1 9278.4 9279.2 41878.0 42147.2 42334.8 42344.2 42426.4 3579.2 3625.8 3659.5 3735.8 3912.6 29319.0 29505.7 29795.6 29828.3 30101.8 3812.4 3815.2 3831.5 3850.0 3886.8 219768.0 220747.0 221782.0 222246.9 222805.0 45081.3 45594.8 66728.3 66773.0 67368.3 44041.0 44148.3 44161.0 44187.8 44188.6 16995.2 17044.1 17173.9 17196.6 17215.6 13944.3 14050.3 14052.2 14052.8 14054.1 15184.2 15647.5 15647.7 15650.0 15752.5 5809.6 5888.6 5941.4 6103.6 6164.3 1031.4 1084.1 1114.4 1136.1 1149.4 30314.0 30733.2 30733.7 30765.5 30808.8 1105.4 1142.7 1145.1 1196.9 1251.7 15618.0 15820.0 15934.7 16136.2 16167.8 343061.0 514616.0 523746.0 524201.0 524447.0 53271.5 53591.0 54267.0 54344.7 54347.0 1383.4 1494.2 1520.1 1520.6 1538.5 28758.1 29228.4 29531.0 29867.6 30268.8 46756.8 47528.3 47531.8 47555.0 47733.8 226943.0 233231.0 234147.0 235319.0 235595.0 30234.8 32847.7 34327.3 34367.5 35203.8 47270.0 47306.5 47660.3 47879.3 48285.3 39630.9 39973.8 40507.0 40783.2 41231.6 37971.2 38618.8 39406.6 39986.2 40266.6 39655.8 40486.4 40915.0 41033.6 41206.6 35030.1 36347.5 36371.9 36695.4 36852.6 27472.3 27516.4 27677.2 28341.1 28535.1 09:41:17 INFO - PROCESS | 26913 | 09:41:17 INFO - PROCESS | 26913 | [#2] jquery.html Cycles:180 Average:26067.62 Median:2217.02 stddev:75229.22 (3393.3%) stddev-sans-first:75415.49 09:41:17 INFO - PROCESS | 26913 | Values: 354.3 365.4 371.1 372.5 374.6 17375.6 18115.3 18178.8 18431.4 18435.6 16814.2 17359.7 17499.3 17523.8 17528.9 5426.2 5659.0 5705.5 5712.9 5718.5 4219.9 5550.3 5872.4 6119.0 6138.5 6095.5 6096.5 6105.2 6121.9 6127.8 5868.2 6056.8 6057.5 6080.8 6082.3 3818.1 5169.7 5349.4 5397.0 5398.9 20523.7 20999.5 21055.3 21337.0 21338.4 2190.7 2243.3 2274.3 2543.7 2653.4 13519.7 13692.6 13826.0 13991.0 14065.9 1804.2 1867.2 1868.0 1898.2 1940.2 60775.1 60903.4 61174.0 62354.7 62507.0 9085.7 9332.4 9851.7 9927.6 10049.8 13776.7 13954.0 13957.9 13974.3 14002.3 8014.8 8125.3 8141.3 8159.9 8220.9 8094.9 8139.5 8221.7 8234.8 8254.2 6059.2 6069.5 6113.9 6146.1 6173.5 1705.6 1734.5 1817.1 1864.3 1865.2 1004.5 1047.2 1078.5 1096.1 1144.9 16780.2 17071.0 17148.0 17221.7 17656.8 1017.6 1018.6 1027.2 1047.4 1111.1 10369.9 10424.3 10582.4 10629.4 10830.4 456271.0 458200.0 461748.0 463603.0 465344.0 62283.0 65049.0 66445.0 66834.7 67445.0 1075.7 1079.4 1094.8 1105.1 1112.6 16047.1 16238.4 16306.9 16408.5 16425.2 31977.5 32013.2 33411.3 33548.5 34098.0 38102.6 40388.8 46437.0 46546.5 47118.5 7693.6 8144.2 8653.0 8837.2 8885.0 12663.7 12677.6 12975.7 12994.4 13139.7 10887.2 11299.3 11346.4 11374.3 11389.5 10940.1 11102.4 11147.9 11421.5 11502.8 11284.7 11548.3 11599.7 11760.3 12226.8 8482.1 8498.2 8540.9 8678.8 8734.2 9161.3 11102.7 11466.6 11531.5 11951.7 09:41:17 INFO - PROCESS | 26913 | 09:41:17 INFO - PROCESS | 26913 | [#3] mootools.html Cycles:180 Average:5973.59 Median:5402.34 stddev:3176.45 (58.8%) stddev-sans-first:3167.22 09:41:17 INFO - PROCESS | 26913 | Values: 1456.5 1594.9 1624.9 1898.1 2002.7 8256.9 8499.4 8523.6 8526.8 8528.8 8452.2 8605.9 8608.4 8613.6 8618.1 2083.8 2430.2 2439.9 2467.2 2488.6 2445.7 2462.0 2468.9 2470.7 2472.6 2420.5 2455.5 2458.9 2460.6 2461.8 2366.4 2388.0 2407.2 2408.9 2409.7 2340.9 2348.7 2360.6 2392.8 2403.5 8708.3 8781.2 8786.0 8789.3 8793.7 5293.1 5396.1 5408.5 5447.4 5452.0 3200.2 3293.1 3343.4 3344.3 3380.7 978.8 983.6 989.7 993.2 1030.2 11501.5 11720.2 11729.9 11746.4 11755.0 4413.7 4431.9 4481.5 4505.8 4532.8 9533.0 9588.2 9590.6 9593.3 9600.9 4509.4 5201.7 5204.9 5258.7 5263.8 4629.0 4831.6 4838.3 4850.2 4853.9 3698.9 3810.7 3819.2 3836.8 3868.3 1117.1 1125.4 1134.3 1147.4 1148.1 1458.7 1458.9 1471.8 1477.1 1500.2 8190.0 8224.6 8237.7 8273.2 8275.7 495.9 500.4 501.0 503.0 506.4 6049.5 6100.4 6133.6 6181.8 6185.2 10197.3 10402.9 10421.8 10551.7 10560.9 10086.4 10363.7 10379.7 10395.6 10418.5 8090.5 8092.8 8138.9 8179.0 8192.2 7744.3 7750.4 7756.0 7819.1 7941.4 9356.1 9360.3 9413.5 9636.9 9693.8 9535.9 9680.1 10059.1 10063.5 10089.1 6344.3 7198.9 7418.3 7739.8 7891.0 8103.0 8103.8 8118.7 8137.5 8147.5 7348.9 7360.9 7379.4 7438.7 7629.5 7410.0 7431.1 7481.6 7483.7 7553.2 7923.8 7940.8 7957.1 7964.5 7987.1 7019.7 7046.0 7049.4 7058.5 7159.9 7349.3 7367.5 7397.8 7407.3 7411.9 09:41:17 INFO - PROCESS | 26913 | 09:41:17 INFO - PROCESS | 26913 | [#4] prototype.html Cycles:180 Average:5230.56 Median:5964.71 stddev:1560.07 (26.2%) stddev-sans-first:1520.53 09:41:17 INFO - PROCESS | 26913 | Values: 333.6 341.1 342.7 344.3 345.1 5925.0 5933.1 5948.1 5981.3 6018.0 5903.0 5908.6 5919.6 5928.2 5932.6 4389.8 4458.8 4539.0 4580.5 4582.4 4622.8 4632.6 4635.7 4644.5 4646.3 4606.5 4610.4 4612.0 4616.7 4620.6 4378.8 4471.8 4581.6 4599.6 4615.1 4054.1 4056.8 4061.2 4062.0 4077.2 5575.5 5586.8 5586.9 5590.9 5596.2 5322.1 5333.8 5336.0 5336.6 5340.2 6225.3 6226.3 6227.9 6239.3 6244.3 4238.3 4404.0 4416.0 4483.9 4499.6 6470.7 6501.2 6504.1 6522.6 6546.1 4441.1 4448.6 4451.1 4456.1 4462.6 4509.1 4519.8 4521.5 4529.3 4530.7 5220.3 5224.2 5224.5 5229.8 5231.0 6029.7 6315.7 6319.8 6323.9 6326.5 1561.7 1577.9 1586.8 1590.9 1591.7 979.8 1009.2 1029.3 1037.8 1060.1 5866.6 5928.6 5932.2 6010.5 6035.8 6391.2 6401.7 6403.0 6406.5 6418.9 5983.3 5994.7 6004.4 6005.2 6019.9 3397.3 3408.7 3435.8 3437.1 3445.6 6511.1 6614.6 6652.2 6665.8 6674.4 6574.5 6589.8 6604.3 6608.8 6629.3 6604.8 6613.0 6614.7 6621.5 6625.1 6383.2 6386.2 6391.0 6399.5 6402.2 6173.8 6315.0 6321.6 6325.8 6329.1 6589.1 6594.9 6617.0 6629.2 6647.1 4398.2 4398.4 4403.4 4414.4 4420.7 6389.7 6390.6 6396.7 6433.5 6456.4 6211.3 6215.6 6217.2 6222.8 6225.3 6079.7 6209.2 6230.5 6234.3 6239.3 6088.2 6097.4 6110.9 6113.8 6116.1 6232.6 6242.3 6287.4 6320.1 6321.0 5902.5 5987.7 6067.1 6110.5 6124.8 09:41:17 INFO - PROCESS | 26913 | 09:41:17 INFO - PROCESS | 26913 | [#5] yui.html Cycles:180 Average:14224.87 Median:4363.39 stddev:16117.91 (369.4%) stddev-sans-first:16131.30 09:41:17 INFO - PROCESS | 26913 | Values: 737.4 773.5 795.9 802.9 824.8 12715.1 13035.3 13124.9 13126.0 13164.8 13003.9 13034.9 13037.3 13044.0 13088.0 748.7 914.2 936.4 938.3 938.7 913.9 924.9 928.1 928.3 928.7 799.9 969.3 973.0 975.7 976.3 940.4 951.7 956.7 957.3 958.4 701.7 709.4 709.5 710.3 710.5 13481.2 13558.1 13581.7 13590.2 13599.9 13013.0 13617.0 13659.8 13765.1 13836.4 10714.1 10870.5 10876.0 10898.4 11161.4 3848.7 3858.5 3918.0 3948.6 3972.7 49248.0 49382.3 49411.0 49472.0 49509.0 10517.2 10611.6 10669.4 10951.5 11015.9 19355.1 19404.7 19548.9 19615.5 19650.0 7710.4 7710.5 7727.7 7835.6 8137.3 4452.9 4469.8 4479.4 4524.3 4539.5 3279.6 3306.2 3309.0 3310.1 3310.5 593.7 597.2 597.6 612.5 615.1 651.2 731.9 737.8 743.1 759.0 8844.2 8859.2 8967.6 9067.5 9169.4 650.7 718.2 720.3 744.0 744.3 4118.5 4209.2 4209.2 4323.8 4403.0 57911.7 58133.7 58951.4 62951.7 64776.0 49199.0 50682.2 50913.7 51149.7 51355.7 46371.5 46769.8 47142.5 47272.0 47657.8 9064.7 9168.2 9224.0 9356.7 9462.6 34788.5 34913.8 35042.0 35195.0 36333.1 39749.8 39956.8 44506.8 44853.1 45044.3 11617.1 11926.2 12120.2 12367.4 12422.2 12443.9 12588.2 13602.0 13813.5 13881.0 11823.0 12026.6 12532.9 13018.7 13059.5 11433.8 11676.8 12020.3 12239.5 12857.2 11855.2 12028.2 12252.1 12371.2 12410.6 10088.5 10100.1 10241.3 10371.7 10502.9 10289.8 10346.3 10351.9 10426.2 10440.5 09:41:17 INFO - PROCESS | 26913 | -------- Summary: end -------- 09:41:17 INFO - PROCESS | 26913 | 09:41:18 INFO - TEST-INFO | 26913: exit 0 09:41:18 INFO - TEST-OK | dromaeo_css | took 1111933ms 09:41:18 INFO - TEST-START | kraken 09:41:18 INFO - operating with platform_type : linux_ 09:41:18 INFO - Initialising browser for kraken test... 09:41:18 INFO - TEST-INFO | started process 27106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptEBUQ7/profile http://localhost:41299/getInfo.html) 09:41:22 INFO - PROCESS | 27106 | __metrics Screen width/height:1600/1200 09:41:22 INFO - PROCESS | 27106 | colorDepth:24 09:41:22 INFO - PROCESS | 27106 | Browser inner width/height: 1024/697 09:41:22 INFO - PROCESS | 27106 | __metrics 09:41:23 INFO - PROCESS | 27106 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:24 INFO - TEST-INFO | 27106: exit 0 09:41:24 INFO - Browser initialized. 09:41:24 INFO - Running cycle 1/1 for kraken test... 09:41:24 INFO - TEST-INFO | started process 27196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptEBUQ7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:35 INFO - PROCESS | 27196 | RSS: Main: 141717504 09:41:35 INFO - PROCESS | 27196 | 09:41:38 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41299/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:39 INFO - PROCESS | 27196 | RSS: Main: 178192384 09:41:39 INFO - PROCESS | 27196 | 09:41:41 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41299/tests/kraken/driver.html?testName=audio-dft) 09:41:42 INFO - PROCESS | 27196 | RSS: Main: 176025600 09:41:42 INFO - PROCESS | 27196 | 09:41:45 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41299/tests/kraken/driver.html?testName=audio-fft) 09:41:45 INFO - PROCESS | 27196 | RSS: Main: 172433408 09:41:45 INFO - PROCESS | 27196 | 09:41:47 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41299/tests/kraken/driver.html?testName=audio-oscillator) 09:41:48 INFO - PROCESS | 27196 | RSS: Main: 173596672 09:41:48 INFO - PROCESS | 27196 | 09:41:50 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41299/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:51 INFO - PROCESS | 27196 | RSS: Main: 171622400 09:41:51 INFO - PROCESS | 27196 | 09:41:54 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41299/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:54 INFO - PROCESS | 27196 | RSS: Main: 171565056 09:41:54 INFO - PROCESS | 27196 | 09:41:58 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41299/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:58 INFO - PROCESS | 27196 | RSS: Main: 172257280 09:41:58 INFO - PROCESS | 27196 | 09:42:01 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41299/tests/kraken/driver.html?testName=json-parse-financial) 09:42:01 INFO - PROCESS | 27196 | RSS: Main: 171540480 09:42:01 INFO - PROCESS | 27196 | 09:42:03 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41299/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:42:04 INFO - PROCESS | 27196 | RSS: Main: 175939584 09:42:04 INFO - PROCESS | 27196 | 09:42:05 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41299/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:42:06 INFO - PROCESS | 27196 | RSS: Main: 175968256 09:42:06 INFO - PROCESS | 27196 | 09:42:08 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41299/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:42:09 INFO - PROCESS | 27196 | RSS: Main: 180371456 09:42:09 INFO - PROCESS | 27196 | 09:42:11 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:42:11 INFO - PROCESS | 27196 | RSS: Main: 186474496 09:42:11 INFO - PROCESS | 27196 | 09:42:14 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:42:15 INFO - PROCESS | 27196 | RSS: Main: 186183680 09:42:15 INFO - PROCESS | 27196 | 09:42:16 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:41299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41299/tests/kraken/driver.html?testName=ai-astar) 09:42:17 INFO - PROCESS | 27196 | RSS: Main: 248373248 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | __start_tp_report 09:42:17 INFO - PROCESS | 27196 | _x_x_mozilla_page_load 09:42:17 INFO - PROCESS | 27196 | _x_x_mozilla_page_load_details 09:42:17 INFO - PROCESS | 27196 | |i|pagename|runs| 09:42:17 INFO - PROCESS | 27196 | |0;ai-astar;111;112;105;109;113;113;99;110;108;111 09:42:17 INFO - PROCESS | 27196 | |1;audio-beat-detection;159;134;161;167;134;158;159;134;186;128 09:42:17 INFO - PROCESS | 27196 | |2;audio-dft;162;163;162;162;162;163;161;162;162;161 09:42:17 INFO - PROCESS | 27196 | |3;audio-fft;76;75;77;159;79;77;73;76;164;75 09:42:17 INFO - PROCESS | 27196 | |4;audio-oscillator;93;94;147;93;93;93;143;93;92;147 09:42:17 INFO - PROCESS | 27196 | |5;imaging-gaussian-blur;117;116;117;117;116;116;117;117;117;117 09:42:17 INFO - PROCESS | 27196 | |6;imaging-darkroom;146;146;147;146;146;146;146;147;147;146 09:42:17 INFO - PROCESS | 27196 | |7;imaging-desaturate;96;96;96;97;96;95;95;95;95;95 09:42:17 INFO - PROCESS | 27196 | |8;json-parse-financial;54;57;55;55;55;55;56;64;55;52 09:42:17 INFO - PROCESS | 27196 | |9;json-stringify-tinderbox;64;65;65;65;66;64;67;65;65;65 09:42:17 INFO - PROCESS | 27196 | |10;stanford-crypto-aes;84;78;85;78;77;78;77;79;79;78 09:42:17 INFO - PROCESS | 27196 | |11;stanford-crypto-ccm;114;115;111;112;113;114;117;117;114;118 09:42:17 INFO - PROCESS | 27196 | |12;stanford-crypto-pbkdf2;144;144;143;141;143;136;144;153;156;138 09:42:17 INFO - PROCESS | 27196 | |13;stanford-crypto-sha256-iterative;67;69;68;67;68;66;66;67;68;67 09:42:17 INFO - PROCESS | 27196 | __end_tp_report 09:42:17 INFO - PROCESS | 27196 | __start_cc_report 09:42:17 INFO - PROCESS | 27196 | _x_x_mozilla_cycle_collect,1073 09:42:17 INFO - PROCESS | 27196 | __end_cc_report 09:42:17 INFO - PROCESS | 27196 | __startTimestamp1461084137029__endTimestamp 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | ------- Summary: start ------- 09:42:17 INFO - PROCESS | 27196 | Number of tests: 14 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.50 stddev:4.31 (3.9%) stddev-sans-first:4.51 09:42:17 INFO - PROCESS | 27196 | Values: 111.0 112.0 105.0 109.0 113.0 113.0 99.0 110.0 108.0 111.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:159.00 stddev:18.69 (11.8%) stddev-sans-first:19.65 09:42:17 INFO - PROCESS | 27196 | Values: 159.0 134.0 161.0 167.0 134.0 158.0 159.0 134.0 186.0 128.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 09:42:17 INFO - PROCESS | 27196 | Values: 162.0 163.0 162.0 162.0 162.0 163.0 161.0 162.0 162.0 161.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:36.10 (47.5%) stddev-sans-first:37.76 09:42:17 INFO - PROCESS | 27196 | Values: 76.0 75.0 77.0 159.0 79.0 77.0 73.0 76.0 164.0 75.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:93.00 stddev:25.47 (27.4%) stddev-sans-first:26.36 09:42:17 INFO - PROCESS | 27196 | Values: 93.0 94.0 147.0 93.0 93.0 93.0 143.0 93.0 92.0 147.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:42:17 INFO - PROCESS | 27196 | Values: 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:42:17 INFO - PROCESS | 27196 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 09:42:17 INFO - PROCESS | 27196 | Values: 96.0 96.0 96.0 97.0 96.0 95.0 95.0 95.0 95.0 95.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.16 (5.7%) stddev-sans-first:3.28 09:42:17 INFO - PROCESS | 27196 | Values: 54.0 57.0 55.0 55.0 55.0 55.0 56.0 64.0 55.0 52.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 09:42:17 INFO - PROCESS | 27196 | Values: 64.0 65.0 65.0 65.0 66.0 64.0 67.0 65.0 65.0 65.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:2.83 (3.6%) stddev-sans-first:2.44 09:42:17 INFO - PROCESS | 27196 | Values: 84.0 78.0 85.0 78.0 77.0 78.0 77.0 79.0 79.0 78.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#11] stanford-crypto-ccm Cycles:10 Average:114.50 Median:114.50 stddev:2.27 (2.0%) stddev-sans-first:2.40 09:42:17 INFO - PROCESS | 27196 | Values: 114.0 115.0 111.0 112.0 113.0 114.0 117.0 117.0 114.0 118.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:144.00 stddev:6.11 (4.2%) stddev-sans-first:6.48 09:42:17 INFO - PROCESS | 27196 | Values: 144.0 144.0 143.0 141.0 143.0 136.0 144.0 153.0 156.0 138.0 09:42:17 INFO - PROCESS | 27196 | 09:42:17 INFO - PROCESS | 27196 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 09:42:17 INFO - PROCESS | 27196 | Values: 67.0 69.0 68.0 67.0 68.0 66.0 66.0 67.0 68.0 67.0 09:42:17 INFO - PROCESS | 27196 | -------- Summary: end -------- 09:42:17 INFO - PROCESS | 27196 | 09:42:18 INFO - TEST-INFO | 27196: exit 0 09:42:18 INFO - TEST-OK | kraken | took 60044ms 09:42:18 INFO - SUITE-END | took 1171s 09:42:18 INFO - Completed test suite (00:19:32) 09:42:18 INFO - javascript benchmark 09:42:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3301.2242123101073, 3340.7160391366733, 3351.312980838928, 3356.530085787989, 3394.541736865523, 5337.172738225577, 5356.9196462053005, 5359.973200133999, 5377.139657654771, 5391.81128660497, 5334.973325133378, 5365.03429382711, 5389.434109418504, 5389.5688344932405, 5391.703456309901, 4816.0608681306985, 4894.706317620937, 4908.067467181242, 4908.460069392364, 4983.053219888209, 4874.341963834872, 4893.755312234392, 4953.257011448293, 5041.319421878036, 5086.542211200991, 5019.397672279331, 5103.591712662978, 5108.3359163308905, 5109.0, 5117.334746482952, 4963.329950456714, 5021.096202683516, 5030.547250747413, 5040.873978150557, 5047.116754567955, 4795.328653988445, 4855.053264613402, 4926.433460152092, 4937.012597480519, 4940.827071052496, 5331.813386531453, 5354.678719276817, 5357.116075847481, 5361.035013697533, 5368.516833484966, 5888.676122813244, 5903.085021821625, 5905.055191169392, 5906.940930590682, 5920.822375328747, 5739.225204597367, 5917.615355001954, 5975.940240597582, 6014.789482368096, 6023.879522409571, 5491.341039075297, 5492.423295553949, 5493.23094766733, 5493.313335833021, 5499.642523235977, 5799.217105690762, 5919.378465261172, 5974.671393073423, 5977.103434484862, 5994.1608174855555, 5727.656340619493, 5784.1902133701315, 5784.479396854304, 5807.245058142499, 5815.098659707752, 5890.087036509348, 5902.085176797603, 5910.0, 5910.970445147746, 5913.881722365529, 5740.712964351766, 5766.336871259775, 5867.295924489089, 5884.764609415661, 5887.499562537232, 5894.056950887923, 5905.084711869667, 5908.734106965197, 5910.497607703307, 5940.821775346746, 4426.601605855424, 4444.577765112309, 4462.286034234572, 4462.665300102505, 4495.100979804052, 3944.5660977292473, 3965.7025723070883, 4003.839846406111, 4019.376996565537, 4067.3695577185586, 5603.831885043455, 5621.016322143691, 5625.128105143709, 5625.521830644359, 5637.379888212294, 5920.674362910081, 5930.762769489172, 5955.642661440327, 5958.731857066442, 5960.0761881908375, 5465.726713664301, 5548.91676624851, 5605.131204663284, 5627.409122042209, 5629.746661400247, 5028.522290382408, 5039.798408063636, 5047.722375269395, 5077.746112694351, 5085.084684756705, 6062.090686396988, 6109.725062372204, 6115.755369785248, 6122.969385153046, 6124.118392306737, 5781.1328300754385, 5955.344912059757, 6005.099235114768, 6018.458338749533, 6043.425874541911, 6144.354842741448, 6151.231096112986, 6152.969235153974, 6179.104029915727, 6186.969065154825, 5646.576506761927, 5860.912086318794, 5877.265341832271, 5879.617824841372, 5881.3236477803885, 5865.266841644794, 5921.733521991607, 5927.762889484545, 5933.22868027171, 5953.28560572734, 5749.281339832521, 5760.308762948473, 5791.884162316815, 5793.594448388741, 5799.82600521985, 5623.297087864017, 5752.9137062943255, 5773.191753154646, 5780.132980052857, 5784.5083167929515, 5665.178549110438, 5675.57433192504, 5678.744456499385, 5679.574031947538, 5716.228309178207, 5774.393688662798, 5785.6817875015595, 5786.363500014911, 5788.363280039108, 5788.392218817132, 5545.889082218252, 5618.85952851182, 5670.092785154356, 5700.201971723879, 5718.685472298897], "unit": "score", "name": "dojo.html", "value": 5423.015494221755}, {"lowerIsBetter": false, "replicates": [554.9954582206204, 562.5864989232914, 565.2169719417036, 586.1471558881827, 630.5208041888163, 38962.22075558491, 39631.60368396315, 39633.60366396335, 39705.60294397055, 39767.0, 42260.36609450861, 42877.14245715092, 42937.78531107348, 42947.78526107373, 42960.35559466603, 8839.16027977341, 9029.322800789934, 9045.140711632384, 9055.95472022639, 9056.184943355096, 8941.284697224239, 9094.0, 9100.408473449237, 9105.408148470327, 9109.726708198765, 9247.676331328405, 9371.812563748721, 9373.109554592304, 9373.156415922565, 9379.24966002718, 9200.493972831491, 9275.489848058354, 9291.814163716756, 9292.210162136227, 9308.58111384986, 9119.0, 9249.6300147994, 9268.119528644767, 9278.35051546392, 9279.164875161201, 41878.0, 42147.157056858996, 42334.78832605848, 42344.15311693749, 42426.36360454596, 3579.2125732338845, 3625.800580968046, 3659.5242618459697, 3735.831887565039, 3912.550056743454, 29319.0, 29505.704942950724, 29795.55306670402, 29828.254293642833, 30101.849490752626, 3812.3519001769487, 3815.1606646537716, 3831.4635950966886, 3849.9807500962315, 3886.7667939923695, 219768.0, 220747.0, 221782.0, 222246.88876555677, 222805.0, 45081.32378014332, 45594.77202614032, 66728.33271667318, 66773.0, 67368.3263167362, 44041.0, 44148.3377749334, 44161.0, 44187.77906110513, 44188.55811441909, 16995.150242487827, 17044.14779261032, 17173.914130429268, 17196.570085747957, 17215.56961075958, 13944.302784860716, 14050.297485125702, 14052.227127508086, 14052.789208161887, 14054.086484378482, 15184.164870932205, 15647.452339168301, 15647.68704625924, 15650.0, 15752.527424177293, 5809.593328467051, 5888.587798854125, 5941.376155503696, 6103.6032657877095, 6164.291106522717, 1031.3966329697212, 1084.1110289562641, 1114.403793970222, 1136.1478890831877, 1149.3965668024355, 30314.0, 30733.231669208002, 30733.69266307353, 30765.538516922265, 30808.828644399935, 1105.4141305108305, 1142.7200335917587, 1145.1297014269048, 1196.8683444821063, 1251.6745646132072, 15618.0, 15820.0, 15934.681306373808, 16136.193190340437, 16167.757483637755, 343061.0, 514616.0, 523746.0, 524201.0, 524447.0, 53271.467285327424, 53591.0, 54266.99999999921, 54344.72827635916, 54347.0, 1383.4120498787975, 1494.1856688105008, 1520.1335238913935, 1520.6198450387403, 1538.523057852047, 28758.137255882357, 29228.415431691672, 29531.0, 29867.55198672065, 30268.84865575746, 46756.766216168704, 47528.287075694585, 47531.76234118807, 47555.0, 47733.76133119312, 226943.0, 233231.0, 234147.0, 235319.0, 235595.0, 30234.84882575573, 32847.67152328542, 34327.31345373129, 34367.48448773321, 35203.82398087993, 47270.0, 47306.52693473021, 47660.285095722895, 47879.28181077217, 48285.27572086492, 39630.891680139284, 39973.80013099916, 40507.0, 40783.1843363137, 41231.58768412397, 37971.240575188895, 38618.80690596529, 39406.60593394029, 39986.200275994895, 40266.597334026286, 39655.80172099121, 40486.392704110054, 40915.0, 41033.589664102976, 41206.587934121475, 35030.12424689403, 36347.45478817767, 36371.90884273476, 36695.449568257034, 36852.63147368492, 27472.313192169557, 27516.449671006067, 27677.16968490868, 28341.149765507067, 28535.143945681662], "unit": "score", "name": "ext.html", "value": 19065.184133171315}, {"lowerIsBetter": false, "replicates": [354.32677911967266, 365.3843274083172, 371.10563541864116, 372.46923134533284, 374.63473113714116, 17375.565610859736, 18115.275388984443, 18178.818211817877, 18431.447056588324, 18435.631287374243, 16814.15929203541, 17359.652806943886, 17499.300027998896, 17523.824761752378, 17528.912355438206, 5426.186072089188, 5659.0, 5705.5435565154685, 5712.942870571283, 5718.513926316268, 4219.873403797891, 5550.333959924815, 5872.412758724136, 6119.0209566469375, 6138.478229350489, 6095.481884039862, 6096.542759293048, 6105.175801266839, 6121.908171377433, 6127.754889804402, 5868.178455016301, 6056.788012419544, 6057.454829065361, 6080.817575472721, 6082.270127584696, 3818.1409182933617, 5169.715665638389, 5349.43830897754, 5397.028534863763, 5398.865028374283, 20523.692144617842, 20999.47501312464, 21055.263065792777, 21337.0, 21338.359849204393, 2190.6823510591034, 2243.349428665685, 2274.2722328854775, 2543.682039745032, 2653.4162484253625, 13519.729605407934, 13692.589222323346, 13826.0, 13991.0, 14065.85934140666, 1804.2422182683304, 1867.2344338821154, 1867.9813201867944, 1898.1648074847024, 1940.2045161483725, 60775.08837367443, 60903.39096609021, 61174.0, 62354.688226558574, 62507.0, 9085.682001129928, 9332.39339442934, 9851.704448866401, 9927.602895884083, 10049.849252261221, 13776.724465510833, 13954.0, 13957.860421395657, 13974.301284935917, 14002.299885005708, 8014.839703205903, 8125.268725814705, 8141.267285944294, 8159.918400815915, 8220.917790822135, 8094.878576821352, 8139.511629302261, 8221.671133154727, 8234.835303293901, 8254.174582541818, 6059.151718759377, 6069.544784141207, 6113.877722445615, 6146.108814221912, 6173.506119510428, 1705.6332888429047, 1734.5056658852166, 1817.1277786662477, 1864.2636158717503, 1865.1628146275907, 1004.4575928998405, 1047.2145890582065, 1078.5308390850005, 1096.0628662493452, 1144.8797876222877, 16780.160991950353, 17071.0, 17147.971121732735, 17221.7416738749, 17656.82343176552, 1017.6133069433567, 1018.6434747838346, 1027.1833892055834, 1047.3925123428394, 1111.1222134513805, 10369.9481502592, 10424.322419042737, 10582.417967011888, 10629.4153821539, 10830.350178989285, 456271.0, 458200.0, 461748.0, 463603.0, 465344.0, 62283.0, 65049.0, 66445.0, 66834.66582667152, 67445.0, 1075.736444571085, 1079.3523885668692, 1094.7591529863416, 1105.1324710102692, 1112.6161474291357, 16047.117408542643, 16238.431654892021, 16306.918465407596, 16408.507744767678, 16425.17874106266, 31977.520337195427, 32013.199670008435, 33411.33177336488, 33548.49677254892, 34098.0, 38102.61897381102, 40388.79805601071, 46437.0, 46546.53453465422, 47118.52881471279, 7693.615319233904, 8144.185581441809, 8652.956735216536, 8837.160469755363, 8885.022647508898, 12663.746725065632, 12677.619671409873, 12975.675608109495, 12994.415251313903, 13139.73720525565, 10887.237893347707, 11299.265547739371, 11346.432678366215, 11374.317540947239, 11389.544418223179, 10940.12479001662, 11102.44487775592, 11147.888521114684, 11421.486033128695, 11502.82745758831, 11284.661460156209, 11548.307101573933, 11599.710007249549, 11760.294382337088, 12226.75546489083, 8482.066972633129, 8498.235158835734, 8540.871886921825, 8678.78303042429, 8734.213920747163, 9161.312901532545, 11102.666919992413, 11466.598669046543, 11531.481083351437, 11951.701207469883], "unit": "score", "name": "jquery.html", "value": 8860.573933328053}, {"lowerIsBetter": false, "replicates": [1456.4538298138198, 1594.8644365228954, 1624.886257961943, 1898.126861643644, 2002.6995950607406, 8256.876146857794, 8499.447535910169, 8523.57382130894, 8526.786830329238, 8528.829423411527, 8452.239298463137, 8605.870911936327, 8608.440451370656, 8613.569321533914, 8618.052014278424, 2083.8124568788808, 2430.234476140019, 2439.853608783474, 2467.1734968785477, 2488.601823708207, 2445.6576079348906, 2461.9753802461923, 2468.938276543092, 2470.7158676752133, 2472.6043832986725, 2420.515896820634, 2455.533448644761, 2458.8770561471943, 2460.5570997220493, 2461.778439940405, 2366.3965688749345, 2388.0, 2407.1574948767966, 2408.903643854244, 2409.734929157791, 2340.871252081135, 2348.694669692929, 2360.610499267636, 2392.7846493815464, 2403.4712363280223, 8708.346873984414, 8781.165789250012, 8786.0, 8789.296856251485, 8793.736187914374, 5293.100172970604, 5396.1366181410785, 5408.540274076709, 5447.428020057877, 5452.0, 3200.1679563313473, 3293.0943990402593, 3343.414902392096, 3344.2809795893754, 3380.746444016684, 978.7553111722069, 983.5819776594918, 989.7179303898355, 993.2401712689726, 1030.1810061001522, 11501.482433290523, 11720.179587428884, 11729.882701172965, 11746.412679365998, 11755.0, 4413.668974826901, 4431.8670439886855, 4481.5070342262325, 4505.752183629932, 4532.750698711537, 9533.0, 9588.232941364675, 9590.568424420917, 9593.328467007383, 9600.855987160197, 4509.436320459942, 5201.687898726089, 5204.869878253074, 5258.6581872178185, 5263.763130659129, 4628.9537104628525, 4831.589314908272, 4838.250071238964, 4850.248211527219, 4853.878653033632, 3698.9075273118387, 3810.6951443884423, 3819.2361527694015, 3836.8489453164498, 3868.3423817951016, 1117.100733909211, 1125.3810404277615, 1134.3080720760329, 1147.449224372306, 1148.0987424871437, 1458.7447196740527, 1458.9489367872075, 1471.77923311502, 1477.0989696285258, 1500.1524138861507, 8190.0, 8224.62989165477, 8237.711680091168, 8273.1726827318, 8275.668973241123, 495.85868027611957, 500.42701107232017, 500.99851094876203, 503.04923694217956, 506.4226781469128, 6049.487672826514, 6100.420460056376, 6133.6319820810895, 6181.81454556364, 6185.195924529872, 10197.337173083726, 10402.947985260025, 10421.791564168674, 10551.736206594744, 10560.894391055992, 10086.44524551142, 10363.740906477398, 10379.688609341732, 10395.636152734618, 10418.531166097544, 8090.474119182234, 8092.797680058045, 8138.87791683137, 8179.0, 8192.18078192188, 7744.341730952932, 7750.372421791261, 7755.961220193863, 7819.0617125945255, 7941.404394670307, 9356.111169438893, 9360.297977651568, 9413.482258475575, 9636.903630963881, 9693.806123877624, 9535.856962145435, 9680.128788409076, 10059.144972677112, 10063.49682515886, 10089.09198172168, 6344.270408903035, 7198.856022879618, 7418.332350088518, 7739.806504837424, 7890.9605451972375, 8103.027636683636, 8103.756887293391, 8118.715844945398, 8137.511749295061, 8147.470414423044, 7348.853022939618, 7360.926390736238, 7379.372753316028, 7438.739644112647, 7629.46593738433, 7409.962950185214, 7431.071116110486, 7481.551106933602, 7483.663235154322, 7553.206913274027, 7923.801904952422, 7940.761777146695, 7957.084935232291, 7964.522128672298, 7987.121416644049, 7019.719211231493, 7046.048783414173, 7049.365557099885, 7058.505904586629, 7159.8568028640175, 7349.338559529668, 7367.5211111277595, 7397.778066658009, 7407.296306850841, 7411.888821667787], "unit": "score", "name": "mootools.html", "value": 4774.596441039621}, {"lowerIsBetter": false, "replicates": [333.5580356028263, 341.1369235833342, 342.7378055787323, 344.29247895574593, 345.11478058779227, 5925.0, 5933.110033494978, 5948.078047902572, 5981.342052374235, 6018.007028840236, 5902.970485147579, 5908.645481271126, 5919.615225010371, 5928.199693041438, 5932.584719069667, 4389.824407023715, 4458.843940462085, 4538.954610453886, 4580.473245576752, 4582.427196600425, 4622.8150873965005, 4632.606228470584, 4635.652326075541, 4644.489106198315, 4646.303054541829, 4606.493285738566, 4610.423697037871, 4611.976940115294, 4616.676832621718, 4620.607248383892, 4378.781060946956, 4471.7987690554, 4581.5647513486165, 4599.563041511051, 4615.053913947632, 4054.067564460161, 4056.7565946043333, 4061.2486689962157, 4061.97969010156, 4077.1641813428178, 5575.52608028314, 5586.804461843816, 5586.888262234733, 5590.86022849428, 5596.1605759136455, 5322.121849894763, 5333.839984800462, 5336.039512887679, 5336.573074154058, 5340.172273297645, 6225.252969643627, 6226.25284965807, 6227.87544249117, 6239.344868788758, 6244.281907580641, 4238.279492486285, 4404.031113155101, 4415.977920110411, 4483.865484035484, 4499.61753250974, 6470.708818103197, 6501.187351581052, 6504.121943537609, 6522.608643481359, 6546.0835483032415, 4441.133978874089, 4448.644108471314, 4451.087527056946, 4456.086502267028, 4462.576055274743, 4509.075639493896, 4519.7740112994215, 4521.525239849834, 4529.275315949432, 4530.682852200381, 5220.321358223407, 5224.242484839677, 5224.52979231871, 5229.764660590283, 5230.973845130826, 6029.698515074228, 6315.747370105144, 6319.842003949938, 6323.873522529616, 6326.49388048955, 1561.7032763775073, 1577.897436666613, 1586.7937168168064, 1590.8886377953663, 1591.7134915715283, 979.774651830083, 1009.1926458833051, 1029.25893356783, 1037.7872536130076, 1060.1412855587, 5866.6186697864505, 5928.614640048383, 5932.228810254725, 6010.489108425745, 6035.758569657252, 6391.201099862517, 6401.743930242738, 6402.967985160044, 6406.487481001509, 6418.903716444257, 5983.311919129269, 5994.670293133832, 6004.42957918997, 6005.159277701126, 6019.909701354483, 3397.286569820316, 3408.744344174197, 3435.7766745161484, 3437.05480992729, 3445.586529616462, 6511.0558968949235, 6614.603123812587, 6652.234992975869, 6665.766698165541, 6674.365935236145, 6574.474042076622, 6589.80230593083, 6604.3395660434535, 6608.8347791305605, 6629.3370662934285, 6604.834879127964, 6612.966935165294, 6614.735410583523, 6621.470282377494, 6625.138731964814, 6383.202099737533, 6386.201724784402, 6390.968045159931, 6399.520035997226, 6402.167718196791, 6173.84565385869, 6314.989601663896, 6321.620702757849, 6325.841853953688, 6329.082283069021, 6589.110470086477, 6594.868102638016, 6616.966915165393, 6629.171353580802, 6647.069410282661, 4398.164348773723, 4398.416570034721, 4403.383526306384, 4414.359917811835, 4420.7126536775, 6389.744410223539, 6390.64851433157, 6396.680165991775, 6433.5496515243485, 6456.386643268882, 6211.316755156839, 6215.564910456224, 6217.191765070512, 6222.782202622887, 6225.315215326401, 6079.696015199311, 6209.223847019122, 6230.532710046674, 6234.251889773256, 6239.251289845248, 6088.208532890696, 6097.390260973867, 6110.908336375047, 6113.786017489367, 6116.082587611716, 6232.5637205397, 6242.3133455320785, 6287.434130928238, 6320.115183874169, 6321.020241862519, 5902.498287645598, 5987.700614969147, 6067.059605761114, 6110.541709371726, 6124.816255512342], "unit": "score", "name": "prototype.html", "value": 4721.945532559826}, {"lowerIsBetter": false, "replicates": [737.4248086492536, 773.4817672159652, 795.8845967334737, 802.9036515618127, 824.7690646618948, 12715.109942304043, 13035.348232588356, 13124.868751312484, 13126.0, 13164.802527962076, 13003.934980325084, 13034.934825325883, 13037.348132593379, 13044.0, 13087.9529637629, 748.6705849426248, 914.1909410172012, 936.372630337672, 938.2540880000416, 938.6714649872524, 913.8720579118929, 924.944503329799, 928.0997432490507, 928.331601247101, 928.7120992492315, 799.856025915335, 969.2682025071061, 972.9610815567369, 975.687779910429, 976.3409698453551, 940.4357385568672, 951.6574033347989, 956.7273327101777, 957.25812495316, 958.4345236310576, 701.7333413302963, 709.4182770128497, 709.5494361080699, 710.2506855267691, 710.5097482736895, 13481.191128532222, 13558.050936434454, 13581.728365432637, 13590.184588924696, 13599.932000340033, 13013.0, 13617.046806723532, 13659.795103073462, 13765.105268157538, 13836.377363018688, 10714.142868570496, 10870.510827012804, 10876.0, 10898.400587967659, 11161.38612376319, 3848.672862806665, 3858.536975562922, 3917.9608203918165, 3948.605139486057, 3972.7219094663387, 49248.0, 49382.25926611104, 49411.0, 49472.0, 49509.0, 10517.158627309796, 10611.628592999363, 10669.41318227505, 10951.507182176661, 11015.889841101487, 19355.09463339186, 19404.70892936579, 19548.902255488916, 19615.509612259808, 19650.0, 7710.383169346439, 7710.498817576839, 7727.729529466442, 7835.569043702537, 8137.308328792001, 4452.933206001912, 4469.843555475542, 4479.417675702138, 4524.276115821453, 4539.5460453955, 3279.5900512435946, 3306.156929982887, 3308.966910330866, 3310.1062713067336, 3310.503424486298, 593.6675461741438, 597.2146627185324, 597.5667640960269, 612.5191724496249, 615.0865964043392, 651.1957732200729, 731.8865575835754, 737.7749786315226, 743.1231147246193, 758.9772306830804, 8844.248104590792, 8859.202671759573, 8967.551622418983, 9067.501287429255, 9169.436538423257, 650.7039297119799, 718.2386670129679, 720.2977097330062, 744.0104660801121, 744.3040756892215, 4118.52636946755, 4209.200251952119, 4209.200251952119, 4323.783810809447, 4402.987312918047, 57911.710441447525, 58133.709331453916, 58951.41048589545, 62951.6852415735, 64776.0, 49199.0, 50682.23976640353, 50913.745431272604, 51149.74425127925, 51355.74322128366, 46371.5362846374, 46769.766151169024, 47142.5285747145, 47272.0, 47657.76171119122, 9064.706586348386, 9168.220701240203, 9224.0, 9356.719298421058, 9462.621495140118, 34788.478172827934, 34913.82543087268, 35042.0, 35195.0, 36333.0916727084, 39749.80125099356, 39956.80021599874, 44506.777466112464, 44853.10293794171, 45044.32433513566, 11617.128715346214, 11926.224795388272, 12120.151589388659, 12367.443465043914, 12422.192557483735, 12443.93778031104, 12588.181768185039, 13602.0, 13813.51652692151, 13881.0, 11823.0, 12026.579069732517, 12532.874671253536, 13018.739625207632, 13059.542915997894, 11433.771324573629, 11676.824847627122, 12020.278783273032, 12239.510419583474, 12857.228566286052, 11855.229410088317, 12028.15802893789, 12252.142350035412, 12371.195872268274, 12410.627681169579, 10088.546015429176, 10100.090991810772, 10241.334313269614, 10371.688849334532, 10502.894971050497, 10289.794204115726, 10346.275760696679, 10351.948240258751, 10426.165906727596, 10440.530176142243], "unit": "score", "name": "yui.html", "value": 6684.490922658242}], "name": "dromaeo_css", "value": 7189.265136431263}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 109.0, 113.0, 113.0, 99.0, 110.0, 108.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [159.0, 134.0, 161.0, 167.0, 134.0, 158.0, 159.0, 134.0, 186.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 152.0}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 163.0, 161.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 77.0, 159.0, 79.0, 77.0, 73.0, 76.0, 164.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.1}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 147.0, 93.0, 93.0, 93.0, 143.0, 93.0, 92.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 55.0, 55.0, 55.0, 56.0, 64.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 65.0, 66.0, 64.0, 67.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [84.0, 78.0, 85.0, 78.0, 77.0, 78.0, 77.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 111.0, 112.0, 113.0, 114.0, 117.0, 117.0, 114.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.5}, {"lowerIsBetter": true, "replicates": [144.0, 144.0, 143.0, 141.0, 143.0, 136.0, 144.0, 153.0, 156.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 67.0, 68.0, 66.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1509.8}]} 09:42:18 INFO - Return code: 0 09:42:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:42:18 INFO - # TBPL SUCCESS # 09:42:18 INFO - Running post-action listener: _resource_record_post_action 09:42:18 INFO - Running post-run listener: _resource_record_post_run 09:42:19 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 278528; Write bytes: 264036352; Read time: 40; Write time: 206444 09:42:19 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 14024704; Read time: 0; Write time: 4432 09:42:19 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 278528; Write bytes: 250011648; Read time: 40; Write time: 202012 09:42:19 INFO - Running post-run listener: _upload_blobber_files 09:42:19 INFO - Blob upload gear active. 09:42:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:42:19 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 09:42:19 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'] 09:42:19 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 09:42:19 INFO - (blobuploader) - INFO - Open directory for files ... 09:42:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:42:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:42:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:20 INFO - (blobuploader) - INFO - Done attempting. 09:42:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:42:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:42:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:21 INFO - (blobuploader) - INFO - Done attempting. 09:42:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:42:21 INFO - Return code: 0 09:42:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:42:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:42:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9724245cdc9c89b3eece5266e3c2f4c8867de533aad8c5eec4aa4fcc599fc1b9c1bf1dccad0deb667832c986d10dd845043c2458b8c3f923cf7e5c27d7fd897", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69d87b1b593b2a8e8a199a81f36fa7d85d8469778a2a53e3a94f4365572e65f5188ff8956855aa20a2aad8defe322fe8ee3792b47d5c7f6c05d0f97e2ff01e3"} 09:42:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:42:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:42:21 INFO - Contents: 09:42:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9724245cdc9c89b3eece5266e3c2f4c8867de533aad8c5eec4aa4fcc599fc1b9c1bf1dccad0deb667832c986d10dd845043c2458b8c3f923cf7e5c27d7fd897", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69d87b1b593b2a8e8a199a81f36fa7d85d8469778a2a53e3a94f4365572e65f5188ff8956855aa20a2aad8defe322fe8ee3792b47d5c7f6c05d0f97e2ff01e3"} 09:42:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:42:21 INFO - Copying logs to upload dir... 09:42:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:42:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.913330 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-04-19 09:42:21.248459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 09:42:21.252504) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9724245cdc9c89b3eece5266e3c2f4c8867de533aad8c5eec4aa4fcc599fc1b9c1bf1dccad0deb667832c986d10dd845043c2458b8c3f923cf7e5c27d7fd897", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69d87b1b593b2a8e8a199a81f36fa7d85d8469778a2a53e3a94f4365572e65f5188ff8956855aa20a2aad8defe322fe8ee3792b47d5c7f6c05d0f97e2ff01e3"} build_url:https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/X_NuPN6hS1WfxbJ25QPWhw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9724245cdc9c89b3eece5266e3c2f4c8867de533aad8c5eec4aa4fcc599fc1b9c1bf1dccad0deb667832c986d10dd845043c2458b8c3f923cf7e5c27d7fd897", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69d87b1b593b2a8e8a199a81f36fa7d85d8469778a2a53e3a94f4365572e65f5188ff8956855aa20a2aad8defe322fe8ee3792b47d5c7f6c05d0f97e2ff01e3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 09:42:21.278051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:42:21.278430) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1461072677.474548-1018105059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 09:42:21.362352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 09:42:21.362715) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 09:42:21.363097) ========= ========= Total master_lag: 0.18 =========