builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1464629387.95 results: success (0) buildid: 20160530075039 builduid: c46f238fe5414d5db0817f0b0fedddd7 revision: c74c00d5cd6fb5b82239ecf337067dbfd103e2d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:47.950079) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:47.950651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:47.950953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:47.970670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:47.971061) ========= 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=7de08804244eb36560b44971000001c3-1464629386.730812-259093068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 10:29:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-05-30 10:29:48 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157870 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:48.143508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:48.143900) ========= 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=7de08804244eb36560b44971000001c3-1464629386.730812-259093068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012977 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:48.193607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:48.193978) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c74c00d5cd6fb5b82239ecf337067dbfd103e2d2 --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 c74c00d5cd6fb5b82239ecf337067dbfd103e2d2 --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=7de08804244eb36560b44971000001c3-1464629386.730812-259093068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 10:29:48,239 truncating revision to first 12 chars 2016-05-30 10:29:48,239 Setting DEBUG logging. 2016-05-30 10:29:48,240 attempt 1/10 2016-05-30 10:29:48,240 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c74c00d5cd6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 10:29:48,585 unpacking tar archive at: mozilla-aurora-c74c00d5cd6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684941 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:48.892847) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:48.893230) ========= script_repo_revision: c74c00d5cd6fb5b82239ecf337067dbfd103e2d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:48.893657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:48.893940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 10:29:48.904243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 10:29:48.904633) ========= /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=7de08804244eb36560b44971000001c3-1464629386.730812-259093068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:29:49 INFO - MultiFileLogger online at 20160530 10:29:49 in /builds/slave/test 10:29:49 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 10:29:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:29:49 INFO - {'append_to_log': False, 10:29:49 INFO - 'base_work_dir': '/builds/slave/test', 10:29:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:29:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:29:49 INFO - 'branch': 'Mozilla-Aurora', 10:29:49 INFO - 'buildbot_json_path': 'buildprops.json', 10:29:49 INFO - 'config_files': ('talos/linux_config.py',), 10:29:49 INFO - 'default_actions': ('clobber', 10:29:49 INFO - 'read-buildbot-config', 10:29:49 INFO - 'download-and-extract', 10:29:49 INFO - 'populate-webroot', 10:29:49 INFO - 'create-virtualenv', 10:29:49 INFO - 'install', 10:29:49 INFO - 'run-tests'), 10:29:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:29:49 INFO - 'download_minidump_stackwalk': True, 10:29:49 INFO - 'download_symbols': 'ondemand', 10:29:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:29:49 INFO - 'tooltool.py': '/tools/tooltool.py', 10:29:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:29:49 INFO - '/tools/misc-python/virtualenv.py')}, 10:29:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:29:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:29:49 INFO - 'installer_path': 'installer.exe', 10:29:49 INFO - 'log_level': 'info', 10:29:49 INFO - 'log_name': 'talos', 10:29:49 INFO - 'log_to_console': True, 10:29:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:29:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:29:49 INFO - 'opt_config_files': (), 10:29:49 INFO - 'pip_index': False, 10:29:49 INFO - 'sps_profile': False, 10:29:49 INFO - 'sps_profile_interval': 0, 10:29:49 INFO - 'suite': 'dromaeojs', 10:29:49 INFO - 'system_bits': '32', 10:29:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:29:49 INFO - 'title': 'talos-linux64-ix-003', 10:29:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:29:49 INFO - 'use_talos_json': True, 10:29:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:29:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:29:49 INFO - 'work_dir': 'build'} 10:29:49 INFO - ##### 10:29:49 INFO - ##### Running clobber step. 10:29:49 INFO - ##### 10:29:49 INFO - Running pre-action listener: _resource_record_pre_action 10:29:49 INFO - Running main action method: clobber 10:29:49 INFO - rmtree: /builds/slave/test/build 10:29:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:29:49 INFO - Running post-action listener: _resource_record_post_action 10:29:49 INFO - ##### 10:29:49 INFO - ##### Running read-buildbot-config step. 10:29:49 INFO - ##### 10:29:49 INFO - Running pre-action listener: _resource_record_pre_action 10:29:49 INFO - Running main action method: read_buildbot_config 10:29:49 INFO - Using buildbot properties: 10:29:49 INFO - { 10:29:49 INFO - "project": "", 10:29:49 INFO - "product": "firefox", 10:29:49 INFO - "script_repo_revision": "production", 10:29:49 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:29:49 INFO - "repository": "", 10:29:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:29:49 INFO - "buildid": "20160530075039", 10:29:49 INFO - "pgo_build": "True", 10:29:49 INFO - "basedir": "/builds/slave/test", 10:29:49 INFO - "buildnumber": 274, 10:29:49 INFO - "slavename": "talos-linux64-ix-003", 10:29:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:29:49 INFO - "platform": "ubuntu64_hw", 10:29:49 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:29:49 INFO - "branch": "mozilla-aurora", 10:29:49 INFO - "repo_path": "releases/mozilla-aurora", 10:29:49 INFO - "revision": "c74c00d5cd6fb5b82239ecf337067dbfd103e2d2", 10:29:49 INFO - "stage_platform": "linux64-pgo", 10:29:49 INFO - "builduid": "c46f238fe5414d5db0817f0b0fedddd7", 10:29:49 INFO - "slavebuilddir": "test" 10:29:49 INFO - } 10:29:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:29:49 INFO - Running post-action listener: _resource_record_post_action 10:29:49 INFO - ##### 10:29:49 INFO - ##### Running download-and-extract step. 10:29:49 INFO - ##### 10:29:49 INFO - Running pre-action listener: _resource_record_pre_action 10:29:49 INFO - Running main action method: download_and_extract 10:29:49 INFO - mkdir: /builds/slave/test/build/tests 10:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:49 INFO - https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:29:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:29:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:29:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:29:50 INFO - Downloaded 1361 bytes. 10:29:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:29:50 INFO - Using the following test package requirements: 10:29:50 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:29:50 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:29:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:29:50 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:29:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:29:50 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:29:50 INFO - u'jsshell-linux-x86_64.zip'], 10:29:50 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:29:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:29:50 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:29:50 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:29:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:29:50 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:29:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:29:50 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:29:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:29:50 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:29:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:29:50 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:50 INFO - https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:29:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:29:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:29:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:29:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:29:51 INFO - Downloaded 24174004 bytes. 10:29:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:29:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:29:52 INFO - Return code: 0 10:29:52 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:52 INFO - https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:29:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:29:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:29:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:29:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:29:54 INFO - Downloaded 24174004 bytes. 10:29:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:29:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:29:55 INFO - Return code: 0 10:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:55 INFO - https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:29:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:29:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:29:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:29:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:29:56 INFO - Downloaded 10840145 bytes. 10:29:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:29:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:29:57 INFO - Return code: 0 10:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:57 INFO - https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:29:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:29:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:29:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:29:58 INFO - Downloaded 62789394 bytes. 10:29:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:29:58 INFO - mkdir: /builds/slave/test/properties 10:29:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:29:58 INFO - Writing to file /builds/slave/test/properties/build_url 10:29:58 INFO - Contents: 10:29:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:29:59 INFO - Running post-action listener: _resource_record_post_action 10:29:59 INFO - Running post-action listener: set_extra_try_arguments 10:29:59 INFO - ##### 10:29:59 INFO - ##### Running populate-webroot step. 10:29:59 INFO - ##### 10:29:59 INFO - Running pre-action listener: _resource_record_pre_action 10:29:59 INFO - Running main action method: populate_webroot 10:29:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:29:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:29:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:29:59 INFO - '--tppagecycles', 10:29:59 INFO - '7'], 10:29:59 INFO - 'tests': ['tsvgm']}}, 10:29:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:29:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:29:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:29:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:29:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:59 INFO - 'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:59 INFO - 'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['damp', 'tps']}, 10:29:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:59 INFO - 'tests': ['damp', 'tps']}, 10:29:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['dromaeo_dom']}, 10:29:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:29:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['a11yr', 10:29:59 INFO - 'ts_paint', 10:29:59 INFO - 'tpaint', 10:29:59 INFO - 'sessionrestore', 10:29:59 INFO - 'sessionrestore_no_auto_restore', 10:29:59 INFO - 'tabpaint']}, 10:29:59 INFO - 'other-e10s': {'tests': ['a11yr', 10:29:59 INFO - 'ts_paint', 10:29:59 INFO - 'tpaint', 10:29:59 INFO - 'sessionrestore', 10:29:59 INFO - 'sessionrestore_no_auto_restore', 10:29:59 INFO - 'tabpaint']}, 10:29:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:29:59 INFO - 'ts_paint', 10:29:59 INFO - 'tpaint', 10:29:59 INFO - 'sessionrestore', 10:29:59 INFO - 'sessionrestore_no_auto_restore', 10:29:59 INFO - 'tabpaint']}, 10:29:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:29:59 INFO - 'ts_paint', 10:29:59 INFO - 'tpaint', 10:29:59 INFO - 'sessionrestore', 10:29:59 INFO - 'sessionrestore_no_auto_restore', 10:29:59 INFO - 'tabpaint']}, 10:29:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['a11yr', 10:29:59 INFO - 'ts_paint', 10:29:59 INFO - 'tpaint', 10:29:59 INFO - 'sessionrestore', 10:29:59 INFO - 'sessionrestore_no_auto_restore', 10:29:59 INFO - 'tabpaint']}, 10:29:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['a11yr', 10:29:59 INFO - 'ts_paint', 10:29:59 INFO - 'tpaint', 10:29:59 INFO - 'sessionrestore', 10:29:59 INFO - 'sessionrestore_no_auto_restore', 10:29:59 INFO - 'tabpaint']}, 10:29:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['tsvgx', 10:29:59 INFO - 'tsvgr_opacity', 10:29:59 INFO - 'tart', 10:29:59 INFO - 'tscrollx', 10:29:59 INFO - 'cart']}, 10:29:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:29:59 INFO - 'tsvgr_opacity', 10:29:59 INFO - 'tart', 10:29:59 INFO - 'tscrollx', 10:29:59 INFO - 'cart']}, 10:29:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:59 INFO - 'talos_options': ['--disable-e10s'], 10:29:59 INFO - 'tests': ['tp5o']}, 10:29:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:59 INFO - 'tests': ['tp5o']}, 10:29:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:59 INFO - 'talos_options': ['--disable-e10s', 10:29:59 INFO - '--xperf_path', 10:29:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:59 INFO - 'tests': ['tp5n']}, 10:29:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:59 INFO - 'talos_options': ['--xperf_path', 10:29:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:59 INFO - 'tests': ['tp5n']}}, 10:29:59 INFO - 'talos.zip': {'path': '', 10:29:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:29:59 INFO - Running post-action listener: _resource_record_post_action 10:29:59 INFO - ##### 10:29:59 INFO - ##### Running create-virtualenv step. 10:29:59 INFO - ##### 10:29:59 INFO - Running pre-action listener: _resource_record_pre_action 10:29:59 INFO - Running main action method: create_virtualenv 10:29:59 INFO - Creating virtualenv /builds/slave/test/build/venv 10:29:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:29:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:29:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:29:59 INFO - Using real prefix '/usr' 10:29:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:30:00 INFO - Installing distribute.............................................................................................................................................................................................done. 10:30:02 INFO - Installing pip.................done. 10:30:02 INFO - Return code: 0 10:30:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:02 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 0x7f53f217ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, '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': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:30:02 INFO - Using env: {'DISPLAY': ':0', 10:30:02 INFO - 'HOME': '/home/cltbld', 10:30:02 INFO - 'LANG': 'en_US.UTF-8', 10:30:02 INFO - 'LANGUAGE': 'en_US:en', 10:30:02 INFO - 'LOGNAME': 'cltbld', 10:30:02 INFO - 'MAIL': '/var/mail/cltbld', 10:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:02 INFO - 'MOZ_NO_REMOTE': '1', 10:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:02 INFO - 'NO_EM_RESTART': '1', 10:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:02 INFO - 'PWD': '/builds/slave/test', 10:30:02 INFO - 'SHELL': '/bin/bash', 10:30:02 INFO - 'SHLVL': '1', 10:30:02 INFO - 'TERM': 'linux', 10:30:02 INFO - 'TMOUT': '86400', 10:30:02 INFO - 'USER': 'cltbld', 10:30:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:02 INFO - '_': '/tools/buildbot/bin/python'} 10:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:30:02 INFO - Cleaning up... 10:30:02 INFO - Return code: 0 10:30:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:02 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 0x7f53f217ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, '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': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:02 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 10:30:02 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 10:30:02 INFO - Using env: {'DISPLAY': ':0', 10:30:02 INFO - 'HOME': '/home/cltbld', 10:30:02 INFO - 'LANG': 'en_US.UTF-8', 10:30:02 INFO - 'LANGUAGE': 'en_US:en', 10:30:02 INFO - 'LOGNAME': 'cltbld', 10:30:02 INFO - 'MAIL': '/var/mail/cltbld', 10:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:02 INFO - 'MOZ_NO_REMOTE': '1', 10:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:02 INFO - 'NO_EM_RESTART': '1', 10:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:02 INFO - 'PWD': '/builds/slave/test', 10:30:02 INFO - 'SHELL': '/bin/bash', 10:30:02 INFO - 'SHLVL': '1', 10:30:02 INFO - 'TERM': 'linux', 10:30:02 INFO - 'TMOUT': '86400', 10:30:02 INFO - 'USER': 'cltbld', 10:30:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:02 INFO - '_': '/tools/buildbot/bin/python'} 10:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:03 INFO - Downloading/unpacking psutil>=0.7.1 10:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:30:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:30:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:30:05 INFO - Installing collected packages: psutil 10:30:05 INFO - Running setup.py install for psutil 10:30:05 INFO - building 'psutil._psutil_linux' extension 10:30:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:30:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:30:09 INFO - building 'psutil._psutil_posix' extension 10:30:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:30:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:30:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:30:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:30:09 INFO - Successfully installed psutil 10:30:09 INFO - Cleaning up... 10:30:09 INFO - Return code: 0 10:30:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:09 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 0x7f53f217ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, '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': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:09 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 10:30:09 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 10:30:09 INFO - Using env: {'DISPLAY': ':0', 10:30:09 INFO - 'HOME': '/home/cltbld', 10:30:09 INFO - 'LANG': 'en_US.UTF-8', 10:30:09 INFO - 'LANGUAGE': 'en_US:en', 10:30:09 INFO - 'LOGNAME': 'cltbld', 10:30:09 INFO - 'MAIL': '/var/mail/cltbld', 10:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:09 INFO - 'MOZ_NO_REMOTE': '1', 10:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:09 INFO - 'NO_EM_RESTART': '1', 10:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:09 INFO - 'PWD': '/builds/slave/test', 10:30:09 INFO - 'SHELL': '/bin/bash', 10:30:09 INFO - 'SHLVL': '1', 10:30:09 INFO - 'TERM': 'linux', 10:30:09 INFO - 'TMOUT': '86400', 10:30:09 INFO - 'USER': 'cltbld', 10:30:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:09 INFO - '_': '/tools/buildbot/bin/python'} 10:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:30:11 INFO - Installing collected packages: mozsystemmonitor 10:30:11 INFO - Running setup.py install for mozsystemmonitor 10:30:12 INFO - Successfully installed mozsystemmonitor 10:30:12 INFO - Cleaning up... 10:30:12 INFO - Return code: 0 10:30:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:12 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 0x7f53f217ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, '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': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:30:12 INFO - Using env: {'DISPLAY': ':0', 10:30:12 INFO - 'HOME': '/home/cltbld', 10:30:12 INFO - 'LANG': 'en_US.UTF-8', 10:30:12 INFO - 'LANGUAGE': 'en_US:en', 10:30:12 INFO - 'LOGNAME': 'cltbld', 10:30:12 INFO - 'MAIL': '/var/mail/cltbld', 10:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:12 INFO - 'MOZ_NO_REMOTE': '1', 10:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:12 INFO - 'NO_EM_RESTART': '1', 10:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:12 INFO - 'PWD': '/builds/slave/test', 10:30:12 INFO - 'SHELL': '/bin/bash', 10:30:12 INFO - 'SHLVL': '1', 10:30:12 INFO - 'TERM': 'linux', 10:30:12 INFO - 'TMOUT': '86400', 10:30:12 INFO - 'USER': 'cltbld', 10:30:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:12 INFO - '_': '/tools/buildbot/bin/python'} 10:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:12 INFO - Downloading/unpacking blobuploader==1.2.4 10:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:14 INFO - Downloading blobuploader-1.2.4.tar.gz 10:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:30:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:30:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:14 INFO - Downloading docopt-0.6.1.tar.gz 10:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:30:15 INFO - Installing collected packages: blobuploader, requests, docopt 10:30:15 INFO - Running setup.py install for blobuploader 10:30:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:30:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:30:15 INFO - Running setup.py install for requests 10:30:15 INFO - Running setup.py install for docopt 10:30:15 INFO - Successfully installed blobuploader requests docopt 10:30:15 INFO - Cleaning up... 10:30:15 INFO - Return code: 0 10:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:15 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 0x7f53f217ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, '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': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:30:15 INFO - Using env: {'DISPLAY': ':0', 10:30:15 INFO - 'HOME': '/home/cltbld', 10:30:15 INFO - 'LANG': 'en_US.UTF-8', 10:30:15 INFO - 'LANGUAGE': 'en_US:en', 10:30:15 INFO - 'LOGNAME': 'cltbld', 10:30:15 INFO - 'MAIL': '/var/mail/cltbld', 10:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:15 INFO - 'MOZ_NO_REMOTE': '1', 10:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:15 INFO - 'NO_EM_RESTART': '1', 10:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:15 INFO - 'PWD': '/builds/slave/test', 10:30:15 INFO - 'SHELL': '/bin/bash', 10:30:15 INFO - 'SHLVL': '1', 10:30:15 INFO - 'TERM': 'linux', 10:30:15 INFO - 'TMOUT': '86400', 10:30:15 INFO - 'USER': 'cltbld', 10:30:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:15 INFO - '_': '/tools/buildbot/bin/python'} 10:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:30:15 INFO - Running setup.py (path:/tmp/pip-4l7L1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:30:15 INFO - Running setup.py (path:/tmp/pip-fpgVmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:30:15 INFO - Running setup.py (path:/tmp/pip-C8axwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:30:16 INFO - Running setup.py (path:/tmp/pip-wsMswo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:30:16 INFO - Running setup.py (path:/tmp/pip-OBLtcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:30:16 INFO - Running setup.py (path:/tmp/pip-qPVo79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:30:16 INFO - Running setup.py (path:/tmp/pip-d7F4gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:30:16 INFO - Running setup.py (path:/tmp/pip-KdFcvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:30:16 INFO - Running setup.py (path:/tmp/pip-rV1BCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:30:16 INFO - Running setup.py (path:/tmp/pip-rpb0DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:30:16 INFO - Running setup.py (path:/tmp/pip-0Yu9On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:30:16 INFO - Running setup.py (path:/tmp/pip-z4Q_G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:30:16 INFO - Running setup.py (path:/tmp/pip-k3r0Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:30:16 INFO - Running setup.py (path:/tmp/pip-gsmCSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:30:16 INFO - Running setup.py (path:/tmp/pip-Z_s2Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:30:16 INFO - Running setup.py (path:/tmp/pip-nbLPWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:30:16 INFO - Running setup.py (path:/tmp/pip-sGdKHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:30:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:30:17 INFO - Running setup.py install for manifestparser 10:30:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:30:17 INFO - Running setup.py install for mozcrash 10:30:17 INFO - Running setup.py install for mozdebug 10:30:17 INFO - Running setup.py install for mozdevice 10:30:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:30:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:30:17 INFO - Running setup.py install for mozfile 10:30:17 INFO - Running setup.py install for mozhttpd 10:30:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:30:17 INFO - Running setup.py install for mozinfo 10:30:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:30:17 INFO - Running setup.py install for mozInstall 10:30:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:30:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:30:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:30:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:30:17 INFO - Running setup.py install for mozleak 10:30:17 INFO - Running setup.py install for mozlog 10:30:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:30:18 INFO - Running setup.py install for moznetwork 10:30:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:30:18 INFO - Running setup.py install for mozprocess 10:30:18 INFO - Running setup.py install for mozprofile 10:30:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:30:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:30:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:30:18 INFO - Running setup.py install for mozrunner 10:30:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:30:18 INFO - Running setup.py install for mozscreenshot 10:30:18 INFO - Running setup.py install for moztest 10:30:18 INFO - Running setup.py install for mozversion 10:30:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:30:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:30:18 INFO - Cleaning up... 10:30:18 INFO - Return code: 0 10:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:18 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 0x7f53f217ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, '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': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:30:18 INFO - Using env: {'DISPLAY': ':0', 10:30:18 INFO - 'HOME': '/home/cltbld', 10:30:18 INFO - 'LANG': 'en_US.UTF-8', 10:30:18 INFO - 'LANGUAGE': 'en_US:en', 10:30:18 INFO - 'LOGNAME': 'cltbld', 10:30:18 INFO - 'MAIL': '/var/mail/cltbld', 10:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:18 INFO - 'MOZ_NO_REMOTE': '1', 10:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:18 INFO - 'NO_EM_RESTART': '1', 10:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:18 INFO - 'PWD': '/builds/slave/test', 10:30:18 INFO - 'SHELL': '/bin/bash', 10:30:18 INFO - 'SHLVL': '1', 10:30:18 INFO - 'TERM': 'linux', 10:30:18 INFO - 'TMOUT': '86400', 10:30:18 INFO - 'USER': 'cltbld', 10:30:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:18 INFO - '_': '/tools/buildbot/bin/python'} 10:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:30:19 INFO - Running setup.py (path:/tmp/pip-YC3OIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:30:19 INFO - Running setup.py (path:/tmp/pip-5jqvPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:30:19 INFO - Running setup.py (path:/tmp/pip-h9MgX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:30:19 INFO - Running setup.py (path:/tmp/pip-379jUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:30:19 INFO - Running setup.py (path:/tmp/pip-DnnRgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:30:19 INFO - Running setup.py (path:/tmp/pip-1sHq4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:30:19 INFO - Running setup.py (path:/tmp/pip-4bfkZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:30:19 INFO - Running setup.py (path:/tmp/pip-uHQiJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:30:19 INFO - Running setup.py (path:/tmp/pip-0ArBC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:30:19 INFO - Running setup.py (path:/tmp/pip-mAWYu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:30:19 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)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:30:19 INFO - Running setup.py (path:/tmp/pip-nXRRis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:30:19 INFO - Running setup.py (path:/tmp/pip-8AJc4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:30:19 INFO - Running setup.py (path:/tmp/pip-3zNqTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:30: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)) 10:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:30:20 INFO - Running setup.py (path:/tmp/pip-3nru6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:30: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)) 10:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:30:20 INFO - Running setup.py (path:/tmp/pip-KStyzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:30:20 INFO - Running setup.py (path:/tmp/pip-mDGdUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:30:20 INFO - Running setup.py (path:/tmp/pip-PB8q_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:30:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:22 INFO - Downloading blessings-1.6.tar.gz 10:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:30:22 INFO - Installing collected packages: blessings 10:30:22 INFO - Running setup.py install for blessings 10:30:22 INFO - Successfully installed blessings 10:30:22 INFO - Cleaning up... 10:30:22 INFO - Return code: 0 10:30:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:30:22 INFO - Reading from file tmpfile_stdout 10:30:22 INFO - Current package versions: 10:30:22 INFO - argparse == 1.2.1 10:30:22 INFO - blessings == 1.6 10:30:22 INFO - blobuploader == 1.2.4 10:30:22 INFO - docopt == 0.6.1 10:30:22 INFO - manifestparser == 1.1 10:30:22 INFO - mozInstall == 1.12 10:30:22 INFO - mozcrash == 0.17 10:30:22 INFO - mozdebug == 0.1 10:30:22 INFO - mozdevice == 0.48 10:30:22 INFO - mozfile == 1.2 10:30:22 INFO - mozhttpd == 0.7 10:30:22 INFO - mozinfo == 0.9 10:30:22 INFO - mozleak == 0.1 10:30:22 INFO - mozlog == 3.1 10:30:22 INFO - moznetwork == 0.27 10:30:22 INFO - mozprocess == 0.22 10:30:22 INFO - mozprofile == 0.28 10:30:22 INFO - mozrunner == 6.11 10:30:22 INFO - mozscreenshot == 0.1 10:30:22 INFO - mozsystemmonitor == 0.0 10:30:22 INFO - moztest == 0.7 10:30:22 INFO - mozversion == 1.4 10:30:22 INFO - psutil == 3.1.1 10:30:22 INFO - requests == 1.2.3 10:30:22 INFO - wsgiref == 0.1.2 10:30:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:30: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')]} 10:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30: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')]} 10:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:22 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 0x7f53f217ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, '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': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:30:22 INFO - Using env: {'DISPLAY': ':0', 10:30:22 INFO - 'HOME': '/home/cltbld', 10:30:22 INFO - 'LANG': 'en_US.UTF-8', 10:30:22 INFO - 'LANGUAGE': 'en_US:en', 10:30:22 INFO - 'LOGNAME': 'cltbld', 10:30:22 INFO - 'MAIL': '/var/mail/cltbld', 10:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:22 INFO - 'MOZ_NO_REMOTE': '1', 10:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:22 INFO - 'NO_EM_RESTART': '1', 10:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:22 INFO - 'PWD': '/builds/slave/test', 10:30:22 INFO - 'SHELL': '/bin/bash', 10:30:22 INFO - 'SHLVL': '1', 10:30:22 INFO - 'TERM': 'linux', 10:30:22 INFO - 'TMOUT': '86400', 10:30:22 INFO - 'USER': 'cltbld', 10:30:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:22 INFO - '_': '/tools/buildbot/bin/python'} 10:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:30:22 INFO - Cleaning up... 10:30:22 INFO - Return code: 0 10:30:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:30: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')]} 10:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30: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')]} 10:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:22 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 0x7f53f217ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, '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': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:30:22 INFO - Using env: {'DISPLAY': ':0', 10:30:22 INFO - 'HOME': '/home/cltbld', 10:30:22 INFO - 'LANG': 'en_US.UTF-8', 10:30:22 INFO - 'LANGUAGE': 'en_US:en', 10:30:22 INFO - 'LOGNAME': 'cltbld', 10:30:22 INFO - 'MAIL': '/var/mail/cltbld', 10:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:22 INFO - 'MOZ_NO_REMOTE': '1', 10:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:22 INFO - 'NO_EM_RESTART': '1', 10:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:22 INFO - 'PWD': '/builds/slave/test', 10:30:22 INFO - 'SHELL': '/bin/bash', 10:30:22 INFO - 'SHLVL': '1', 10:30:22 INFO - 'TERM': 'linux', 10:30:22 INFO - 'TMOUT': '86400', 10:30:22 INFO - 'USER': 'cltbld', 10:30:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:22 INFO - '_': '/tools/buildbot/bin/python'} 10:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:23 INFO - Downloading/unpacking jsonschema 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:30:25 INFO - Downloading/unpacking functools32 (from jsonschema) 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30:25 INFO - Downloading functools32-3.2.3-2.tar.gz 10:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:30:25 INFO - warning: no files found matching '*.txt' 10:30:25 INFO - no previously-included directories found matching 'build' 10:30:25 INFO - no previously-included directories found matching 'dist' 10:30:25 INFO - no previously-included directories found matching '.git*' 10:30:25 INFO - Installing collected packages: jsonschema, functools32 10:30:25 INFO - Running setup.py install for functools32 10:30:25 INFO - warning: no files found matching '*.txt' 10:30:25 INFO - no previously-included directories found matching 'build' 10:30:25 INFO - no previously-included directories found matching 'dist' 10:30:25 INFO - no previously-included directories found matching '.git*' 10:30:25 INFO - Successfully installed jsonschema functools32 10:30:25 INFO - Cleaning up... 10:30:25 INFO - Return code: 0 10:30:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:25 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 0x7f53f217ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, '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': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:30:25 INFO - Using env: {'DISPLAY': ':0', 10:30:25 INFO - 'HOME': '/home/cltbld', 10:30:25 INFO - 'LANG': 'en_US.UTF-8', 10:30:25 INFO - 'LANGUAGE': 'en_US:en', 10:30:25 INFO - 'LOGNAME': 'cltbld', 10:30:25 INFO - 'MAIL': '/var/mail/cltbld', 10:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:25 INFO - 'MOZ_NO_REMOTE': '1', 10:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:25 INFO - 'NO_EM_RESTART': '1', 10:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:25 INFO - 'PWD': '/builds/slave/test', 10:30:25 INFO - 'SHELL': '/bin/bash', 10:30:25 INFO - 'SHLVL': '1', 10:30:25 INFO - 'TERM': 'linux', 10:30:25 INFO - 'TMOUT': '86400', 10:30:25 INFO - 'USER': 'cltbld', 10:30:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:25 INFO - '_': '/tools/buildbot/bin/python'} 10:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:25 INFO - Downloading/unpacking flake8 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:30:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:30:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:30:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:30:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:30:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:30:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:30:28 INFO - no previously-included directories found matching 'docs/_build' 10:30:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:30:28 INFO - Running setup.py install for pep8 10:30:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:30:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:30:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:30:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:30:28 INFO - no previously-included directories found matching 'docs/_build' 10:30:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:30:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:30:28 INFO - Cleaning up... 10:30:28 INFO - Return code: 0 10:30:28 INFO - Running post-action listener: _resource_record_post_action 10:30:28 INFO - Running post-action listener: _start_resource_monitoring 10:30:28 INFO - Starting resource monitoring. 10:30:28 INFO - ##### 10:30:28 INFO - ##### Running install step. 10:30:28 INFO - ##### 10:30:28 INFO - Running pre-action listener: _resource_record_pre_action 10:30:28 INFO - Running main action method: install 10:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:30:28 INFO - Reading from file tmpfile_stdout 10:30:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:30:28 INFO - Reading from file tmpfile_stdout 10:30:28 INFO - Output received: 10:30:28 INFO - Usage: mozinstall [options] installer 10:30:28 INFO - Options: 10:30:28 INFO - -h, --help show this help message and exit 10:30:28 INFO - -d DEST, --destination=DEST 10:30:28 INFO - Directory to install application into. [default: 10:30:28 INFO - "/builds/slave/test"] 10:30:28 INFO - --app=APP Application being installed. [default: firefox] 10:30:28 INFO - mkdir: /builds/slave/test/build/application 10:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:30:44 INFO - Reading from file tmpfile_stdout 10:30:44 INFO - Output received: 10:30:44 INFO - /builds/slave/test/build/application/firefox/firefox 10:30:44 INFO - Running post-action listener: _resource_record_post_action 10:30:44 INFO - ##### 10:30:44 INFO - ##### Running run-tests step. 10:30:44 INFO - ##### 10:30:44 INFO - Running pre-action listener: _resource_record_pre_action 10:30:44 INFO - Running main action method: run_tests 10:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:30:44 INFO - Python 2.7.3 10:30:44 INFO - Return code: 0 10:30:44 INFO - grabbing minidump binary from tooltool 10:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30: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 0x1505410>, '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 0x1506310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15067a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:30: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 10:30: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 10:30:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:30:44 INFO - Return code: 0 10:30:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:30:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:30:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:30:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:30:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:30:45 INFO - Return code: 0 10:30: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/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 10:30: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/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 10:30:45 INFO - Using env: {'DISPLAY': ':0', 10:30:45 INFO - 'HOME': '/home/cltbld', 10:30:45 INFO - 'LANG': 'en_US.UTF-8', 10:30:45 INFO - 'LANGUAGE': 'en_US:en', 10:30:45 INFO - 'LOGNAME': 'cltbld', 10:30:45 INFO - 'MAIL': '/var/mail/cltbld', 10:30:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:30:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:45 INFO - 'MOZ_NO_REMOTE': '1', 10:30:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:45 INFO - 'NO_EM_RESTART': '1', 10:30:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:45 INFO - 'PWD': '/builds/slave/test', 10:30:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:30:45 INFO - 'SHELL': '/bin/bash', 10:30:45 INFO - 'SHLVL': '1', 10:30:45 INFO - 'TERM': 'linux', 10:30:45 INFO - 'TMOUT': '86400', 10:30:45 INFO - 'USER': 'cltbld', 10:30:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464629386.730812-259093068', 10:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:45 INFO - '_': '/tools/buildbot/bin/python'} 10:30: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/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 10:30:45 INFO - mozversion application_buildid: 20160530075039 10:30:45 INFO - mozversion application_changeset: c74c00d5cd6fb5b82239ecf337067dbfd103e2d2 10:30:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:30:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:30:45 INFO - mozversion application_name: Firefox 10:30:45 INFO - mozversion application_remotingname: firefox-dev 10:30:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:30:45 INFO - mozversion application_vendor: Mozilla 10:30:45 INFO - mozversion application_version: 48.0a2 10:30:45 INFO - mozversion platform_buildid: 20160530075039 10:30:45 INFO - mozversion platform_changeset: c74c00d5cd6fb5b82239ecf337067dbfd103e2d2 10:30:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:30:45 INFO - mozversion platform_version: 48.0a2 10:30:45 INFO - using testdate: 1464629445 10:30:45 INFO - actual date: 1464629445 10:30:45 INFO - starting webserver on 'localhost:36908' 10:30:45 INFO - SUITE-START | Running 2 tests 10:30:45 INFO - TEST-START | dromaeo_css 10:30:45 INFO - operating with platform_type : linux_ 10:30:45 INFO - Initialising browser for dromaeo_css test... 10:30:45 INFO - TEST-INFO | started process 3321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI2Rku1/profile http://localhost:36908/getInfo.html) 10:30:52 INFO - PROCESS | 3321 | __metrics Screen width/height:1600/1200 10:30:52 INFO - PROCESS | 3321 | colorDepth:24 10:30:52 INFO - PROCESS | 3321 | Browser inner width/height: 1024/697 10:30:52 INFO - PROCESS | 3321 | __metrics 10:30:53 ERROR - PROCESS | 3321 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:30:54 INFO - TEST-INFO | 3321: exit 0 10:30:54 INFO - Browser initialized. 10:30:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:30:54 INFO - TEST-INFO | started process 3414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI2Rku1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:06 INFO - PROCESS | 3414 | RSS: Main: 142057472 10:31:06 INFO - PROCESS | 3414 | 10:31:57 INFO - PROCESS | 3414 | 1464629517416 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:34:05 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:36908/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36908/tests/dromaeo/cssquery-ext.html) 10:34:06 INFO - PROCESS | 3414 | RSS: Main: 247250944 10:34:06 INFO - PROCESS | 3414 | 10:37:08 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:36908/tests/dromaeo/cssquery-ext.html (next: http://localhost:36908/tests/dromaeo/cssquery-jquery.html) 10:37:09 INFO - PROCESS | 3414 | RSS: Main: 218337280 10:37:09 INFO - PROCESS | 3414 | 10:40:10 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:36908/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36908/tests/dromaeo/cssquery-mootools.html) 10:40:11 INFO - PROCESS | 3414 | RSS: Main: 215207936 10:40:11 INFO - PROCESS | 3414 | 10:43:13 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:36908/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36908/tests/dromaeo/cssquery-prototype.html) 10:43:13 INFO - PROCESS | 3414 | RSS: Main: 216035328 10:43:13 INFO - PROCESS | 3414 | 10:46:16 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:36908/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36908/tests/dromaeo/cssquery-yui.html) 10:46:17 INFO - PROCESS | 3414 | RSS: Main: 209989632 10:46:17 INFO - PROCESS | 3414 | 10:49:19 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:36908/tests/dromaeo/cssquery-yui.html (next: http://localhost:36908/tests/dromaeo/cssquery-dojo.html) 10:49:19 INFO - PROCESS | 3414 | RSS: Main: 257503232 10:49:19 INFO - PROCESS | 3414 | 10:49:19 INFO - PROCESS | 3414 | __start_tp_report 10:49:19 INFO - PROCESS | 3414 | _x_x_mozilla_page_load 10:49:19 INFO - PROCESS | 3414 | _x_x_mozilla_page_load_details 10:49:19 INFO - PROCESS | 3414 | |i|pagename|runs| 10:49:19 INFO - PROCESS | 3414 | |0;dojo.html;3296.143002819267;3347.949780753289;3359.580052493439;3379.9324013519713;3385.069105995852;5519.889602207959;5522.779088836447;5528.75120619572;5536.19725139855;5536.584756143286;5455.290812194419;5495.203195536655;5498.532624726903;5499.340079190492;5536.363318218406;4947.307376967209;4957.206846904487;5073.188289873621;5094.312267843849;5132.820351287705;4978.676386034915;5042.092423363793;5044.873878153039;5045.167547354682;5049.065922804275;5004.249362595603;5075.492450754932;5106.872328191787;5108.157154069574;5130.204818253177;5117.692938423706;5136.871578210537;5138.997895410396;5141.820036298712;5144.897102057976;4904.485029071931;4982.078315511642;5032.6980381177245;5045.4197767256865;5062.392512898476;5399.9730001350135;5449.891002179934;5463.043967305705;5464.508194262496;5469.371022332443;5903.468687818074;5906.763729450817;5936.821895343147;5939.406059394026;5940.524758019348;5924.407559244084;5955.464008239236;6013.458788708994;6026.397360263939;6036.9396306036815;5522.337319521643;5523.530499907512;5526.50261476465;5549.639273447213;5556.944430555643;5870.031444811643;6020.247469066367;6032.336442991267;6038.6678732670125;6042.516598672096;5763.077907534775;5791.536677065825;5791.942080579141;5805.535557155417;5814;5834.94165058344;5853.707314634251;5854.619449735754;5866.061430171152;5867.501262392744;5665.858353541112;5821.243238378984;5828.737706803204;5840.1239814027385;5901.498372638288;5825.2135961644635;5837.29952405714;5852.795152169653;5878.911816322759;5879.412058794086;4452.220861349251;4464.084862603158;4465.843695470643;4479.596836284685;4484.686071974996;3948.6051394860283;3965.643092121723;4032.858849940238;4036.4348991141264;4039.373897045904;5522.889542209134;5523.972380138073;5548;5552.11166213412;5562.554995600342;5855.531557475391;5876.059830427112;5894.469497745224;5898.852528686817;5899.616524925866;5399.595030372738;5487.533559647395;5513.8345849624575;5565.1095824667855;5579.6652200868075;5076.162433198481;5091.159958606789;5112.182050871843;5112.207607820794;5114.105031619451;6098.573099882966;6124.418180272867;6141.938580614136;6147.385261473906;6153.98459254227;5761.654300741969;5848.619839710405;5914.526837852962;5961.254843144607;5964.254468191476;6037.547183961133;6066.090086486885;6070.878582428415;6075.605085669417;6078.513718902389;5764.971175144097;5773.191753154478;5777.191193232867;5778.219940308005;5780.046292361713;5781.913271300849;5907.704614769158;5968.820935371946;5975.103734439869;5989.910151347821;5748.540116790563;5750.913736293875;5767.423257674199;5773.8556536086935;5785.016547187072;5678.943210568007;5715.942840571707;5726.914096288476;5733.197352370755;5734.541236701138;5597.44025597437;5630.211770352236;5692.231548740867;5709;5718.571107166896;5802.187693722966;5805.796797112081;5859.472647461578;5863.794767183128;5873.207117039145;5565.248691426767;5765.221695071112;5765.365809760839;5771.336296325976;5781.537477001913 10:49:19 INFO - PROCESS | 3414 | |1;ext.html;672.7443571442851;678.308125711774;680.0920770771017;740.9555426674398;756.8873755579297;32112.357752844957;40438.59561404385;40462;40585.1882962341;40602;43627.78186109065;44341.7782911085;44348.3347749784;44354.55645443553;44366.77816610921;7906.881396779053;8865.999999999984;9096.727098187064;10451.738706532322;10616.46917654118;10515.579376824919;10630.62792802252;10632.893671063268;10640.733981650443;10646.25476216665;10607.469626518681;10655.78688426231;10668.093212076983;10671.19966002549;10671.733206669818;8245.257926786588;10511.84232236517;10554.419506927154;10681.0921071709;10690.51892664832;10641.14870810341;10745.83881241782;10750.516226769736;10757.623483178051;10770.838437423445;39226;39748.20503589941;39786;39806.80096599527;39817.60182398197;3639.636036396366;3769.2838360711376;3805.296020236265;4093.570175131628;4242.957570424287;33913.49129763056;34659.4801077984;34681.65318346809;34767;34768.304633907435;4455.77721113943;4521.525239849834;4584.931226031612;4588.4035075440315;4590.793414296365;232346;234703.99999999828;234836;235223;236153.99999999828;41155.7942210287;41901;41974.37038444426;69677;70904;39644.207115858095;39694.603053969666;39714.20571588552;39896.60103398987;39917.600823991386;17366.305347785947;17463.301467941394;17464.039477828843;17475.912620436815;17483.56291092733;13805.585832425044;13871.4451421942;14007.789883151761;14018.369173387222;14018.789718154236;9441.961384247727;9444.669436569688;9470.668526601536;9510.71605333285;9539.856902146474;3698.2973235085246;3740.756850804689;3771.660550550409;3777.905552361213;3790.924181516354;1163.662537864027;1207.903367730597;1213.8543374794904;1222.5720997650928;1288.62629837348;33058.83470582632;33261.16847078794;33668.66331336704;33735.493967590504;34776.65223347785;1241.267652085274;1255.7174635707077;1267.6674918150647;1275.7610393758894;1301.563976068009;18276.268949241883;18998.71501927472;19008.619827603372;19141.13864876084;19219.423417297505;467163;472537;473338;473392;473584;62927;64487.67756161189;64659.353406465336;64735.67632161809;65061.67469162624;1371.2869307959804;1535.5777161280737;1555.183528647469;1580.2730743857724;1584.9207539622973;30994.69005309918;32486.187845304055;32723;33305.83347083249;33329.50005749867;53965.73017134889;62710.6864465693;64087;64119.358806413205;64371.35628643654;408357;411059;411983;412748;415433.69132617785;40987.7950610245;46996.530034699215;49111;49268.75365623149;49748.00503989828;45398.54601453943;45510.54489455063;46549.767251163525;46694.29958550556;54376.72811635916;37621.81189094037;39794.80102599468;40379.59620403758;40498.39252411275;42194.156116876875;41379.379309310985;42476.088576013535;42916.78541607272;43345.78327108344;44042.559574403844;42819.357709635005;43156.13687726291;43421.131577368906;44269.33595995998;44578;36863;38108.618913810504;38135.809320953216;38451.38979120613;38830.223395531364;29253.268668283465;29267.414651706422;29306.7069329304;29445;29462.705372945995 10:49:19 INFO - PROCESS | 3414 | |2;jquery.html;409.9118689481761;414.98340066397344;416.6312813160352;425.7679564637272;432.08613781851375;12943.935280323609;18445.077746112707;19057;19082.713759293605;20226.69659955098;16107.43623973161;17515.386961456352;19223.32718354858;20238;20757.688634670456;5558.972205138979;5929.792457263997;5953.285605727318;5955.136505206742;5957.404259574051;5875.882482350372;5916.585838991272;5938.940610593882;5943.257092863392;5945.732442040097;4252.425922500453;5960.284765828107;6113.7860174893885;6345.048242763576;6350.968245158768;6300.5589608727405;6304.117423560705;6307.495400367982;6350.174477317943;6362.777302794403;5446.972765136149;5657;5707.971460142714;5708.029634962067;5710.65736055838;20976.895115524323;21071.789282107136;21448.678269825967;21542.784572154236;21678.34964951054;2289.5077558324874;2427.9757202427927;2444.168982545943;2467.938301542458;2678.209928071204;10037;10229;10424.426656533888;11544.884551154464;14440;1821.763170787789;2028.7362642856335;2048.2523878784286;2075.6886467030067;2086.1655337864822;76189;80728;81437.59281203615;81480.77778833381;82028.58985705093;9879.950600246953;10623.628173013907;10688.198385121146;11168.888311116947;11188.160887933438;14475.059121157092;14477.710445791025;14570.19863907474;14601.342939567745;14622.488212912496;8301.750947471586;8627.482351058956;8692.391532592657;8709.564521774013;8744.519051452231;8629.180227878342;8632.741017769476;8633.69782057625;8664.913350866536;8752.64989400417;4475.955240447619;4749.2876068589985;4905.583025442806;4985.252212168131;4996.275540046746;1926.4509614759727;2065.98967005164;2086.6244076066455;2095.1200495791804;2125.341144245258;1049.569676432659;1101.8512500812449;1209.1958847366402;1211.7515909238584;1226.141700809437;18178.091095445176;18423.631527369376;18656.160472778487;18758.1558829853;18938.431847044612;1086.6794295682635;1090.607381342716;1091.6233899304727;1128.6444769897455;1163.2497039409702;10428.322159059637;10444.373337599769;10559.736006599896;10562.89437105619;10622;356697;365990;456066;457360;467691;82432;84193.57903210445;91155;98202.50898745461;99884.50057749664;1116.3748300951493;1144.70237738187;1157.6064138193055;1162.430409099552;1163.7148898519918;16435.67128657444;16443.58891027734;16711.498655040366;16753.32986680519;16894.40869569559;36368.63631363758;39178.80410597929;40484.3927341096;41116.794416027726;41548;57048.429515705975;57615.711921440125;57942.71028644998;58064;58299.4170058294;8776.692815751418;8834.734957951272;8889.288856891562;9001.18989290967;9002;9996.900030999597;10725.946370268099;12730.17253878495;12924.289164096064;13512.391942362421;11351.37567433799;11425.942870285928;11593.188476806543;11605.709857253636;11814.94092529532;11222.102231821598;11250.774984500427;11371.601993930173;11761.411929403666;11823.82264266054;11446.313221206754;11722.824157637813;11756.94121529387;11817.113716471471;11846.348450835287;8545.572721364031;8548.700795472128;8635.956820215859;8768.079351667982;8833.29333653319;10773.89226107729;11623.825642615537;11965.16243862956;12116.636500904988;12201.02391808671 10:49:19 INFO - PROCESS | 3414 | |3;mootools.html;1429.9499517516888;1604.4785444730462;1605.99197004015;1838.567936534914;1900.952476188096;7510.361619262362;8244.752657420271;8363.707270245535;8379.24586787189;8385.0357208921;8248.46384984977;8429.45208561443;8430.747077587666;8437.451565648229;8450.366222533305;2116.6401711709045;2370.383700237933;2425.3936515871032;2438.3782135555407;2463.4949835283724;2435.8538487690794;2442.6702395176603;2447.437089469423;2449.2774631483753;2451.240115564172;2368.2658375903525;2425.5391475619576;2428.441458464554;2432.5499782540196;2434.062885788975;2128.755193152792;2332.0322066342446;2382.9046838126455;2383.0229605861687;2385.5109702510945;2337.789598936087;2351.1418332308754;2352.8235382346393;2352.9058837646476;2414.8430352027062;8311.667533298662;8384.413091083627;8414.653655415104;8422.326213902874;8439.915600843975;5346.331708536433;5523.061079616435;5526.889462210734;5528.364238112588;5535.501804837584;3457.291255292684;3522.630123836986;3532.2405682778067;3617.656322649344;3619.9276014479565;1079.8326259429723;1093.5899037860802;1112.75927341015;1136.5908273021705;1140.589387820384;11988.70028249292;12070.879291207064;12080.214786038967;12091.57679481214;12103.697407564794;4677.18149323867;4770.76146192689;4792.664513484023;4793.856184314476;4795.040991801584;10219.540120694586;10229.283950123569;10252.436116013541;10261.28171028021;10274;4706.482286948433;5417.3770016447825;5457.372402173722;5461.808836690697;5465.945340546623;4298.161858437575;4351.3472979053395;4351.673624478177;4921.434035086011;5013.799448022039;4101.774402407897;4124.205970402884;4209.473815773028;4251.171021650748;4261.914761704748;1325.5691900132495;1360.768669326217;1377.7106807570322;1378.9172649641055;1379.6137081617164;1023.3246057601947;1023.534291897185;1030.2015937648382;1038.4548112240982;1049.3598904668147;5837.7664893404635;5845.571619426993;5863.419397913355;5942.3166335871065;5951.613145145551;475.9714417134983;479.04908756119073;483.3450674336224;489.1195847474532;491.83277685587075;4016.4376987221813;4017.6384125428267;4017.8593749218635;4033.576474470197;4113.506379234511;9974.551145198484;10152.593896244216;10306.227032972407;10483.697635244873;10515.26393152472;10263.538140783683;10322.948385258025;10331.276810623334;10340.121089707309;10398.636047738444;7704.460687751915;8077.798055048554;8186.426950113435;8200.220979006985;8234;5625.774969001194;5665.461781130786;5740.167675687086;5796;5821.039528477754;9062.04848490899;9091.363604547883;9358.251339892928;9384.343095983215;9406.717798466058;9403.764905877408;9575.138237558653;9592.08875156859;9835;9855;6724.932750672627;7331.120265567953;7393.297636724503;7504;7551.773446796605;8127.959360203397;8154.1030486647605;8163.551004694798;8201.343892488705;8217.506949583045;7266.346028857428;7363.447741419308;7419.591922444318;7511.098668159856;7521.022267105242;7321.707131714672;7389.187189409053;7393.334599886036;7479.738209162653;7486.850262994819;6794.592324460548;6859.657017149222;6909.516333856582;6911.136107986502;6919.550229235084;5179.40436849752;5218.269442278008;5378.811741589026;5382.946170538401;5396.325459317585;5342.6260161788305;5351;5378.435264297193;5476.698781567052;5542.7782888684005 10:49:19 INFO - PROCESS | 3414 | |4;prototype.html;345.44728434504793;349.46531806336316;352.3474902706309;354.75699146084935;358.4390428978648;6329.7151628176725;6330.3036665966765;6360.236771587404;6364.904526432101;6367.426931576158;6398.488120950325;6424.132742079818;6430.421262086411;6434.485241180706;6440.967795161029;4626.444826620802;4747.05058988202;4853.441854186761;4874.293227482013;4881.194602890519;4830.2513110467935;4836.250381190904;4852.660313778037;4855.514448555134;4874.512548745115;4612.377329060584;4813.735244561548;4837.7822997965;4841.273808928671;4844.612431005528;4692.554207350297;4693.108309421216;4742.051589682077;4838.250071238964;4845.709257444564;4222.366645003243;4241.300185469394;4247.256730072225;4249.383839343278;4258.91482170358;6105.358937311563;6116.602420842631;6123.203983482119;6123.785667501661;6127.89697854386;5547.223388725582;5598.300212473441;5603.411641777596;5615.578831587606;5633.239512665819;6493.155889734351;6697.129373181455;6701.128853249095;6702.865942681119;6705.6982435790505;4505.684602077856;4518.887027824298;4521.231390663595;4522.3668686383935;4537;6921.377076063128;6957.965210173917;7004.754833580801;7006.4745144114395;7010.789676309668;4683.882902927386;4695.906081878344;4697.201475749062;4697.929531057037;4701.106789709944;4754.667173297836;4755.762211889391;4755.881102972453;4761.95238047622;4764.857054288377;5537.833864984057;5540.861478463071;5554.250411120484;5596.38439771633;5602.607817452739;6479.546431749826;6794.048833163361;6844.589324640438;6849.075374824434;6851.45188384928;1630.755386691982;1649.1424459281106;1649.9010059396476;1659.062629614264;1664.3924967387059;1020.637673625867;1052.8526006359116;1061.7345663584103;1077.0737166037202;1077.4720387010466;6293.653849038255;6457.4511166551365;6468.059582125344;6535.444487218545;6540.869182616321;6954.513184077066;6974.511784175161;6996.440284777307;7003.5797852129035;7010.123734533184;6478.708458119396;6497.8700425992165;6506.544541882023;6515.218173819172;6515.641639709766;3710.8144592770795;3748.9690335158048;3753.6809371203753;3764.3600587900123;3766.2090960898518;7104.964475177694;7138.250483699137;7249.130104387507;7251.383632391306;7264.782056538313;7068.434525237969;7070.717171313193;7093.787186384417;7100.5029647925185;7105.360517553341;7246.891296630555;7249.492535522569;7250;7251.1661158966335;7253.709851605982;6975.337342952412;6977.1278590176225;6984;6986.47601429905;6988.545744526589;6724.596524208563;6862.245153033262;6875.621840798804;6877.862442751217;6882.7591034313555;7204.423646108404;7241;7241.891371629325;7250.41996640257;7268.96365518169;4690.648201384842;4705.270683044134;4710.128626204163;4713.528647135259;4713.952860471351;6972.09362782835;6974.61639609806;6975.093237879043;6977.3720365165345;6978.092847929736;6645.1361323027695;6808.387245147763;6817.0456136141975;6839.931600684128;6845.726170953106;6737.191537015589;6743.696533656095;6783.864322713617;6788.422984046214;6801.965990170018;6654.933450665625;6658.201015878126;6659.833504162435;6676.432503237279;6677.499187560855;6768.932310676831;6807.0810440589885;6836.658167091526;6900.758473453606;6914.204866440223;6345.841353966188;6399.168108145911;6486.254080780771;6624.337566243337;6672.6997285121315 10:49:19 INFO - PROCESS | 3414 | |5;yui.html;929.0848514213499;939.9107084826943;948.3503799897069;959.040959040959;978.0415193110756;14609.050411723243;14777.630559236024;14785.630359241024;14797.778033329496;15071.547853564396;12960.416781244843;13003.674908127301;13038.543650972219;13038.60884173474;13144.079914405995;941.1858742188026;958.3483231402644;959.7840485890689;960.011188475871;960.2605993385089;931.9394239374453;936.166811537732;942.1661829281102;942.63708472238;944.315371355765;981.4847205217246;988.2736188901152;989.6882482018141;989.8515222716615;990.3265779270093;976.6093562574991;978.2614126334643;980.2403137568406;980.4215512847383;980.9607615695328;718.0736849464184;718.5616773767997;718.6694120704482;719.6401799100449;720.8450183210582;13548.525801596898;13621.25083120428;13644.113132646446;13663.931680341633;13688.589342319747;12833.935830320788;12842.807357889638;12878.935605321913;12953.54662586805;13074.542391016364;10721.62474313403;13189.634076301098;13411.865881341158;13572.728545429134;13772.517961871386;4646.279826626878;4700.083483720676;4831.637627177975;4883.072216278932;4893.02139572087;49956;55491.44508554903;56207.718961404935;56287.71856140693;57888.71055644737;11012.452733068032;12042.698932526757;12217.083718721131;12219.816702749466;12312.322822244863;20508;20509.692354614694;20547.486312842;20550.794492055185;20584.897075514527;8752.64989400417;8837.60230789616;8851.911480885108;8870.467771933576;8966.282697384324;4738.620910327235;4749.762511874462;4858.1012512685265;4874.098291816025;4934.9013019739405;3527.9294414111573;3537.0626783902285;3556.05764472415;3565.750397472152;3585.5697316321684;434.57845889487146;438.2462165076064;594.1355327997753;664.6377724140258;682.3347236444426;640.6252342379667;771.502380964275;828.0808302783905;834.8956380452444;842.098954119099;9664.75838104039;9756.90243097574;9809.264305177141;10122.44326562046;10206.693799186036;709.9964500177466;795.4988357334842;799.6601444386113;819.3199644295221;853.0786750309651;4494.662900282492;4602.689122361007;4775.832845850378;4818.734969576707;4861.270809378621;65144.67427662831;65543;66114.33885661082;67225.32774672289;67282.66358668175;57328.14007789887;57689;57865.13202301969;58966.70516647389;59305.40694593085;50935.745321273156;51449.48550514597;51856.22215666768;52653.7367313161;52692;9718.70843874685;9771.511424428609;9778.85331720039;9858.162056225301;9883.50582470888;37833.62166378411;37916.05209869775;38618.22763544657;39776.40335395029;40209.79895100506;45498.31752523781;47562.52437475581;47891;51178.23232651588;51683.224751628004;12194.451249693608;12440.688982775502;12910.870891291343;13510.189388636712;13612.591622251348;13862.237576933365;14027.859721402656;14398.856011439751;14666.19335936491;14937.253137343307;12275.93862030684;13750.724985500434;14269.143851368952;14409.207493587954;14734.484293049692;12697.047721420746;13188.280848985582;13473.19160850313;13750.312484375941;14009.84927622751;12060;12376.938115309726;13543.796843047165;13571.253581053137;13699.452021919411;11577.884221157681;11597.478113485082;11816.527338906348;11836.526538938691;11903.10726695484;11539.942300288445;11547.826782598437;11589.130815189063;11899.940500297444;11989.940050299692 10:49:19 INFO - PROCESS | 3414 | __end_tp_report 10:49:19 INFO - PROCESS | 3414 | __start_cc_report 10:49:19 INFO - PROCESS | 3414 | _x_x_mozilla_cycle_collect,848 10:49:19 INFO - PROCESS | 3414 | __end_cc_report 10:49:19 INFO - PROCESS | 3414 | __startTimestamp1464630559768__endTimestamp 10:49:19 INFO - PROCESS | 3414 | 10:49:19 INFO - PROCESS | 3414 | ------- Summary: start ------- 10:49:19 INFO - PROCESS | 3414 | Number of tests: 6 10:49:19 INFO - PROCESS | 3414 | 10:49:19 INFO - PROCESS | 3414 | [#0] dojo.html Cycles:165 Average:5482.39 Median:5715.94 stddev:599.74 (10.5%) stddev-sans-first:576.53 10:49:19 INFO - PROCESS | 3414 | Values: 3296.1 3347.9 3359.6 3379.9 3385.1 5519.9 5522.8 5528.8 5536.2 5536.6 5455.3 5495.2 5498.5 5499.3 5536.4 4947.3 4957.2 5073.2 5094.3 5132.8 4978.7 5042.1 5044.9 5045.2 5049.1 5004.2 5075.5 5106.9 5108.2 5130.2 5117.7 5136.9 5139.0 5141.8 5144.9 4904.5 4982.1 5032.7 5045.4 5062.4 5400.0 5449.9 5463.0 5464.5 5469.4 5903.5 5906.8 5936.8 5939.4 5940.5 5924.4 5955.5 6013.5 6026.4 6036.9 5522.3 5523.5 5526.5 5549.6 5556.9 5870.0 6020.2 6032.3 6038.7 6042.5 5763.1 5791.5 5791.9 5805.5 5814.0 5834.9 5853.7 5854.6 5866.1 5867.5 5665.9 5821.2 5828.7 5840.1 5901.5 5825.2 5837.3 5852.8 5878.9 5879.4 4452.2 4464.1 4465.8 4479.6 4484.7 3948.6 3965.6 4032.9 4036.4 4039.4 5522.9 5524.0 5548.0 5552.1 5562.6 5855.5 5876.1 5894.5 5898.9 5899.6 5399.6 5487.5 5513.8 5565.1 5579.7 5076.2 5091.2 5112.2 5112.2 5114.1 6098.6 6124.4 6141.9 6147.4 6154.0 5761.7 5848.6 5914.5 5961.3 5964.3 6037.5 6066.1 6070.9 6075.6 6078.5 5765.0 5773.2 5777.2 5778.2 5780.0 5781.9 5907.7 5968.8 5975.1 5989.9 5748.5 5750.9 5767.4 5773.9 5785.0 5678.9 5715.9 5726.9 5733.2 5734.5 5597.4 5630.2 5692.2 5709.0 5718.6 5802.2 5805.8 5859.5 5863.8 5873.2 5565.2 5765.2 5765.4 5771.3 5781.5 10:49:19 INFO - PROCESS | 3414 | 10:49:19 INFO - PROCESS | 3414 | [#1] ext.html Cycles:180 Average:54956.65 Median:39028.11 stddev:102150.48 (261.7%) stddev-sans-first:102355.73 10:49:19 INFO - PROCESS | 3414 | Values: 672.7 678.3 680.1 741.0 756.9 32112.4 40438.6 40462.0 40585.2 40602.0 43627.8 44341.8 44348.3 44354.6 44366.8 7906.9 8866.0 9096.7 10451.7 10616.5 10515.6 10630.6 10632.9 10640.7 10646.3 10607.5 10655.8 10668.1 10671.2 10671.7 8245.3 10511.8 10554.4 10681.1 10690.5 10641.1 10745.8 10750.5 10757.6 10770.8 39226.0 39748.2 39786.0 39806.8 39817.6 3639.6 3769.3 3805.3 4093.6 4243.0 33913.5 34659.5 34681.7 34767.0 34768.3 4455.8 4521.5 4584.9 4588.4 4590.8 232346.0 234704.0 234836.0 235223.0 236154.0 41155.8 41901.0 41974.4 69677.0 70904.0 39644.2 39694.6 39714.2 39896.6 39917.6 17366.3 17463.3 17464.0 17475.9 17483.6 13805.6 13871.4 14007.8 14018.4 14018.8 9442.0 9444.7 9470.7 9510.7 9539.9 3698.3 3740.8 3771.7 3777.9 3790.9 1163.7 1207.9 1213.9 1222.6 1288.6 33058.8 33261.2 33668.7 33735.5 34776.7 1241.3 1255.7 1267.7 1275.8 1301.6 18276.3 18998.7 19008.6 19141.1 19219.4 467163.0 472537.0 473338.0 473392.0 473584.0 62927.0 64487.7 64659.4 64735.7 65061.7 1371.3 1535.6 1555.2 1580.3 1584.9 30994.7 32486.2 32723.0 33305.8 33329.5 53965.7 62710.7 64087.0 64119.4 64371.4 408357.0 411059.0 411983.0 412748.0 415433.7 40987.8 46996.5 49111.0 49268.8 49748.0 45398.5 45510.5 46549.8 46694.3 54376.7 37621.8 39794.8 40379.6 40498.4 42194.2 41379.4 42476.1 42916.8 43345.8 44042.6 42819.4 43156.1 43421.1 44269.3 44578.0 36863.0 38108.6 38135.8 38451.4 38830.2 29253.3 29267.4 29306.7 29445.0 29462.7 10:49:19 INFO - PROCESS | 3414 | 10:49:19 INFO - PROCESS | 3414 | [#2] jquery.html Cycles:180 Average:26898.56 Median:21495.73 stddev:70246.89 (326.8%) stddev-sans-first:70415.80 10:49:19 INFO - PROCESS | 3414 | Values: 409.9 415.0 416.6 425.8 432.1 12943.9 18445.1 19057.0 19082.7 20226.7 16107.4 17515.4 19223.3 20238.0 20757.7 5559.0 5929.8 5953.3 5955.1 5957.4 5875.9 5916.6 5938.9 5943.3 5945.7 4252.4 5960.3 6113.8 6345.0 6351.0 6300.6 6304.1 6307.5 6350.2 6362.8 5447.0 5657.0 5708.0 5708.0 5710.7 20976.9 21071.8 21448.7 21542.8 21678.3 2289.5 2428.0 2444.2 2467.9 2678.2 10037.0 10229.0 10424.4 11544.9 14440.0 1821.8 2028.7 2048.3 2075.7 2086.2 76189.0 80728.0 81437.6 81480.8 82028.6 9880.0 10623.6 10688.2 11168.9 11188.2 14475.1 14477.7 14570.2 14601.3 14622.5 8301.8 8627.5 8692.4 8709.6 8744.5 8629.2 8632.7 8633.7 8664.9 8752.6 4476.0 4749.3 4905.6 4985.3 4996.3 1926.5 2066.0 2086.6 2095.1 2125.3 1049.6 1101.9 1209.2 1211.8 1226.1 18178.1 18423.6 18656.2 18758.2 18938.4 1086.7 1090.6 1091.6 1128.6 1163.2 10428.3 10444.4 10559.7 10562.9 10622.0 356697.0 365990.0 456066.0 457360.0 467691.0 82432.0 84193.6 91155.0 98202.5 99884.5 1116.4 1144.7 1157.6 1162.4 1163.7 16435.7 16443.6 16711.5 16753.3 16894.4 36368.6 39178.8 40484.4 41116.8 41548.0 57048.4 57615.7 57942.7 58064.0 58299.4 8776.7 8834.7 8889.3 9001.2 9002.0 9996.9 10725.9 12730.2 12924.3 13512.4 11351.4 11425.9 11593.2 11605.7 11814.9 11222.1 11250.8 11371.6 11761.4 11823.8 11446.3 11722.8 11756.9 11817.1 11846.3 8545.6 8548.7 8636.0 8768.1 8833.3 10773.9 11623.8 11965.2 12116.6 12201.0 10:49:19 INFO - PROCESS | 3414 | 10:49:19 INFO - PROCESS | 3414 | [#3] mootools.html Cycles:180 Average:5664.81 Median:486.23 stddev:3114.28 (640.5%) stddev-sans-first:3106.75 10:49:19 INFO - PROCESS | 3414 | Values: 1429.9 1604.5 1606.0 1838.6 1901.0 7510.4 8244.8 8363.7 8379.2 8385.0 8248.5 8429.5 8430.7 8437.5 8450.4 2116.6 2370.4 2425.4 2438.4 2463.5 2435.9 2442.7 2447.4 2449.3 2451.2 2368.3 2425.5 2428.4 2432.5 2434.1 2128.8 2332.0 2382.9 2383.0 2385.5 2337.8 2351.1 2352.8 2352.9 2414.8 8311.7 8384.4 8414.7 8422.3 8439.9 5346.3 5523.1 5526.9 5528.4 5535.5 3457.3 3522.6 3532.2 3617.7 3619.9 1079.8 1093.6 1112.8 1136.6 1140.6 11988.7 12070.9 12080.2 12091.6 12103.7 4677.2 4770.8 4792.7 4793.9 4795.0 10219.5 10229.3 10252.4 10261.3 10274.0 4706.5 5417.4 5457.4 5461.8 5465.9 4298.2 4351.3 4351.7 4921.4 5013.8 4101.8 4124.2 4209.5 4251.2 4261.9 1325.6 1360.8 1377.7 1378.9 1379.6 1023.3 1023.5 1030.2 1038.5 1049.4 5837.8 5845.6 5863.4 5942.3 5951.6 476.0 479.0 483.3 489.1 491.8 4016.4 4017.6 4017.9 4033.6 4113.5 9974.6 10152.6 10306.2 10483.7 10515.3 10263.5 10322.9 10331.3 10340.1 10398.6 7704.5 8077.8 8186.4 8200.2 8234.0 5625.8 5665.5 5740.2 5796.0 5821.0 9062.0 9091.4 9358.3 9384.3 9406.7 9403.8 9575.1 9592.1 9835.0 9855.0 6724.9 7331.1 7393.3 7504.0 7551.8 8128.0 8154.1 8163.6 8201.3 8217.5 7266.3 7363.4 7419.6 7511.1 7521.0 7321.7 7389.2 7393.3 7479.7 7486.9 6794.6 6859.7 6909.5 6911.1 6919.6 5179.4 5218.3 5378.8 5382.9 5396.3 5342.6 5351.0 5378.4 5476.7 5542.8 10:49:19 INFO - PROCESS | 3414 | 10:49:19 INFO - PROCESS | 3414 | [#4] prototype.html Cycles:180 Average:5625.31 Median:6432.45 stddev:1723.86 (26.8%) stddev-sans-first:1682.53 10:49:19 INFO - PROCESS | 3414 | Values: 345.4 349.5 352.3 354.8 358.4 6329.7 6330.3 6360.2 6364.9 6367.4 6398.5 6424.1 6430.4 6434.5 6441.0 4626.4 4747.1 4853.4 4874.3 4881.2 4830.3 4836.3 4852.7 4855.5 4874.5 4612.4 4813.7 4837.8 4841.3 4844.6 4692.6 4693.1 4742.1 4838.3 4845.7 4222.4 4241.3 4247.3 4249.4 4258.9 6105.4 6116.6 6123.2 6123.8 6127.9 5547.2 5598.3 5603.4 5615.6 5633.2 6493.2 6697.1 6701.1 6702.9 6705.7 4505.7 4518.9 4521.2 4522.4 4537.0 6921.4 6958.0 7004.8 7006.5 7010.8 4683.9 4695.9 4697.2 4697.9 4701.1 4754.7 4755.8 4755.9 4762.0 4764.9 5537.8 5540.9 5554.3 5596.4 5602.6 6479.5 6794.0 6844.6 6849.1 6851.5 1630.8 1649.1 1649.9 1659.1 1664.4 1020.6 1052.9 1061.7 1077.1 1077.5 6293.7 6457.5 6468.1 6535.4 6540.9 6954.5 6974.5 6996.4 7003.6 7010.1 6478.7 6497.9 6506.5 6515.2 6515.6 3710.8 3749.0 3753.7 3764.4 3766.2 7105.0 7138.3 7249.1 7251.4 7264.8 7068.4 7070.7 7093.8 7100.5 7105.4 7246.9 7249.5 7250.0 7251.2 7253.7 6975.3 6977.1 6984.0 6986.5 6988.5 6724.6 6862.2 6875.6 6877.9 6882.8 7204.4 7241.0 7241.9 7250.4 7269.0 4690.6 4705.3 4710.1 4713.5 4714.0 6972.1 6974.6 6975.1 6977.4 6978.1 6645.1 6808.4 6817.0 6839.9 6845.7 6737.2 6743.7 6783.9 6788.4 6802.0 6654.9 6658.2 6659.8 6676.4 6677.5 6768.9 6807.1 6836.7 6900.8 6914.2 6345.8 6399.2 6486.3 6624.3 6672.7 10:49:19 INFO - PROCESS | 3414 | 10:49:19 INFO - PROCESS | 3414 | [#5] yui.html Cycles:180 Average:15675.15 Median:26156.14 stddev:18008.34 (68.8%) stddev-sans-first:18024.81 10:49:19 INFO - PROCESS | 3414 | Values: 929.1 939.9 948.4 959.0 978.0 14609.1 14777.6 14785.6 14797.8 15071.5 12960.4 13003.7 13038.5 13038.6 13144.1 941.2 958.3 959.8 960.0 960.3 931.9 936.2 942.2 942.6 944.3 981.5 988.3 989.7 989.9 990.3 976.6 978.3 980.2 980.4 981.0 718.1 718.6 718.7 719.6 720.8 13548.5 13621.3 13644.1 13663.9 13688.6 12833.9 12842.8 12878.9 12953.5 13074.5 10721.6 13189.6 13411.9 13572.7 13772.5 4646.3 4700.1 4831.6 4883.1 4893.0 49956.0 55491.4 56207.7 56287.7 57888.7 11012.5 12042.7 12217.1 12219.8 12312.3 20508.0 20509.7 20547.5 20550.8 20584.9 8752.6 8837.6 8851.9 8870.5 8966.3 4738.6 4749.8 4858.1 4874.1 4934.9 3527.9 3537.1 3556.1 3565.8 3585.6 434.6 438.2 594.1 664.6 682.3 640.6 771.5 828.1 834.9 842.1 9664.8 9756.9 9809.3 10122.4 10206.7 710.0 795.5 799.7 819.3 853.1 4494.7 4602.7 4775.8 4818.7 4861.3 65144.7 65543.0 66114.3 67225.3 67282.7 57328.1 57689.0 57865.1 58966.7 59305.4 50935.7 51449.5 51856.2 52653.7 52692.0 9718.7 9771.5 9778.9 9858.2 9883.5 37833.6 37916.1 38618.2 39776.4 40209.8 45498.3 47562.5 47891.0 51178.2 51683.2 12194.5 12440.7 12910.9 13510.2 13612.6 13862.2 14027.9 14398.9 14666.2 14937.3 12275.9 13750.7 14269.1 14409.2 14734.5 12697.0 13188.3 13473.2 13750.3 14009.8 12060.0 12376.9 13543.8 13571.3 13699.5 11577.9 11597.5 11816.5 11836.5 11903.1 11539.9 11547.8 11589.1 11899.9 11989.9 10:49:19 INFO - PROCESS | 3414 | -------- Summary: end -------- 10:49:19 INFO - PROCESS | 3414 | 10:49:20 INFO - TEST-INFO | 3414: exit 0 10:49:20 INFO - TEST-OK | dromaeo_css | took 1114715ms 10:49:20 INFO - TEST-START | kraken 10:49:20 INFO - operating with platform_type : linux_ 10:49:20 INFO - Initialising browser for kraken test... 10:49:20 INFO - TEST-INFO | started process 3603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAvJMkn/profile http://localhost:36908/getInfo.html) 10:49:24 INFO - PROCESS | 3603 | __metrics Screen width/height:1600/1200 10:49:24 INFO - PROCESS | 3603 | colorDepth:24 10:49:24 INFO - PROCESS | 3603 | Browser inner width/height: 1024/697 10:49:24 INFO - PROCESS | 3603 | __metrics 10:49:25 ERROR - PROCESS | 3603 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:49:26 INFO - TEST-INFO | 3603: exit 0 10:49:26 INFO - Browser initialized. 10:49:26 INFO - Running cycle 1/1 for kraken test... 10:49:26 INFO - TEST-INFO | started process 3697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAvJMkn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:49:38 INFO - PROCESS | 3697 | RSS: Main: 142405632 10:49:38 INFO - PROCESS | 3697 | 10:49:40 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36908/tests/kraken/driver.html?testName=audio-beat-detection) 10:49:41 INFO - PROCESS | 3697 | RSS: Main: 197320704 10:49:41 INFO - PROCESS | 3697 | 10:49:44 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36908/tests/kraken/driver.html?testName=audio-dft) 10:49:44 INFO - PROCESS | 3697 | RSS: Main: 181850112 10:49:44 INFO - PROCESS | 3697 | 10:49:47 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36908/tests/kraken/driver.html?testName=audio-fft) 10:49:48 INFO - PROCESS | 3697 | RSS: Main: 272809984 10:49:48 INFO - PROCESS | 3697 | 10:49:50 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36908/tests/kraken/driver.html?testName=audio-oscillator) 10:49:50 INFO - PROCESS | 3697 | RSS: Main: 178364416 10:49:50 INFO - PROCESS | 3697 | 10:49:52 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36908/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:49:53 INFO - PROCESS | 3697 | RSS: Main: 176943104 10:49:53 INFO - PROCESS | 3697 | 10:49:56 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36908/tests/kraken/driver.html?testName=imaging-darkroom) 10:49:57 INFO - PROCESS | 3697 | RSS: Main: 211611648 10:49:57 INFO - PROCESS | 3697 | 10:50:00 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36908/tests/kraken/driver.html?testName=imaging-desaturate) 10:50:00 INFO - PROCESS | 3697 | RSS: Main: 211292160 10:50:00 INFO - PROCESS | 3697 | 10:50:03 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36908/tests/kraken/driver.html?testName=json-parse-financial) 10:50:04 INFO - PROCESS | 3697 | RSS: Main: 211730432 10:50:04 INFO - PROCESS | 3697 | 10:50:05 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36908/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:50:06 INFO - PROCESS | 3697 | RSS: Main: 190926848 10:50:06 INFO - PROCESS | 3697 | 10:50:08 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36908/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:50:08 INFO - PROCESS | 3697 | RSS: Main: 194805760 10:50:08 INFO - PROCESS | 3697 | 10:50:10 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36908/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:50:11 INFO - PROCESS | 3697 | RSS: Main: 207413248 10:50:11 INFO - PROCESS | 3697 | 10:50:13 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:50:14 INFO - PROCESS | 3697 | RSS: Main: 212439040 10:50:14 INFO - PROCESS | 3697 | 10:50:17 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:50:17 INFO - PROCESS | 3697 | RSS: Main: 208048128 10:50:17 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | Cycle 1(1): loaded http://localhost:36908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36908/tests/kraken/driver.html?testName=ai-astar) 10:50:19 INFO - PROCESS | 3697 | RSS: Main: 271331328 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | __start_tp_report 10:50:19 INFO - PROCESS | 3697 | _x_x_mozilla_page_load 10:50:19 INFO - PROCESS | 3697 | _x_x_mozilla_page_load_details 10:50:19 INFO - PROCESS | 3697 | |i|pagename|runs| 10:50:19 INFO - PROCESS | 3697 | |0;ai-astar;108;110;109;109;111;110;105;110;109;109 10:50:19 INFO - PROCESS | 3697 | |1;audio-beat-detection;159;125;151;177;126;153;153;126;188;126 10:50:19 INFO - PROCESS | 3697 | |2;audio-dft;161;160;162;161;160;159;160;164;160;159 10:50:19 INFO - PROCESS | 3697 | |3;audio-fft;76;75;76;162;77;73;74;76;169;75 10:50:19 INFO - PROCESS | 3697 | |4;audio-oscillator;93;93;154;92;92;91;146;91;92;144 10:50:19 INFO - PROCESS | 3697 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 10:50:19 INFO - PROCESS | 3697 | |6;imaging-darkroom;145;145;145;145;145;146;145;146;145;145 10:50:19 INFO - PROCESS | 3697 | |7;imaging-desaturate;94;95;95;97;94;95;95;94;95;94 10:50:19 INFO - PROCESS | 3697 | |8;json-parse-financial;54;55;54;54;54;53;55;70;54;52 10:50:19 INFO - PROCESS | 3697 | |9;json-stringify-tinderbox;58;64;58;58;58;57;59;60;58;57 10:50:19 INFO - PROCESS | 3697 | |10;stanford-crypto-aes;73;76;77;77;77;84;76;74;74;72 10:50:19 INFO - PROCESS | 3697 | |11;stanford-crypto-ccm;116;116;112;120;118;111;118;126;129;116 10:50:19 INFO - PROCESS | 3697 | |12;stanford-crypto-pbkdf2;164;159;156;159;159;162;154;155;157;158 10:50:19 INFO - PROCESS | 3697 | |13;stanford-crypto-sha256-iterative;66;67;66;66;66;64;66;65;64;63 10:50:19 INFO - PROCESS | 3697 | __end_tp_report 10:50:19 INFO - PROCESS | 3697 | __start_cc_report 10:50:19 INFO - PROCESS | 3697 | _x_x_mozilla_cycle_collect,1585 10:50:19 INFO - PROCESS | 3697 | __end_cc_report 10:50:19 INFO - PROCESS | 3697 | __startTimestamp1464630619634__endTimestamp 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | ------- Summary: start ------- 10:50:19 INFO - PROCESS | 3697 | Number of tests: 14 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:1.63 (1.5%) stddev-sans-first:1.69 10:50:19 INFO - PROCESS | 3697 | Values: 108.0 110.0 109.0 109.0 111.0 110.0 105.0 110.0 109.0 109.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:153.00 stddev:22.61 (14.8%) stddev-sans-first:23.65 10:50:19 INFO - PROCESS | 3697 | Values: 159.0 125.0 151.0 177.0 126.0 153.0 153.0 126.0 188.0 126.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 10:50:19 INFO - PROCESS | 3697 | Values: 161.0 160.0 162.0 161.0 160.0 159.0 160.0 164.0 160.0 159.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.50 stddev:38.11 (50.5%) stddev-sans-first:39.90 10:50:19 INFO - PROCESS | 3697 | Values: 76.0 75.0 76.0 162.0 77.0 73.0 74.0 76.0 169.0 75.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.00 stddev:27.17 (29.5%) stddev-sans-first:28.21 10:50:19 INFO - PROCESS | 3697 | Values: 93.0 93.0 154.0 92.0 92.0 91.0 146.0 91.0 92.0 144.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:50:19 INFO - PROCESS | 3697 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:50:19 INFO - PROCESS | 3697 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 10:50:19 INFO - PROCESS | 3697 | Values: 94.0 95.0 95.0 97.0 94.0 95.0 95.0 94.0 95.0 94.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:5.17 (9.6%) stddev-sans-first:5.45 10:50:19 INFO - PROCESS | 3697 | Values: 54.0 55.0 54.0 54.0 54.0 53.0 55.0 70.0 54.0 52.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.00 stddev:2.06 (3.5%) stddev-sans-first:2.17 10:50:19 INFO - PROCESS | 3697 | Values: 58.0 64.0 58.0 58.0 58.0 57.0 59.0 60.0 58.0 57.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.50 stddev:3.33 (4.4%) stddev-sans-first:3.35 10:50:19 INFO - PROCESS | 3697 | Values: 73.0 76.0 77.0 77.0 77.0 84.0 76.0 74.0 74.0 72.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:118.00 stddev:5.63 (4.8%) stddev-sans-first:5.92 10:50:19 INFO - PROCESS | 3697 | Values: 116.0 116.0 112.0 120.0 118.0 111.0 118.0 126.0 129.0 116.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.00 stddev:3.06 (1.9%) stddev-sans-first:2.45 10:50:19 INFO - PROCESS | 3697 | Values: 164.0 159.0 156.0 159.0 159.0 162.0 154.0 155.0 157.0 158.0 10:50:19 INFO - PROCESS | 3697 | 10:50:19 INFO - PROCESS | 3697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 10:50:19 INFO - PROCESS | 3697 | Values: 66.0 67.0 66.0 66.0 66.0 64.0 66.0 65.0 64.0 63.0 10:50:19 INFO - PROCESS | 3697 | -------- Summary: end -------- 10:50:19 INFO - PROCESS | 3697 | 10:50:20 INFO - TEST-INFO | 3697: exit 0 10:50:20 INFO - TEST-OK | kraken | took 60088ms 10:50:20 INFO - SUITE-END | took 1174s 10:50:20 INFO - Completed test suite (00:19:35) 10:50:20 INFO - javascript benchmark 10:50:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.143002819267, 3347.949780753289, 3359.580052493439, 3379.9324013519713, 3385.069105995852, 5519.889602207959, 5522.779088836447, 5528.75120619572, 5536.19725139855, 5536.584756143286, 5455.290812194419, 5495.203195536655, 5498.532624726903, 5499.340079190492, 5536.363318218406, 4947.307376967209, 4957.206846904487, 5073.188289873621, 5094.312267843849, 5132.820351287705, 4978.676386034915, 5042.092423363793, 5044.873878153039, 5045.167547354682, 5049.065922804275, 5004.249362595603, 5075.492450754932, 5106.872328191787, 5108.157154069574, 5130.204818253177, 5117.692938423706, 5136.871578210537, 5138.997895410396, 5141.820036298712, 5144.897102057976, 4904.485029071931, 4982.078315511642, 5032.6980381177245, 5045.4197767256865, 5062.392512898476, 5399.9730001350135, 5449.891002179934, 5463.043967305705, 5464.508194262496, 5469.371022332443, 5903.468687818074, 5906.763729450817, 5936.821895343147, 5939.406059394026, 5940.524758019348, 5924.407559244084, 5955.464008239236, 6013.458788708994, 6026.397360263939, 6036.9396306036815, 5522.337319521643, 5523.530499907512, 5526.50261476465, 5549.639273447213, 5556.944430555643, 5870.031444811643, 6020.247469066367, 6032.336442991267, 6038.6678732670125, 6042.516598672096, 5763.077907534775, 5791.536677065825, 5791.942080579141, 5805.535557155417, 5814.0, 5834.94165058344, 5853.707314634251, 5854.619449735754, 5866.061430171152, 5867.501262392744, 5665.858353541112, 5821.243238378984, 5828.737706803204, 5840.1239814027385, 5901.498372638288, 5825.2135961644635, 5837.29952405714, 5852.795152169653, 5878.911816322759, 5879.412058794086, 4452.220861349251, 4464.084862603158, 4465.843695470643, 4479.596836284685, 4484.686071974996, 3948.6051394860283, 3965.643092121723, 4032.858849940238, 4036.4348991141264, 4039.373897045904, 5522.889542209134, 5523.972380138073, 5548.0, 5552.11166213412, 5562.554995600342, 5855.531557475391, 5876.059830427112, 5894.469497745224, 5898.852528686817, 5899.616524925866, 5399.595030372738, 5487.533559647395, 5513.8345849624575, 5565.1095824667855, 5579.6652200868075, 5076.162433198481, 5091.159958606789, 5112.182050871843, 5112.207607820794, 5114.105031619451, 6098.573099882966, 6124.418180272867, 6141.938580614136, 6147.385261473906, 6153.98459254227, 5761.654300741969, 5848.619839710405, 5914.526837852962, 5961.254843144607, 5964.254468191476, 6037.547183961133, 6066.090086486885, 6070.878582428415, 6075.605085669417, 6078.513718902389, 5764.971175144097, 5773.191753154478, 5777.191193232867, 5778.219940308005, 5780.046292361713, 5781.913271300849, 5907.704614769158, 5968.820935371946, 5975.103734439869, 5989.910151347821, 5748.540116790563, 5750.913736293875, 5767.423257674199, 5773.8556536086935, 5785.016547187072, 5678.943210568007, 5715.942840571707, 5726.914096288476, 5733.197352370755, 5734.541236701138, 5597.44025597437, 5630.211770352236, 5692.231548740867, 5709.0, 5718.571107166896, 5802.187693722966, 5805.796797112081, 5859.472647461578, 5863.794767183128, 5873.207117039145, 5565.248691426767, 5765.221695071112, 5765.365809760839, 5771.336296325976, 5781.537477001913], "value": 5443.96460653001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.7443571442851, 678.308125711774, 680.0920770771017, 740.9555426674398, 756.8873755579297, 32112.357752844957, 40438.59561404385, 40462.0, 40585.1882962341, 40602.0, 43627.78186109065, 44341.7782911085, 44348.3347749784, 44354.55645443553, 44366.77816610921, 7906.881396779053, 8865.999999999984, 9096.727098187064, 10451.738706532322, 10616.46917654118, 10515.579376824919, 10630.62792802252, 10632.893671063268, 10640.733981650443, 10646.25476216665, 10607.469626518681, 10655.78688426231, 10668.093212076983, 10671.19966002549, 10671.733206669818, 8245.257926786588, 10511.84232236517, 10554.419506927154, 10681.0921071709, 10690.51892664832, 10641.14870810341, 10745.83881241782, 10750.516226769736, 10757.623483178051, 10770.838437423445, 39226.0, 39748.20503589941, 39786.0, 39806.80096599527, 39817.60182398197, 3639.636036396366, 3769.2838360711376, 3805.296020236265, 4093.570175131628, 4242.957570424287, 33913.49129763056, 34659.4801077984, 34681.65318346809, 34767.0, 34768.304633907435, 4455.77721113943, 4521.525239849834, 4584.931226031612, 4588.4035075440315, 4590.793414296365, 232346.0, 234703.99999999828, 234836.0, 235223.0, 236153.99999999828, 41155.7942210287, 41901.0, 41974.37038444426, 69677.0, 70904.0, 39644.207115858095, 39694.603053969666, 39714.20571588552, 39896.60103398987, 39917.600823991386, 17366.305347785947, 17463.301467941394, 17464.039477828843, 17475.912620436815, 17483.56291092733, 13805.585832425044, 13871.4451421942, 14007.789883151761, 14018.369173387222, 14018.789718154236, 9441.961384247727, 9444.669436569688, 9470.668526601536, 9510.71605333285, 9539.856902146474, 3698.2973235085246, 3740.756850804689, 3771.660550550409, 3777.905552361213, 3790.924181516354, 1163.662537864027, 1207.903367730597, 1213.8543374794904, 1222.5720997650928, 1288.62629837348, 33058.83470582632, 33261.16847078794, 33668.66331336704, 33735.493967590504, 34776.65223347785, 1241.267652085274, 1255.7174635707077, 1267.6674918150647, 1275.7610393758894, 1301.563976068009, 18276.268949241883, 18998.71501927472, 19008.619827603372, 19141.13864876084, 19219.423417297505, 467163.0, 472537.0, 473338.0, 473392.0, 473584.0, 62927.0, 64487.67756161189, 64659.353406465336, 64735.67632161809, 65061.67469162624, 1371.2869307959804, 1535.5777161280737, 1555.183528647469, 1580.2730743857724, 1584.9207539622973, 30994.69005309918, 32486.187845304055, 32723.0, 33305.83347083249, 33329.50005749867, 53965.73017134889, 62710.6864465693, 64087.0, 64119.358806413205, 64371.35628643654, 408357.0, 411059.0, 411983.0, 412748.0, 415433.69132617785, 40987.7950610245, 46996.530034699215, 49111.0, 49268.75365623149, 49748.00503989828, 45398.54601453943, 45510.54489455063, 46549.767251163525, 46694.29958550556, 54376.72811635916, 37621.81189094037, 39794.80102599468, 40379.59620403758, 40498.39252411275, 42194.156116876875, 41379.379309310985, 42476.088576013535, 42916.78541607272, 43345.78327108344, 44042.559574403844, 42819.357709635005, 43156.13687726291, 43421.131577368906, 44269.33595995998, 44578.0, 36863.0, 38108.618913810504, 38135.809320953216, 38451.38979120613, 38830.223395531364, 29253.268668283465, 29267.414651706422, 29306.7069329304, 29445.0, 29462.705372945995], "value": 20239.08502754635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.9118689481761, 414.98340066397344, 416.6312813160352, 425.7679564637272, 432.08613781851375, 12943.935280323609, 18445.077746112707, 19057.0, 19082.713759293605, 20226.69659955098, 16107.43623973161, 17515.386961456352, 19223.32718354858, 20238.0, 20757.688634670456, 5558.972205138979, 5929.792457263997, 5953.285605727318, 5955.136505206742, 5957.404259574051, 5875.882482350372, 5916.585838991272, 5938.940610593882, 5943.257092863392, 5945.732442040097, 4252.425922500453, 5960.284765828107, 6113.7860174893885, 6345.048242763576, 6350.968245158768, 6300.5589608727405, 6304.117423560705, 6307.495400367982, 6350.174477317943, 6362.777302794403, 5446.972765136149, 5657.0, 5707.971460142714, 5708.029634962067, 5710.65736055838, 20976.895115524323, 21071.789282107136, 21448.678269825967, 21542.784572154236, 21678.34964951054, 2289.5077558324874, 2427.9757202427927, 2444.168982545943, 2467.938301542458, 2678.209928071204, 10037.0, 10229.0, 10424.426656533888, 11544.884551154464, 14440.0, 1821.763170787789, 2028.7362642856335, 2048.2523878784286, 2075.6886467030067, 2086.1655337864822, 76189.0, 80728.0, 81437.59281203615, 81480.77778833381, 82028.58985705093, 9879.950600246953, 10623.628173013907, 10688.198385121146, 11168.888311116947, 11188.160887933438, 14475.059121157092, 14477.710445791025, 14570.19863907474, 14601.342939567745, 14622.488212912496, 8301.750947471586, 8627.482351058956, 8692.391532592657, 8709.564521774013, 8744.519051452231, 8629.180227878342, 8632.741017769476, 8633.69782057625, 8664.913350866536, 8752.64989400417, 4475.955240447619, 4749.2876068589985, 4905.583025442806, 4985.252212168131, 4996.275540046746, 1926.4509614759727, 2065.98967005164, 2086.6244076066455, 2095.1200495791804, 2125.341144245258, 1049.569676432659, 1101.8512500812449, 1209.1958847366402, 1211.7515909238584, 1226.141700809437, 18178.091095445176, 18423.631527369376, 18656.160472778487, 18758.1558829853, 18938.431847044612, 1086.6794295682635, 1090.607381342716, 1091.6233899304727, 1128.6444769897455, 1163.2497039409702, 10428.322159059637, 10444.373337599769, 10559.736006599896, 10562.89437105619, 10622.0, 356697.0, 365990.0, 456066.0, 457360.0, 467691.0, 82432.0, 84193.57903210445, 91155.0, 98202.50898745461, 99884.50057749664, 1116.3748300951493, 1144.70237738187, 1157.6064138193055, 1162.430409099552, 1163.7148898519918, 16435.67128657444, 16443.58891027734, 16711.498655040366, 16753.32986680519, 16894.40869569559, 36368.63631363758, 39178.80410597929, 40484.3927341096, 41116.794416027726, 41548.0, 57048.429515705975, 57615.711921440125, 57942.71028644998, 58064.0, 58299.4170058294, 8776.692815751418, 8834.734957951272, 8889.288856891562, 9001.18989290967, 9002.0, 9996.900030999597, 10725.946370268099, 12730.17253878495, 12924.289164096064, 13512.391942362421, 11351.37567433799, 11425.942870285928, 11593.188476806543, 11605.709857253636, 11814.94092529532, 11222.102231821598, 11250.774984500427, 11371.601993930173, 11761.411929403666, 11823.82264266054, 11446.313221206754, 11722.824157637813, 11756.94121529387, 11817.113716471471, 11846.348450835287, 8545.572721364031, 8548.700795472128, 8635.956820215859, 8768.079351667982, 8833.29333653319, 10773.89226107729, 11623.825642615537, 11965.16243862956, 12116.636500904988, 12201.02391808671], "value": 9328.261133468159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.9499517516888, 1604.4785444730462, 1605.99197004015, 1838.567936534914, 1900.952476188096, 7510.361619262362, 8244.752657420271, 8363.707270245535, 8379.24586787189, 8385.0357208921, 8248.46384984977, 8429.45208561443, 8430.747077587666, 8437.451565648229, 8450.366222533305, 2116.6401711709045, 2370.383700237933, 2425.3936515871032, 2438.3782135555407, 2463.4949835283724, 2435.8538487690794, 2442.6702395176603, 2447.437089469423, 2449.2774631483753, 2451.240115564172, 2368.2658375903525, 2425.5391475619576, 2428.441458464554, 2432.5499782540196, 2434.062885788975, 2128.755193152792, 2332.0322066342446, 2382.9046838126455, 2383.0229605861687, 2385.5109702510945, 2337.789598936087, 2351.1418332308754, 2352.8235382346393, 2352.9058837646476, 2414.8430352027062, 8311.667533298662, 8384.413091083627, 8414.653655415104, 8422.326213902874, 8439.915600843975, 5346.331708536433, 5523.061079616435, 5526.889462210734, 5528.364238112588, 5535.501804837584, 3457.291255292684, 3522.630123836986, 3532.2405682778067, 3617.656322649344, 3619.9276014479565, 1079.8326259429723, 1093.5899037860802, 1112.75927341015, 1136.5908273021705, 1140.589387820384, 11988.70028249292, 12070.879291207064, 12080.214786038967, 12091.57679481214, 12103.697407564794, 4677.18149323867, 4770.76146192689, 4792.664513484023, 4793.856184314476, 4795.040991801584, 10219.540120694586, 10229.283950123569, 10252.436116013541, 10261.28171028021, 10274.0, 4706.482286948433, 5417.3770016447825, 5457.372402173722, 5461.808836690697, 5465.945340546623, 4298.161858437575, 4351.3472979053395, 4351.673624478177, 4921.434035086011, 5013.799448022039, 4101.774402407897, 4124.205970402884, 4209.473815773028, 4251.171021650748, 4261.914761704748, 1325.5691900132495, 1360.768669326217, 1377.7106807570322, 1378.9172649641055, 1379.6137081617164, 1023.3246057601947, 1023.534291897185, 1030.2015937648382, 1038.4548112240982, 1049.3598904668147, 5837.7664893404635, 5845.571619426993, 5863.419397913355, 5942.3166335871065, 5951.613145145551, 475.9714417134983, 479.04908756119073, 483.3450674336224, 489.1195847474532, 491.83277685587075, 4016.4376987221813, 4017.6384125428267, 4017.8593749218635, 4033.576474470197, 4113.506379234511, 9974.551145198484, 10152.593896244216, 10306.227032972407, 10483.697635244873, 10515.26393152472, 10263.538140783683, 10322.948385258025, 10331.276810623334, 10340.121089707309, 10398.636047738444, 7704.460687751915, 8077.798055048554, 8186.426950113435, 8200.220979006985, 8234.0, 5625.774969001194, 5665.461781130786, 5740.167675687086, 5796.0, 5821.039528477754, 9062.04848490899, 9091.363604547883, 9358.251339892928, 9384.343095983215, 9406.717798466058, 9403.764905877408, 9575.138237558653, 9592.08875156859, 9835.0, 9855.0, 6724.932750672627, 7331.120265567953, 7393.297636724503, 7504.0, 7551.773446796605, 8127.959360203397, 8154.1030486647605, 8163.551004694798, 8201.343892488705, 8217.506949583045, 7266.346028857428, 7363.447741419308, 7419.591922444318, 7511.098668159856, 7521.022267105242, 7321.707131714672, 7389.187189409053, 7393.334599886036, 7479.738209162653, 7486.850262994819, 6794.592324460548, 6859.657017149222, 6909.516333856582, 6911.136107986502, 6919.550229235084, 5179.40436849752, 5218.269442278008, 5378.811741589026, 5382.946170538401, 5396.325459317585, 5342.6260161788305, 5351.0, 5378.435264297193, 5476.698781567052, 5542.7782888684005], "value": 4539.354312363313, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.44728434504793, 349.46531806336316, 352.3474902706309, 354.75699146084935, 358.4390428978648, 6329.7151628176725, 6330.3036665966765, 6360.236771587404, 6364.904526432101, 6367.426931576158, 6398.488120950325, 6424.132742079818, 6430.421262086411, 6434.485241180706, 6440.967795161029, 4626.444826620802, 4747.05058988202, 4853.441854186761, 4874.293227482013, 4881.194602890519, 4830.2513110467935, 4836.250381190904, 4852.660313778037, 4855.514448555134, 4874.512548745115, 4612.377329060584, 4813.735244561548, 4837.7822997965, 4841.273808928671, 4844.612431005528, 4692.554207350297, 4693.108309421216, 4742.051589682077, 4838.250071238964, 4845.709257444564, 4222.366645003243, 4241.300185469394, 4247.256730072225, 4249.383839343278, 4258.91482170358, 6105.358937311563, 6116.602420842631, 6123.203983482119, 6123.785667501661, 6127.89697854386, 5547.223388725582, 5598.300212473441, 5603.411641777596, 5615.578831587606, 5633.239512665819, 6493.155889734351, 6697.129373181455, 6701.128853249095, 6702.865942681119, 6705.6982435790505, 4505.684602077856, 4518.887027824298, 4521.231390663595, 4522.3668686383935, 4537.0, 6921.377076063128, 6957.965210173917, 7004.754833580801, 7006.4745144114395, 7010.789676309668, 4683.882902927386, 4695.906081878344, 4697.201475749062, 4697.929531057037, 4701.106789709944, 4754.667173297836, 4755.762211889391, 4755.881102972453, 4761.95238047622, 4764.857054288377, 5537.833864984057, 5540.861478463071, 5554.250411120484, 5596.38439771633, 5602.607817452739, 6479.546431749826, 6794.048833163361, 6844.589324640438, 6849.075374824434, 6851.45188384928, 1630.755386691982, 1649.1424459281106, 1649.9010059396476, 1659.062629614264, 1664.3924967387059, 1020.637673625867, 1052.8526006359116, 1061.7345663584103, 1077.0737166037202, 1077.4720387010466, 6293.653849038255, 6457.4511166551365, 6468.059582125344, 6535.444487218545, 6540.869182616321, 6954.513184077066, 6974.511784175161, 6996.440284777307, 7003.5797852129035, 7010.123734533184, 6478.708458119396, 6497.8700425992165, 6506.544541882023, 6515.218173819172, 6515.641639709766, 3710.8144592770795, 3748.9690335158048, 3753.6809371203753, 3764.3600587900123, 3766.2090960898518, 7104.964475177694, 7138.250483699137, 7249.130104387507, 7251.383632391306, 7264.782056538313, 7068.434525237969, 7070.717171313193, 7093.787186384417, 7100.5029647925185, 7105.360517553341, 7246.891296630555, 7249.492535522569, 7250.0, 7251.1661158966335, 7253.709851605982, 6975.337342952412, 6977.1278590176225, 6984.0, 6986.47601429905, 6988.545744526589, 6724.596524208563, 6862.245153033262, 6875.621840798804, 6877.862442751217, 6882.7591034313555, 7204.423646108404, 7241.0, 7241.891371629325, 7250.41996640257, 7268.96365518169, 4690.648201384842, 4705.270683044134, 4710.128626204163, 4713.528647135259, 4713.952860471351, 6972.09362782835, 6974.61639609806, 6975.093237879043, 6977.3720365165345, 6978.092847929736, 6645.1361323027695, 6808.387245147763, 6817.0456136141975, 6839.931600684128, 6845.726170953106, 6737.191537015589, 6743.696533656095, 6783.864322713617, 6788.422984046214, 6801.965990170018, 6654.933450665625, 6658.201015878126, 6659.833504162435, 6676.432503237279, 6677.499187560855, 6768.932310676831, 6807.0810440589885, 6836.658167091526, 6900.758473453606, 6914.204866440223, 6345.841353966188, 6399.168108145911, 6486.254080780771, 6624.337566243337, 6672.6997285121315], "value": 5055.679858081902, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [929.0848514213499, 939.9107084826943, 948.3503799897069, 959.040959040959, 978.0415193110756, 14609.050411723243, 14777.630559236024, 14785.630359241024, 14797.778033329496, 15071.547853564396, 12960.416781244843, 13003.674908127301, 13038.543650972219, 13038.60884173474, 13144.079914405995, 941.1858742188026, 958.3483231402644, 959.7840485890689, 960.011188475871, 960.2605993385089, 931.9394239374453, 936.166811537732, 942.1661829281102, 942.63708472238, 944.315371355765, 981.4847205217246, 988.2736188901152, 989.6882482018141, 989.8515222716615, 990.3265779270093, 976.6093562574991, 978.2614126334643, 980.2403137568406, 980.4215512847383, 980.9607615695328, 718.0736849464184, 718.5616773767997, 718.6694120704482, 719.6401799100449, 720.8450183210582, 13548.525801596898, 13621.25083120428, 13644.113132646446, 13663.931680341633, 13688.589342319747, 12833.935830320788, 12842.807357889638, 12878.935605321913, 12953.54662586805, 13074.542391016364, 10721.62474313403, 13189.634076301098, 13411.865881341158, 13572.728545429134, 13772.517961871386, 4646.279826626878, 4700.083483720676, 4831.637627177975, 4883.072216278932, 4893.02139572087, 49956.0, 55491.44508554903, 56207.718961404935, 56287.71856140693, 57888.71055644737, 11012.452733068032, 12042.698932526757, 12217.083718721131, 12219.816702749466, 12312.322822244863, 20508.0, 20509.692354614694, 20547.486312842, 20550.794492055185, 20584.897075514527, 8752.64989400417, 8837.60230789616, 8851.911480885108, 8870.467771933576, 8966.282697384324, 4738.620910327235, 4749.762511874462, 4858.1012512685265, 4874.098291816025, 4934.9013019739405, 3527.9294414111573, 3537.0626783902285, 3556.05764472415, 3565.750397472152, 3585.5697316321684, 434.57845889487146, 438.2462165076064, 594.1355327997753, 664.6377724140258, 682.3347236444426, 640.6252342379667, 771.502380964275, 828.0808302783905, 834.8956380452444, 842.098954119099, 9664.75838104039, 9756.90243097574, 9809.264305177141, 10122.44326562046, 10206.693799186036, 709.9964500177466, 795.4988357334842, 799.6601444386113, 819.3199644295221, 853.0786750309651, 4494.662900282492, 4602.689122361007, 4775.832845850378, 4818.734969576707, 4861.270809378621, 65144.67427662831, 65543.0, 66114.33885661082, 67225.32774672289, 67282.66358668175, 57328.14007789887, 57689.0, 57865.13202301969, 58966.70516647389, 59305.40694593085, 50935.745321273156, 51449.48550514597, 51856.22215666768, 52653.7367313161, 52692.0, 9718.70843874685, 9771.511424428609, 9778.85331720039, 9858.162056225301, 9883.50582470888, 37833.62166378411, 37916.05209869775, 38618.22763544657, 39776.40335395029, 40209.79895100506, 45498.31752523781, 47562.52437475581, 47891.0, 51178.23232651588, 51683.224751628004, 12194.451249693608, 12440.688982775502, 12910.870891291343, 13510.189388636712, 13612.591622251348, 13862.237576933365, 14027.859721402656, 14398.856011439751, 14666.19335936491, 14937.253137343307, 12275.93862030684, 13750.724985500434, 14269.143851368952, 14409.207493587954, 14734.484293049692, 12697.047721420746, 13188.280848985582, 13473.19160850313, 13750.312484375941, 14009.84927622751, 12060.0, 12376.938115309726, 13543.796843047165, 13571.253581053137, 13699.452021919411, 11577.884221157681, 11597.478113485082, 11816.527338906348, 11836.526538938691, 11903.10726695484, 11539.942300288445, 11547.826782598437, 11589.130815189063, 11899.940500297444, 11989.940050299692], "value": 7260.273691457838, "unit": "score"}], "name": "dromaeo_css", "value": 7452.102756663534, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 109.0, 109.0, 111.0, 110.0, 105.0, 110.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 151.0, 177.0, 126.0, 153.0, 153.0, 126.0, 188.0, 126.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 160.0, 159.0, 160.0, 164.0, 160.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 162.0, 77.0, 73.0, 74.0, 76.0, 169.0, 75.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 154.0, 92.0, 92.0, 91.0, 146.0, 91.0, 92.0, 144.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 97.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 53.0, 55.0, 70.0, 54.0, 52.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 58.0, 58.0, 58.0, 57.0, 59.0, 60.0, 58.0, 57.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 77.0, 77.0, 77.0, 84.0, 76.0, 74.0, 74.0, 72.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 112.0, 120.0, 118.0, 111.0, 118.0, 126.0, 129.0, 116.0], "value": 118.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 156.0, 159.0, 159.0, 162.0, 154.0, 155.0, 157.0, 158.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 64.0, 66.0, 65.0, 64.0, 63.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1508.8999999999999, "alertThreshold": 2.0}]} 10:50:20 INFO - Return code: 0 10:50:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:50:20 ERROR - # TBPL SUCCESS # 10:50:20 INFO - Running post-action listener: _resource_record_post_action 10:50:20 INFO - Running post-run listener: _resource_record_post_run 10:50:22 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7917568; Write bytes: 380805120; Read time: 912; Write time: 379160 10:50:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7401472; Read time: 0; Write time: 3228 10:50:22 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6180864; Write bytes: 373403648; Read time: 872; Write time: 375932 10:50:22 INFO - Running post-run listener: _upload_blobber_files 10:50:22 INFO - Blob upload gear active. 10:50:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:50:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:50:22 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'] 10:50:22 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 10:50:22 INFO - (blobuploader) - INFO - Open directory for files ... 10:50:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:50:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:50:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:50:23 INFO - (blobuploader) - INFO - Done attempting. 10:50:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:50:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:50:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:50:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:50:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:50:24 INFO - (blobuploader) - INFO - Done attempting. 10:50:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:50:24 INFO - Return code: 0 10:50:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:50:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:50:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1e6e335859c4988cc157e3c5601bdfb14e229759de18ad632a5856a0b9a92e1dfaa1705d20865fdd1e9597a7c4b8d5eb5a654f450ab918d98123ad4c26d5708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad75644aeba0cdf004d6bd9503a6fbacb352a9c897600027183deba63d480d48c8a3e0e9ac233281b89fa79670487f07c7f3661ae8b7302b2812dd765a59506"} 10:50:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:50:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:50:24 INFO - Contents: 10:50:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1e6e335859c4988cc157e3c5601bdfb14e229759de18ad632a5856a0b9a92e1dfaa1705d20865fdd1e9597a7c4b8d5eb5a654f450ab918d98123ad4c26d5708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad75644aeba0cdf004d6bd9503a6fbacb352a9c897600027183deba63d480d48c8a3e0e9ac233281b89fa79670487f07c7f3661ae8b7302b2812dd765a59506"} 10:50:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:50:24 INFO - Copying logs to upload dir... 10:50:24 INFO - mkdir: /builds/slave/test/build/upload/logs 10:50:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.200064 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 10:50:24.125548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:50:24.129086) ========= 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=7de08804244eb36560b44971000001c3-1464629386.730812-259093068 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/d1e6e335859c4988cc157e3c5601bdfb14e229759de18ad632a5856a0b9a92e1dfaa1705d20865fdd1e9597a7c4b8d5eb5a654f450ab918d98123ad4c26d5708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad75644aeba0cdf004d6bd9503a6fbacb352a9c897600027183deba63d480d48c8a3e0e9ac233281b89fa79670487f07c7f3661ae8b7302b2812dd765a59506"} build_url:https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/ekcSWje3RceGC2ukUq6UUQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1e6e335859c4988cc157e3c5601bdfb14e229759de18ad632a5856a0b9a92e1dfaa1705d20865fdd1e9597a7c4b8d5eb5a654f450ab918d98123ad4c26d5708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad75644aeba0cdf004d6bd9503a6fbacb352a9c897600027183deba63d480d48c8a3e0e9ac233281b89fa79670487f07c7f3661ae8b7302b2812dd765a59506"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:50:24.154842) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:50:24.155233) ========= 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=7de08804244eb36560b44971000001c3-1464629386.730812-259093068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:50:24.239875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:50:24.240282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:50:24.240687) ========= ========= Total master_lag: 0.18 =========