builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1463823677.75 results: success (0) buildid: 20160521000929 builduid: c09c316c80464cf980cd49e397ca52cf revision: 8b81a6c988c496aaff85df718646e17239c1e278 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:17.749166) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:17.749692) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:17.749973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:17.796723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:17.797044) ========= 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=6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 02:41:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-21 02:41:17 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112154 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:17.925841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:17.926144) ========= 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=6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019518 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:17.982774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:17.983083) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8b81a6c988c496aaff85df718646e17239c1e278 --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 8b81a6c988c496aaff85df718646e17239c1e278 --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=6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 02:41:18,072 truncating revision to first 12 chars 2016-05-21 02:41:18,072 Setting DEBUG logging. 2016-05-21 02:41:18,072 attempt 1/10 2016-05-21 02:41:18,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8b81a6c988c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 02:41:18,313 unpacking tar archive at: mozilla-aurora-8b81a6c988c4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.511695 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:18.509744) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:18.510198) ========= script_repo_revision: 8b81a6c988c496aaff85df718646e17239c1e278 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:18.510641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:18.511246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 02:41:18.523362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-21 02:41:18.523647) ========= /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=6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:41:18 INFO - MultiFileLogger online at 20160521 02:41:18 in /builds/slave/test 02:41:18 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 02:41:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:41:18 INFO - {'append_to_log': False, 02:41:18 INFO - 'base_work_dir': '/builds/slave/test', 02:41:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:41:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:41:18 INFO - 'branch': 'Mozilla-Aurora', 02:41:18 INFO - 'buildbot_json_path': 'buildprops.json', 02:41:18 INFO - 'config_files': ('talos/linux_config.py',), 02:41:18 INFO - 'default_actions': ('clobber', 02:41:18 INFO - 'read-buildbot-config', 02:41:18 INFO - 'download-and-extract', 02:41:18 INFO - 'populate-webroot', 02:41:18 INFO - 'create-virtualenv', 02:41:18 INFO - 'install', 02:41:18 INFO - 'run-tests'), 02:41:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:41:18 INFO - 'download_minidump_stackwalk': True, 02:41:18 INFO - 'download_symbols': 'ondemand', 02:41:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:41:18 INFO - 'tooltool.py': '/tools/tooltool.py', 02:41:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:41:18 INFO - '/tools/misc-python/virtualenv.py')}, 02:41:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:41:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:41:18 INFO - 'installer_path': 'installer.exe', 02:41:18 INFO - 'log_level': 'info', 02:41:18 INFO - 'log_name': 'talos', 02:41:18 INFO - 'log_to_console': True, 02:41:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:41:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:41:18 INFO - 'opt_config_files': (), 02:41:18 INFO - 'pip_index': False, 02:41:18 INFO - 'sps_profile': False, 02:41:18 INFO - 'sps_profile_interval': 0, 02:41:18 INFO - 'suite': 'dromaeojs', 02:41:18 INFO - 'system_bits': '32', 02:41:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:41:18 INFO - 'title': 'talos-linux64-ix-050', 02:41:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:41:18 INFO - 'use_talos_json': True, 02:41:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:41:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:41:18 INFO - 'work_dir': 'build'} 02:41:18 INFO - ##### 02:41:18 INFO - ##### Running clobber step. 02:41:18 INFO - ##### 02:41:18 INFO - Running pre-action listener: _resource_record_pre_action 02:41:18 INFO - Running main action method: clobber 02:41:18 INFO - rmtree: /builds/slave/test/build 02:41:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:41:19 INFO - Running post-action listener: _resource_record_post_action 02:41:19 INFO - ##### 02:41:19 INFO - ##### Running read-buildbot-config step. 02:41:19 INFO - ##### 02:41:19 INFO - Running pre-action listener: _resource_record_pre_action 02:41:19 INFO - Running main action method: read_buildbot_config 02:41:19 INFO - Using buildbot properties: 02:41:19 INFO - { 02:41:19 INFO - "project": "", 02:41:19 INFO - "product": "firefox", 02:41:19 INFO - "script_repo_revision": "production", 02:41:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:41:19 INFO - "repository": "", 02:41:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:41:19 INFO - "buildid": "20160521000929", 02:41:19 INFO - "pgo_build": "True", 02:41:19 INFO - "basedir": "/builds/slave/test", 02:41:19 INFO - "buildnumber": 246, 02:41:19 INFO - "slavename": "talos-linux64-ix-050", 02:41:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:41:19 INFO - "platform": "ubuntu64_hw", 02:41:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:41:19 INFO - "branch": "mozilla-aurora", 02:41:19 INFO - "repo_path": "releases/mozilla-aurora", 02:41:19 INFO - "revision": "8b81a6c988c496aaff85df718646e17239c1e278", 02:41:19 INFO - "stage_platform": "linux64-pgo", 02:41:19 INFO - "builduid": "c09c316c80464cf980cd49e397ca52cf", 02:41:19 INFO - "slavebuilddir": "test" 02:41:19 INFO - } 02:41:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 02:41:19 INFO - Running post-action listener: _resource_record_post_action 02:41:19 INFO - ##### 02:41:19 INFO - ##### Running download-and-extract step. 02:41:19 INFO - ##### 02:41:19 INFO - Running pre-action listener: _resource_record_pre_action 02:41:19 INFO - Running main action method: download_and_extract 02:41:19 INFO - mkdir: /builds/slave/test/build/tests 02:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:19 INFO - https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:41:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 02:41:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 02:41:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:22 INFO - Downloaded 1361 bytes. 02:41:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 02:41:22 INFO - Using the following test package requirements: 02:41:22 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 02:41:22 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:41:22 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:41:22 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:22 INFO - u'jsshell-linux-x86_64.zip'], 02:41:22 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:41:22 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 02:41:22 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:41:22 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:41:22 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:41:22 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 02:41:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:41:22 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:41: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')]} 02:41:22 INFO - https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:41:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 02:41:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 02:41:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:23 INFO - Downloaded 23812944 bytes. 02:41:23 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'] 02:41:23 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 02:41:24 INFO - Return code: 0 02:41:24 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 02:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:24 INFO - https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:41:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 02:41:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 02:41:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:25 INFO - Downloaded 23812944 bytes. 02:41:25 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'] 02:41:25 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 02:41:26 INFO - Return code: 0 02:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:26 INFO - https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:41:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 02:41:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 02:41:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:28 INFO - Downloaded 10840145 bytes. 02:41:28 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'] 02:41:28 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 02:41:28 INFO - Return code: 0 02:41:28 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')]} 02:41:28 INFO - https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 02:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 02:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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 02:41:31 INFO - Downloaded 62719868 bytes. 02:41:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 02:41:31 INFO - mkdir: /builds/slave/test/properties 02:41:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:41:31 INFO - Writing to file /builds/slave/test/properties/build_url 02:41:31 INFO - Contents: 02:41:31 INFO - build_url:https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 02:41:32 INFO - Running post-action listener: _resource_record_post_action 02:41:32 INFO - Running post-action listener: set_extra_try_arguments 02:41:32 INFO - ##### 02:41:32 INFO - ##### Running populate-webroot step. 02:41:32 INFO - ##### 02:41:32 INFO - Running pre-action listener: _resource_record_pre_action 02:41:32 INFO - Running main action method: populate_webroot 02:41:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:41:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:41:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:41:32 INFO - '--tppagecycles', 02:41:32 INFO - '7'], 02:41:32 INFO - 'tests': ['tsvgm']}}, 02:41:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:41:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:41:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:41:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:41:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:32 INFO - 'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:32 INFO - 'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['damp', 'tps']}, 02:41:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:32 INFO - 'tests': ['damp', 'tps']}, 02:41:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['dromaeo_dom']}, 02:41:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:41:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['a11yr', 02:41:32 INFO - 'ts_paint', 02:41:32 INFO - 'tpaint', 02:41:32 INFO - 'sessionrestore', 02:41:32 INFO - 'sessionrestore_no_auto_restore', 02:41:32 INFO - 'tabpaint']}, 02:41:32 INFO - 'other-e10s': {'tests': ['a11yr', 02:41:32 INFO - 'ts_paint', 02:41:32 INFO - 'tpaint', 02:41:32 INFO - 'sessionrestore', 02:41:32 INFO - 'sessionrestore_no_auto_restore', 02:41:32 INFO - 'tabpaint']}, 02:41:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:41:32 INFO - 'ts_paint', 02:41:32 INFO - 'tpaint', 02:41:32 INFO - 'sessionrestore', 02:41:32 INFO - 'sessionrestore_no_auto_restore', 02:41:32 INFO - 'tabpaint']}, 02:41:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:41:32 INFO - 'ts_paint', 02:41:32 INFO - 'tpaint', 02:41:32 INFO - 'sessionrestore', 02:41:32 INFO - 'sessionrestore_no_auto_restore', 02:41:32 INFO - 'tabpaint']}, 02:41:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['a11yr', 02:41:32 INFO - 'ts_paint', 02:41:32 INFO - 'tpaint', 02:41:32 INFO - 'sessionrestore', 02:41:32 INFO - 'sessionrestore_no_auto_restore', 02:41:32 INFO - 'tabpaint']}, 02:41:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['a11yr', 02:41:32 INFO - 'ts_paint', 02:41:32 INFO - 'tpaint', 02:41:32 INFO - 'sessionrestore', 02:41:32 INFO - 'sessionrestore_no_auto_restore', 02:41:32 INFO - 'tabpaint']}, 02:41:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['tsvgx', 02:41:32 INFO - 'tsvgr_opacity', 02:41:32 INFO - 'tart', 02:41:32 INFO - 'tscrollx', 02:41:32 INFO - 'cart']}, 02:41:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:41:32 INFO - 'tsvgr_opacity', 02:41:32 INFO - 'tart', 02:41:32 INFO - 'tscrollx', 02:41:32 INFO - 'cart']}, 02:41:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:32 INFO - 'talos_options': ['--disable-e10s'], 02:41:32 INFO - 'tests': ['tp5o']}, 02:41:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:32 INFO - 'tests': ['tp5o']}, 02:41:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:32 INFO - 'talos_options': ['--disable-e10s', 02:41:32 INFO - '--xperf_path', 02:41:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:32 INFO - 'tests': ['tp5n']}, 02:41:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:32 INFO - 'talos_options': ['--xperf_path', 02:41:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:32 INFO - 'tests': ['tp5n']}}, 02:41:32 INFO - 'talos.zip': {'path': '', 02:41:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:41:32 INFO - Running post-action listener: _resource_record_post_action 02:41:32 INFO - ##### 02:41:32 INFO - ##### Running create-virtualenv step. 02:41:32 INFO - ##### 02:41:32 INFO - Running pre-action listener: _resource_record_pre_action 02:41:32 INFO - Running main action method: create_virtualenv 02:41:32 INFO - Creating virtualenv /builds/slave/test/build/venv 02:41:32 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 02:41:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:41:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:41:32 INFO - Using real prefix '/usr' 02:41:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:41:32 INFO - Installing distribute.............................................................................................................................................................................................done. 02:41:34 INFO - Installing pip.................done. 02:41:34 INFO - Return code: 0 02:41:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c46ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26315a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', '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 02:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:41:34 INFO - Using env: {'DISPLAY': ':0', 02:41:34 INFO - 'HOME': '/home/cltbld', 02:41:34 INFO - 'LANG': 'en_US.UTF-8', 02:41:34 INFO - 'LANGUAGE': 'en_US:en', 02:41:34 INFO - 'LOGNAME': 'cltbld', 02:41:34 INFO - 'MAIL': '/var/mail/cltbld', 02:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:34 INFO - 'MOZ_NO_REMOTE': '1', 02:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:34 INFO - 'NO_EM_RESTART': '1', 02:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:34 INFO - 'PWD': '/builds/slave/test', 02:41:34 INFO - 'SHELL': '/bin/bash', 02:41:34 INFO - 'SHLVL': '1', 02:41:34 INFO - 'TERM': 'linux', 02:41:34 INFO - 'TMOUT': '86400', 02:41:34 INFO - 'USER': 'cltbld', 02:41:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:34 INFO - '_': '/tools/buildbot/bin/python'} 02:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:34 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 02:41:34 INFO - Cleaning up... 02:41:34 INFO - Return code: 0 02:41:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5c46ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26315a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', '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 02:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:41:34 INFO - Using env: {'DISPLAY': ':0', 02:41:34 INFO - 'HOME': '/home/cltbld', 02:41:34 INFO - 'LANG': 'en_US.UTF-8', 02:41:34 INFO - 'LANGUAGE': 'en_US:en', 02:41:34 INFO - 'LOGNAME': 'cltbld', 02:41:34 INFO - 'MAIL': '/var/mail/cltbld', 02:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:34 INFO - 'MOZ_NO_REMOTE': '1', 02:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:34 INFO - 'NO_EM_RESTART': '1', 02:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:34 INFO - 'PWD': '/builds/slave/test', 02:41:34 INFO - 'SHELL': '/bin/bash', 02:41:34 INFO - 'SHLVL': '1', 02:41:34 INFO - 'TERM': 'linux', 02:41:34 INFO - 'TMOUT': '86400', 02:41:34 INFO - 'USER': 'cltbld', 02:41:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:34 INFO - '_': '/tools/buildbot/bin/python'} 02:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:35 INFO - Downloading/unpacking psutil>=0.7.1 02:41:35 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 02:41:35 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 02:41:35 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 02:41:35 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 02:41:35 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 02:41:35 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 02:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:41:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:37 INFO - Installing collected packages: psutil 02:41:37 INFO - Running setup.py install for psutil 02:41:37 INFO - building 'psutil._psutil_linux' extension 02:41:37 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 02:41:37 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 02:41:37 INFO - building 'psutil._psutil_posix' extension 02:41:37 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 02:41:37 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 02:41:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:37 INFO - Successfully installed psutil 02:41:37 INFO - Cleaning up... 02:41:37 INFO - Return code: 0 02:41:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5c46ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26315a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', '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 02:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:41:37 INFO - Using env: {'DISPLAY': ':0', 02:41:37 INFO - 'HOME': '/home/cltbld', 02:41:37 INFO - 'LANG': 'en_US.UTF-8', 02:41:37 INFO - 'LANGUAGE': 'en_US:en', 02:41:37 INFO - 'LOGNAME': 'cltbld', 02:41:37 INFO - 'MAIL': '/var/mail/cltbld', 02:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:37 INFO - 'MOZ_NO_REMOTE': '1', 02:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:37 INFO - 'NO_EM_RESTART': '1', 02:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:37 INFO - 'PWD': '/builds/slave/test', 02:41:37 INFO - 'SHELL': '/bin/bash', 02:41:37 INFO - 'SHLVL': '1', 02:41:37 INFO - 'TERM': 'linux', 02:41:37 INFO - 'TMOUT': '86400', 02:41:37 INFO - 'USER': 'cltbld', 02:41:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:37 INFO - '_': '/tools/buildbot/bin/python'} 02:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:41:39 INFO - Installing collected packages: mozsystemmonitor 02:41:39 INFO - Running setup.py install for mozsystemmonitor 02:41:39 INFO - Successfully installed mozsystemmonitor 02:41:39 INFO - Cleaning up... 02:41:39 INFO - Return code: 0 02:41:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c46ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26315a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', '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 02:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:41:39 INFO - Using env: {'DISPLAY': ':0', 02:41:39 INFO - 'HOME': '/home/cltbld', 02:41:39 INFO - 'LANG': 'en_US.UTF-8', 02:41:39 INFO - 'LANGUAGE': 'en_US:en', 02:41:39 INFO - 'LOGNAME': 'cltbld', 02:41:39 INFO - 'MAIL': '/var/mail/cltbld', 02:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:39 INFO - 'MOZ_NO_REMOTE': '1', 02:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:39 INFO - 'NO_EM_RESTART': '1', 02:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:39 INFO - 'PWD': '/builds/slave/test', 02:41:39 INFO - 'SHELL': '/bin/bash', 02:41:39 INFO - 'SHLVL': '1', 02:41:39 INFO - 'TERM': 'linux', 02:41:39 INFO - 'TMOUT': '86400', 02:41:39 INFO - 'USER': 'cltbld', 02:41:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:39 INFO - '_': '/tools/buildbot/bin/python'} 02:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:40 INFO - Downloading/unpacking blobuploader==1.2.4 02:41:40 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 02:41:40 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 02:41:40 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 02:41:40 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 02:41:40 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 02:41:40 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 02:41:41 INFO - Downloading blobuploader-1.2.4.tar.gz 02:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:41:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:41:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:42 INFO - Downloading docopt-0.6.1.tar.gz 02:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:41:42 INFO - Installing collected packages: blobuploader, requests, docopt 02:41:42 INFO - Running setup.py install for blobuploader 02:41:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:41:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:41:42 INFO - Running setup.py install for requests 02:41:43 INFO - Running setup.py install for docopt 02:41:43 INFO - Successfully installed blobuploader requests docopt 02:41:43 INFO - Cleaning up... 02:41:43 INFO - Return code: 0 02:41:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c46ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26315a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', '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 02:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:43 INFO - Using env: {'DISPLAY': ':0', 02:41:43 INFO - 'HOME': '/home/cltbld', 02:41:43 INFO - 'LANG': 'en_US.UTF-8', 02:41:43 INFO - 'LANGUAGE': 'en_US:en', 02:41:43 INFO - 'LOGNAME': 'cltbld', 02:41:43 INFO - 'MAIL': '/var/mail/cltbld', 02:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:43 INFO - 'MOZ_NO_REMOTE': '1', 02:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:43 INFO - 'NO_EM_RESTART': '1', 02:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:43 INFO - 'PWD': '/builds/slave/test', 02:41:43 INFO - 'SHELL': '/bin/bash', 02:41:43 INFO - 'SHLVL': '1', 02:41:43 INFO - 'TERM': 'linux', 02:41:43 INFO - 'TMOUT': '86400', 02:41:43 INFO - 'USER': 'cltbld', 02:41:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:43 INFO - '_': '/tools/buildbot/bin/python'} 02:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:43 INFO - Running setup.py (path:/tmp/pip-HKmRUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:43 INFO - Running setup.py (path:/tmp/pip-NILzFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:43 INFO - Running setup.py (path:/tmp/pip-RpSkUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:43 INFO - Running setup.py (path:/tmp/pip-KvFkvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:43 INFO - Running setup.py (path:/tmp/pip-KR31S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:43 INFO - Running setup.py (path:/tmp/pip-OAE1OU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:43 INFO - Running setup.py (path:/tmp/pip-P8_ij3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:44 INFO - Running setup.py (path:/tmp/pip-pgKyS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:44 INFO - Running setup.py (path:/tmp/pip-w5Y8kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:44 INFO - Running setup.py (path:/tmp/pip-Lv2Nym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:44 INFO - Running setup.py (path:/tmp/pip-EN9KaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:44 INFO - Running setup.py (path:/tmp/pip-mRKoVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:44 INFO - Running setup.py (path:/tmp/pip-GJlLiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:44 INFO - Running setup.py (path:/tmp/pip-wW8nKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:44 INFO - Running setup.py (path:/tmp/pip-gnu4sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:44 INFO - Running setup.py (path:/tmp/pip-cENhM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:44 INFO - Running setup.py (path:/tmp/pip-tjDYiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:41:44 INFO - Running setup.py install for manifestparser 02:41:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:41:44 INFO - Running setup.py install for mozcrash 02:41:44 INFO - Running setup.py install for mozdebug 02:41:45 INFO - Running setup.py install for mozdevice 02:41:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Running setup.py install for mozfile 02:41:45 INFO - Running setup.py install for mozhttpd 02:41:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Running setup.py install for mozinfo 02:41:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Running setup.py install for mozInstall 02:41:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Running setup.py install for mozleak 02:41:45 INFO - Running setup.py install for mozlog 02:41:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Running setup.py install for moznetwork 02:41:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:41:45 INFO - Running setup.py install for mozprocess 02:41:45 INFO - Running setup.py install for mozprofile 02:41:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:41:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:41:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:41:46 INFO - Running setup.py install for mozrunner 02:41:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:41:46 INFO - Running setup.py install for mozscreenshot 02:41:46 INFO - Running setup.py install for moztest 02:41:46 INFO - Running setup.py install for mozversion 02:41:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:41:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:41:46 INFO - Cleaning up... 02:41:46 INFO - Return code: 0 02:41:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c46ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26315a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', '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 02:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:46 INFO - Using env: {'DISPLAY': ':0', 02:41:46 INFO - 'HOME': '/home/cltbld', 02:41:46 INFO - 'LANG': 'en_US.UTF-8', 02:41:46 INFO - 'LANGUAGE': 'en_US:en', 02:41:46 INFO - 'LOGNAME': 'cltbld', 02:41:46 INFO - 'MAIL': '/var/mail/cltbld', 02:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:46 INFO - 'MOZ_NO_REMOTE': '1', 02:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:46 INFO - 'NO_EM_RESTART': '1', 02:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:46 INFO - 'PWD': '/builds/slave/test', 02:41:46 INFO - 'SHELL': '/bin/bash', 02:41:46 INFO - 'SHLVL': '1', 02:41:46 INFO - 'TERM': 'linux', 02:41:46 INFO - 'TMOUT': '86400', 02:41:46 INFO - 'USER': 'cltbld', 02:41:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:46 INFO - '_': '/tools/buildbot/bin/python'} 02:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:46 INFO - Running setup.py (path:/tmp/pip-T61KUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:46 INFO - Running setup.py (path:/tmp/pip-q_sxF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:46 INFO - Running setup.py (path:/tmp/pip-TbdejS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:46 INFO - Running setup.py (path:/tmp/pip-bvtZ_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:47 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)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:47 INFO - Running setup.py (path:/tmp/pip-GOSTwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:47 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)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:47 INFO - Running setup.py (path:/tmp/pip-91XUmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:47 INFO - Running setup.py (path:/tmp/pip-ycuaF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:47 INFO - Running setup.py (path:/tmp/pip-duJfxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:47 INFO - Running setup.py (path:/tmp/pip-3b4HBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:47 INFO - Running setup.py (path:/tmp/pip-B5FOlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:47 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)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:47 INFO - Running setup.py (path:/tmp/pip-OOyAPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:47 INFO - Running setup.py (path:/tmp/pip-t4VjxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:47 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)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:47 INFO - Running setup.py (path:/tmp/pip-i7OdSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:47 INFO - Running setup.py (path:/tmp/pip-ddmkds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:47 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)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:47 INFO - Running setup.py (path:/tmp/pip-NYpEhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:47 INFO - Running setup.py (path:/tmp/pip-deN6y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:47 INFO - Running setup.py (path:/tmp/pip-UzIJ4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:49 INFO - Downloading blessings-1.6.tar.gz 02:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:41:49 INFO - Installing collected packages: blessings 02:41:49 INFO - Running setup.py install for blessings 02:41:50 INFO - Successfully installed blessings 02:41:50 INFO - Cleaning up... 02:41:50 INFO - Return code: 0 02:41:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:41:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:50 INFO - Reading from file tmpfile_stdout 02:41:50 INFO - Current package versions: 02:41:50 INFO - argparse == 1.2.1 02:41:50 INFO - blessings == 1.6 02:41:50 INFO - blobuploader == 1.2.4 02:41:50 INFO - docopt == 0.6.1 02:41:50 INFO - manifestparser == 1.1 02:41:50 INFO - mozInstall == 1.12 02:41:50 INFO - mozcrash == 0.17 02:41:50 INFO - mozdebug == 0.1 02:41:50 INFO - mozdevice == 0.48 02:41:50 INFO - mozfile == 1.2 02:41:50 INFO - mozhttpd == 0.7 02:41:50 INFO - mozinfo == 0.9 02:41:50 INFO - mozleak == 0.1 02:41:50 INFO - mozlog == 3.1 02:41:50 INFO - moznetwork == 0.27 02:41:50 INFO - mozprocess == 0.22 02:41:50 INFO - mozprofile == 0.28 02:41:50 INFO - mozrunner == 6.11 02:41:50 INFO - mozscreenshot == 0.1 02:41:50 INFO - mozsystemmonitor == 0.0 02:41:50 INFO - moztest == 0.7 02:41:50 INFO - mozversion == 1.4 02:41:50 INFO - psutil == 3.1.1 02:41:50 INFO - requests == 1.2.3 02:41:50 INFO - wsgiref == 0.1.2 02:41:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41: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')]} 02:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41: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')]} 02:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c46ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26315a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', '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 02:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:50 INFO - Using env: {'DISPLAY': ':0', 02:41:50 INFO - 'HOME': '/home/cltbld', 02:41:50 INFO - 'LANG': 'en_US.UTF-8', 02:41:50 INFO - 'LANGUAGE': 'en_US:en', 02:41:50 INFO - 'LOGNAME': 'cltbld', 02:41:50 INFO - 'MAIL': '/var/mail/cltbld', 02:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:50 INFO - 'MOZ_NO_REMOTE': '1', 02:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:50 INFO - 'NO_EM_RESTART': '1', 02:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:50 INFO - 'PWD': '/builds/slave/test', 02:41:50 INFO - 'SHELL': '/bin/bash', 02:41:50 INFO - 'SHLVL': '1', 02:41:50 INFO - 'TERM': 'linux', 02:41:50 INFO - 'TMOUT': '86400', 02:41:50 INFO - 'USER': 'cltbld', 02:41:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:50 INFO - '_': '/tools/buildbot/bin/python'} 02:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:41:50 INFO - Cleaning up... 02:41:50 INFO - Return code: 0 02:41:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:41: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')]} 02:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41: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')]} 02:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c46ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26315a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', '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 02:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:41:50 INFO - Using env: {'DISPLAY': ':0', 02:41:50 INFO - 'HOME': '/home/cltbld', 02:41:50 INFO - 'LANG': 'en_US.UTF-8', 02:41:50 INFO - 'LANGUAGE': 'en_US:en', 02:41:50 INFO - 'LOGNAME': 'cltbld', 02:41:50 INFO - 'MAIL': '/var/mail/cltbld', 02:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:50 INFO - 'MOZ_NO_REMOTE': '1', 02:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:50 INFO - 'NO_EM_RESTART': '1', 02:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:50 INFO - 'PWD': '/builds/slave/test', 02:41:50 INFO - 'SHELL': '/bin/bash', 02:41:50 INFO - 'SHLVL': '1', 02:41:50 INFO - 'TERM': 'linux', 02:41:50 INFO - 'TMOUT': '86400', 02:41:50 INFO - 'USER': 'cltbld', 02:41:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:50 INFO - '_': '/tools/buildbot/bin/python'} 02:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:50 INFO - Downloading/unpacking jsonschema 02:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:41:52 INFO - Downloading/unpacking functools32 (from jsonschema) 02:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:52 INFO - Downloading functools32-3.2.3-2.tar.gz 02:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:41:52 INFO - warning: no files found matching '*.txt' 02:41:52 INFO - no previously-included directories found matching 'build' 02:41:52 INFO - no previously-included directories found matching 'dist' 02:41:52 INFO - no previously-included directories found matching '.git*' 02:41:52 INFO - Installing collected packages: jsonschema, functools32 02:41:52 INFO - Running setup.py install for functools32 02:41:53 INFO - warning: no files found matching '*.txt' 02:41:53 INFO - no previously-included directories found matching 'build' 02:41:53 INFO - no previously-included directories found matching 'dist' 02:41:53 INFO - no previously-included directories found matching '.git*' 02:41:53 INFO - Successfully installed jsonschema functools32 02:41:53 INFO - Cleaning up... 02:41:53 INFO - Return code: 0 02:41:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:41:53 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')]} 02:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:53 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')]} 02:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:53 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 0x7f5c46ddaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26315a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, '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': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', '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 02:41:53 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 02:41:53 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 02:41:53 INFO - Using env: {'DISPLAY': ':0', 02:41:53 INFO - 'HOME': '/home/cltbld', 02:41:53 INFO - 'LANG': 'en_US.UTF-8', 02:41:53 INFO - 'LANGUAGE': 'en_US:en', 02:41:53 INFO - 'LOGNAME': 'cltbld', 02:41:53 INFO - 'MAIL': '/var/mail/cltbld', 02:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:53 INFO - 'MOZ_NO_REMOTE': '1', 02:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:41:53 INFO - 'NO_EM_RESTART': '1', 02:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:53 INFO - 'PWD': '/builds/slave/test', 02:41:53 INFO - 'SHELL': '/bin/bash', 02:41:53 INFO - 'SHLVL': '1', 02:41:53 INFO - 'TERM': 'linux', 02:41:53 INFO - 'TMOUT': '86400', 02:41:53 INFO - 'USER': 'cltbld', 02:41:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:53 INFO - '_': '/tools/buildbot/bin/python'} 02:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:53 INFO - Downloading/unpacking flake8 02:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:41:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:41:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:41:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:41:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:41:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:41:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:41:55 INFO - no previously-included directories found matching 'docs/_build' 02:41:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:41:55 INFO - Running setup.py install for pep8 02:41:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:41:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:41:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:41:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:41:56 INFO - no previously-included directories found matching 'docs/_build' 02:41:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:41:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:41:56 INFO - Cleaning up... 02:41:56 INFO - Return code: 0 02:41:56 INFO - Running post-action listener: _resource_record_post_action 02:41:56 INFO - Running post-action listener: _start_resource_monitoring 02:41:56 INFO - Starting resource monitoring. 02:41:56 INFO - ##### 02:41:56 INFO - ##### Running install step. 02:41:56 INFO - ##### 02:41:56 INFO - Running pre-action listener: _resource_record_pre_action 02:41:56 INFO - Running main action method: install 02:41:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:41:56 INFO - Reading from file tmpfile_stdout 02:41:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:41:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:41:56 INFO - Reading from file tmpfile_stdout 02:41:56 INFO - Output received: 02:41:56 INFO - Usage: mozinstall [options] installer 02:41:56 INFO - Options: 02:41:56 INFO - -h, --help show this help message and exit 02:41:56 INFO - -d DEST, --destination=DEST 02:41:56 INFO - Directory to install application into. [default: 02:41:56 INFO - "/builds/slave/test"] 02:41:56 INFO - --app=APP Application being installed. [default: firefox] 02:41:56 INFO - mkdir: /builds/slave/test/build/application 02:41:56 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'] 02:41:56 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 02:42:12 INFO - Reading from file tmpfile_stdout 02:42:12 INFO - Output received: 02:42:12 INFO - /builds/slave/test/build/application/firefox/firefox 02:42:12 INFO - Running post-action listener: _resource_record_post_action 02:42:12 INFO - ##### 02:42:12 INFO - ##### Running run-tests step. 02:42:12 INFO - ##### 02:42:12 INFO - Running pre-action listener: _resource_record_pre_action 02:42:12 INFO - Running main action method: run_tests 02:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:42:12 INFO - Python 2.7.3 02:42:12 INFO - Return code: 0 02:42:12 INFO - grabbing minidump binary from tooltool 02:42: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')]} 02:42:12 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 0x26c0410>, '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 0x26c1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:42:12 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 02:42:12 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 02:42:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:42:12 INFO - Return code: 0 02:42:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:42:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:42:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:42:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:42:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:42:13 INFO - Return code: 0 02:42:13 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/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 02:42:13 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/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 02:42:13 INFO - Using env: {'DISPLAY': ':0', 02:42:13 INFO - 'HOME': '/home/cltbld', 02:42:13 INFO - 'LANG': 'en_US.UTF-8', 02:42:13 INFO - 'LANGUAGE': 'en_US:en', 02:42:13 INFO - 'LOGNAME': 'cltbld', 02:42:13 INFO - 'MAIL': '/var/mail/cltbld', 02:42:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:42:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:13 INFO - 'MOZ_NO_REMOTE': '1', 02:42:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:13 INFO - 'NO_EM_RESTART': '1', 02:42:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:13 INFO - 'PWD': '/builds/slave/test', 02:42:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:42:13 INFO - 'SHELL': '/bin/bash', 02:42:13 INFO - 'SHLVL': '1', 02:42:13 INFO - 'TERM': 'linux', 02:42:13 INFO - 'TMOUT': '86400', 02:42:13 INFO - 'USER': 'cltbld', 02:42:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676', 02:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:13 INFO - '_': '/tools/buildbot/bin/python'} 02:42:13 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/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 02:42:13 INFO - mozversion application_buildid: 20160521000929 02:42:13 INFO - mozversion application_changeset: 8b81a6c988c496aaff85df718646e17239c1e278 02:42:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:42:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:42:13 INFO - mozversion application_name: Firefox 02:42:13 INFO - mozversion application_remotingname: firefox-dev 02:42:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:13 INFO - mozversion application_vendor: Mozilla 02:42:13 INFO - mozversion application_version: 48.0a2 02:42:13 INFO - mozversion platform_buildid: 20160521000929 02:42:13 INFO - mozversion platform_changeset: 8b81a6c988c496aaff85df718646e17239c1e278 02:42:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:13 INFO - mozversion platform_version: 48.0a2 02:42:13 INFO - using testdate: 1463823733 02:42:13 INFO - actual date: 1463823733 02:42:13 INFO - starting webserver on 'localhost:45609' 02:42:13 INFO - SUITE-START | Running 2 tests 02:42:13 INFO - TEST-START | dromaeo_css 02:42:13 INFO - operating with platform_type : linux_ 02:42:13 INFO - Initialising browser for dromaeo_css test... 02:42:13 INFO - TEST-INFO | started process 13836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtmx97/profile http://localhost:45609/getInfo.html) 02:42:17 INFO - PROCESS | 13836 | __metrics Screen width/height:1600/1200 02:42:17 INFO - PROCESS | 13836 | colorDepth:24 02:42:17 INFO - PROCESS | 13836 | Browser inner width/height: 1024/697 02:42:17 INFO - PROCESS | 13836 | __metrics 02:42:18 ERROR - PROCESS | 13836 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:42:18 INFO - TEST-INFO | 13836: exit 0 02:42:18 INFO - Browser initialized. 02:42:18 INFO - Running cycle 1/1 for dromaeo_css test... 02:42:18 INFO - TEST-INFO | started process 13926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtmx97/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:30 INFO - PROCESS | 13926 | RSS: Main: 141905920 02:42:30 INFO - PROCESS | 13926 | 02:43:21 INFO - PROCESS | 13926 | 1463823801869 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] 02:45:29 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:45609/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45609/tests/dromaeo/cssquery-ext.html) 02:45:30 INFO - PROCESS | 13926 | RSS: Main: 252039168 02:45:30 INFO - PROCESS | 13926 | 02:48:32 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:45609/tests/dromaeo/cssquery-ext.html (next: http://localhost:45609/tests/dromaeo/cssquery-jquery.html) 02:48:33 INFO - PROCESS | 13926 | RSS: Main: 223813632 02:48:33 INFO - PROCESS | 13926 | 02:51:35 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:45609/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45609/tests/dromaeo/cssquery-mootools.html) 02:51:35 INFO - PROCESS | 13926 | RSS: Main: 219148288 02:51:35 INFO - PROCESS | 13926 | 02:54:37 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:45609/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45609/tests/dromaeo/cssquery-prototype.html) 02:54:38 INFO - PROCESS | 13926 | RSS: Main: 214671360 02:54:38 INFO - PROCESS | 13926 | 02:57:40 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:45609/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45609/tests/dromaeo/cssquery-yui.html) 02:57:41 INFO - PROCESS | 13926 | RSS: Main: 212238336 02:57:41 INFO - PROCESS | 13926 | 03:00:43 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:45609/tests/dromaeo/cssquery-yui.html (next: http://localhost:45609/tests/dromaeo/cssquery-dojo.html) 03:00:44 INFO - PROCESS | 13926 | RSS: Main: 257134592 03:00:44 INFO - PROCESS | 13926 | 03:00:44 INFO - PROCESS | 13926 | __start_tp_report 03:00:44 INFO - PROCESS | 13926 | _x_x_mozilla_page_load 03:00:44 INFO - PROCESS | 13926 | _x_x_mozilla_page_load_details 03:00:44 INFO - PROCESS | 13926 | |i|pagename|runs| 03:00:44 INFO - PROCESS | 13926 | |0;dojo.html;3308.5698859148306;3401.608814986277;3416.991987363728;3446.655334466552;3454.1019334972916;5625.887482250352;5650.124230744231;5656.406077361874;5663.377028526869;5672.574556908233;5658.179563963223;5690.146478028298;5692.089265717486;5695.401982791809;5700.914486282709;4924;5147.562457191143;5241.135212689902;5312.07038768216;5331;5109.310243117187;5161.767720452589;5164.302819119408;5167.509086636764;5171.120909445403;5055.9747201263945;5128;5136.306598609196;5136.974315128419;5160.174372100465;5165.328507294046;5175.120229560984;5194.766235519411;5201.531862132389;5233.581313494911;4969.577585905203;5103.56619687327;5104.259882317043;5110.97444512775;5183.559397451221;5466.508014278695;5532.861678458071;5536.723163841792;5542.8337149885565;5555.50000499957;5900.822975310747;5901.527877769811;5904.055351143839;5905.852353691149;5909.7636094556165;5967.49276311514;6069.332373438918;6095.238095238095;6117.908231376533;6145.863015342176;5617.634853734494;5665.5467562594895;5674.09214525678;5675.091985282335;5677.09166533361;5989.880202396015;6116.2048933639235;6124.540659450559;6126.264848218242;6135.110408990671;5738.827835164868;5799.4780469757925;5805.158252053513;5814.156947242626;5820.3888591698105;5988.880222395528;6030.969845150747;6035.909461358083;6038.6678732670125;6040.244969378828;5830.53355731549;5893.970530147321;5981.431763982415;6003.21958145447;6008.459238668541;5955.642661440327;5957.702114894238;5964.31410387811;5976.880462390728;6003.129546215774;4545.909081818345;4546.227141385973;4547.136044151601;4553.612942899825;4578.587927086578;4040.8383664653675;4047.3119569673227;4078.490188726409;4109.876703698894;4115;5690.800821971211;5701.629394089371;5716.342620598602;5737.65574065549;5738.254026976467;5996.190514280604;6020.879582408327;6043.969780151159;6046.939530604725;6047.697615119227;5514.558835293167;5651.039323315046;5678.432156784371;5728.054870946247;5741.540676745851;5037.420696619863;5063.822766203239;5063.8480845574695;5073.162928116893;5137.922931156036;6021.759129634853;6078.635281883013;6079.513638908877;6089.482393996472;6091.086337049478;5762.855928601818;6021.698915054318;6083.057126145454;6122.510199184144;6123.969380153071;6123.2652081750475;6131.693415329305;6135.815925522242;6136.6011209271255;6142.6314421134875;5784.566157538117;5891.05743081105;5891.705414729332;5893.764249430146;5903.2325797646035;5963.73163207648;5973.970130149321;6007.879842403215;6047.637141771508;6066.848328791815;5867.618604790675;5870.17817505541;5932;5934.881302374015;5941.22764040672;5704.657720536781;5874.765009399576;5903.498202652822;5912.054071348563;5931;5701.600887937971;5710.400407957105;5730.054541000688;5740.1102829061565;5761.625494342854;5855.502282306052;5860.355360910211;5861.413858614104;5864.413558644102;5866.560007999503;5681.573881958787;5743.511801496919;5780.942190578208;5823.854403639943;5895.557833162616 03:00:44 INFO - PROCESS | 13926 | |1;ext.html;671.5634837355718;689.2211800665249;702.4731451411438;749.5540153608605;764.2166779051475;33174.502382464256;40496.190076198494;40828.795856020755;40874;40903.18193636125;42608.786956065174;43299.35050974238;43421.56578434215;43450.13099738003;43490;8107.189281071905;8178.631961561744;8660.783480412993;8799.560021998906;10361.171106311476;10474.371537707724;10652.414117223589;10662.946685266563;10669.359838409682;10674.573017079347;10767.569297228141;10841.83737243942;10860.565577376936;10861.13110951122;10862.61980830671;8504.829903401927;10465.895341046567;10584;10603.204759643058;10620.628278010232;10601.363918164934;10748.301360411548;10752.139828813677;10757.62348317813;10758.623448179276;41194.1761164778;41768;41801;41821.37267940983;41852.372214416806;3855.1325951660933;3882.107115363482;3980.4029395590605;4377.212101821671;4484.417025786627;34042.82978585116;34345.31309373824;34404.13989650279;34576;35640.64359356425;4254.532001479834;4300.010997470568;4311.913761724748;4316.6978311518205;4318.978405107986;327981;328695;328762;331501;332216;41088.589114109076;67134.66432667903;68077.3192268071;68085;68117;38937.6106238934;38950.220995580494;39080.804595976835;39092.804535977135;39107.41338879919;16820.495385138467;17493.212805423787;17650.735238971425;17705.468835934942;17729.645407091786;14908.62728431798;15257.6185595361;15262.16058116792;15262.236888155549;15266.389344426321;9512.239020878313;9515.33392662507;9547.952260238655;9611.807763844685;9616.663416780379;3645.981770091186;3694.150345420568;3736.831842567091;3778.4899038629983;3799.50606421169;1152.4410660829492;1154.7805916875766;1176.5587904535798;1182.7575347053833;1210.8546974362957;29481.852590736908;30232.244193895327;30515.2371190722;31059.223519412197;31537.37770633623;1191.666333426642;1233.586748439265;1234.1916044990546;1251.249250449723;1370.7327071221016;16274.511764647079;17900.731489027676;18251.81748182501;18576.485095378797;18695.345662901735;504492;510437;511534;512017;512285;60960.69519652373;62084.379156208764;62126.378736212966;62222.688886555276;62243.066354004724;1499.4227222519191;1539.699758547095;1542.8534289242505;1612.4437069211103;1649.4309463235165;30577.388452231276;33017.66982330146;33437.39091407692;33543;33910.66089339174;50745.23882141845;51127.233091502916;51597.48402515927;51614.483855160965;51671.741641291555;399062;401351;403309;403357;403457;27643.30891727723;30939.69060309368;31306.843465782524;31314.843425783638;31379.84310078435;41898.37152442777;42992;43167.35248971205;43579.34630980601;44612.55387446084;39820.60179398169;39855.60144398635;40403.393949091376;40574.188516230104;41260.79369603133;39593.80203098966;39775.80112099421;40420.3936940952;40550.79724601358;41020.1795964085;41148.79425602853;41719;42355.152896942505;42518.574814251464;42698.14603707846;35248.647513524535;35389;35817.82091089528;36241.27517449689;36291.27417451689;27362.726372736815;27501.449971000868;27670.308242294104;27673.308167295978;27786.12090944019 03:00:44 INFO - PROCESS | 13926 | |2;jquery.html;411.4281149202608;413.1777762253115;414.8983499042731;416.1614347090612;426.558511940142;18787.2485100596;19675.606487870253;19684;20568.691469627967;21404.57190856182;18973.62052758944;19569.51076223095;19570.51073723154;20949.581008379824;21128.260510882123;5011.098002359565;5111.198397032729;5185.844424667266;5963.880722385549;5979.491743201811;5791.276090488689;5875;5888.4700376966275;5901.586888917777;5916.053431450969;5030.723310217955;5139.15203991341;5751.367349591542;5868.882622347551;5869.119632055204;5122.820701275475;5148.742562871879;5214.322138122057;5219.660722053073;5223.6679646690045;5047.520485553867;5076.64463487556;5131.461196574343;5132.974335128338;5143.408508021588;13012.284324362156;13296;13303.40134693941;13341.39963701626;13388.866111338957;2414.4326083370393;2425.963610545843;2446.8531888086595;2501.1121052026633;2509.3475696318906;10129.746756331077;10205.948970255102;13108;15010.849891501055;15361.462348817739;2011.1352118589;2034.1456588232977;2053.661145910923;2074.7925207479284;2181.2692747929464;82203.5889820547;86177;86728;88501.55749221277;89290.5535472325;11095;11165.385903775208;11266.549338026387;11297.096232301396;11431.657050288504;16021.919890400473;16079.276432560562;16121.919390402973;16180.43368482121;16208.918955405148;8844.159804818531;8861.24679402258;9014.909850901538;9135.314851386172;9164.541772911327;9092.27261819053;9098.226650734628;9118.680846170351;9230.400023998418;9272.860907086399;4719.764011799396;4773.904521909542;4829.758512074382;4837.4920633332995;4838.709677419366;1949.1618604000132;2072.4404410808997;2076.6158260721513;2084.8749075055543;2094.151868493232;971.8104969531015;1032.464499716791;1066.4507778494083;1092.3609688332256;1102.443266150589;19455.513612159528;19592.768753676755;19704.21183152658;19984.60030799405;20171.899140504498;1013.807376598444;1037.159900480613;1041.994790026045;1090.33489571363;1115.1914861725184;10641.787164256672;11425.60010399632;11460.94269528647;11517.827232591519;11576.47905844239;535251;540819;543979;570408;573796;96621;98770;100199;100203.49898250462;100588;1066.3868275741324;1068.1454836131063;1069.6363236499471;1072.1637123044038;1129.6215767717742;17395.304187832346;17839.73240401421;17900.820991789915;17963.281468741105;18105.637887242447;38841.6115838838;39068;39479;40069.79965100156;41692;51396.48603513917;52194.21708674297;52312.47687523076;52582.211266830265;52647.21029184642;7833.255840695125;8028.638711258124;8030.156833532628;8249.29880960125;8309.418340716333;9091.136342047495;12492.750144997231;13283.601491955256;13393.263370514715;13546.729065418833;11772.234804737665;11847.940760296144;11971;11977.520899163936;12220.572279970158;11344.20590558653;11581.305121692725;11839.585614503796;11949.940250298692;11961.102917281412;11653.88346116528;11760.176787624785;11787.351695656822;12131.575394861491;12368.257904525757;8269.875951860606;8450.366222533212;8452.36607254446;8472.788180295542;8534.359923005675;7948.84102317962;11539.4807233673;12670.809937850756;12835;12856.421461034462 03:00:44 INFO - PROCESS | 13926 | |3;mootools.html;1478.6525166585857;1579.0920220872997;1592.402848931651;1804.9819501804986;1906.2089232968328;8191.3856460765455;8359.91640083599;8367.2469477747;8375.204355586226;8379.832403351937;8115.269625733683;8277.255047045765;8287.46131501452;8294.170582941702;8304.50172989621;2082.396105129518;2351.2946116165167;2395.9817077741977;2417.0815090265764;2430.2101816909485;2387.510560335127;2397.2927986244013;2397.61638137898;2399.9760002399926;2401.591729406005;2296.7703229677068;2355.611324131516;2362.763723627632;2369.407648087978;2377.1442280778906;2062.82465990391;2335.4861930375373;2381.1903952656007;2384.308550520347;2385.797207237387;2332.953340933172;2349.977759674547;2356.26955643751;2358.4221865642858;2394.1261439574605;8285.212904774036;8380.83238335236;8392.874106888401;8392.958035209846;8405.327573794082;5107.131787596118;5209.244659524347;5214.113600687892;5236.659617124875;5265.315508983807;3519.0498565387456;3527.4708793680898;3531.8587256509963;3556.697680697144;3625.4380571011534;1144.6680462665818;1148.7817314710178;1179.3277831635971;1181.4388165621347;1182.3615247766281;11963.46164422603;12011.759764804743;12041.819372709417;12043.759124817541;12063.276203427822;4391.912161756747;4466.57567531084;4524.615407690318;4553.954460455419;4564;10284.228682848816;10299.485025748683;10311.123554497952;10312.896871031193;10319.380837149794;4442.155990361821;4976.5023497649945;5015.197568389113;5026.195808670595;5029.497050295015;4660.347551342815;4711.340412342275;4728.40894888139;4749.928751068736;4762.571368576845;4017.6183262590007;4019.737395633821;4190.4419583351955;4207.389928460356;4224.197402493516;1257.534712156508;1333.919964802115;1335.2722766092502;1349.1532865653464;1361.86381361865;840.6385254340693;945.4280160502797;947.3652652722692;968.1867231525412;968.2093072704668;5563.054280772279;5570.303712035996;5596.832095037155;5629.493345598916;5711.571632127524;432.8982738929432;433.4343681495615;434.24874966308465;443.7537166872352;444.21817601022434;3580.856765729394;3596.2627661329366;3610.6750392464805;3621.8189090545366;3648.9635103648625;10126.848097278547;10441.947790261;10565.154787617126;10565.577376904837;10588.364698117983;10258.897411025944;10373.636922707668;10416;10433.947830260951;10498.160147188206;8012.0786109596975;8071.07182674;8160.102388737234;8168.673253069811;8197.918020819716;5347;5414.783408663609;5518.822093226167;5561.4716601922755;5570.442955704397;9165.862512062458;9225.815483690423;9402.15380615748;9419.811603768023;9566.426014439156;9508.809823803624;9687.806243874942;9700.466474343697;9858.112769850748;9893.258005649748;6840.828979275558;6974.546654467444;6974.616396098263;6982.895256571257;7209.567425954459;7720.382369410321;7740;7742.4193185510185;7752;7753.767386978399;6890.414314783299;6938.479614028867;6981.581105133709;6993.650317484207;7243.420526357984;6839.658017099225;6887.7244910203035;7034.859302814018;7118;7175.103112110986;6460.3862633049785;6562.376574225441;6574.704138313883;6617;6624.403803657501;4666.2767271073035;4683.531646835289;4723.622110231242;4760.333553302609;4769.642276829182;4627.814887404601;4747.240441529477;4756.619470442425;4757.02480991389;4857.344258525195 03:00:44 INFO - PROCESS | 13926 | |4;prototype.html;309.2809218566831;314.66331025802384;317.18325312320775;329.4415964939429;336.5759143479215;6290.433860952519;6317;6399.776007839727;6424.3896829801215;6431.710573024214;6306.905396419057;6320.367963203677;6329.2404911410695;6335.809925702225;6336.239651241846;4521.615662668677;4597.54024597541;4606.493285738566;4646.047560250141;4666.953330466703;4699.78850951708;4734.479207287213;4756.857294281177;4759.666823322369;4762.714237145782;4668.229742092551;4673.01866608011;4676.228422310332;4684.859454216379;4686.343911852344;4490.618297444705;4563.543645635443;4632.2819962905805;4679.8362057328;4731.4795372509;4096.365063415175;4107.281225785506;4111.280525907954;4124.546299907008;4125.97937010316;6036.494854635321;6038.516918646542;6054.031354983225;6057.545684073712;6083.087536869461;5431.131019036935;5438.265834112383;5442.673439593597;5447;5461.399246082928;6627.204735431731;6629.801105966829;6639.73441062357;6645.80062598118;6646.6676666166495;4333.328334108218;4481.955180448186;4486.663500237462;4496.617787488068;4536.138133754576;6943.79168624942;6983.196932352794;6985.371316581482;6991.685374158124;7001.579905205704;4545.522720114341;4548.385967894358;4551.795169217393;4552.88617784558;4555.33947577606;4613.446386433649;4614.215583350839;4618.769061546976;4618.815247390134;4619.3994780678295;5407.270018547446;5414.945850541523;5425.620206585501;5428.647137936022;5429.53848922846;6433.131527243762;6624.039514270404;6630.038644396535;6728.259891411941;6741.764038258638;1600.9519714408586;1605.855473007435;1619.0204926019824;1621.051684764426;1624.63445724711;1032.9018743219533;1038.4963292802984;1048.0567489259727;1058.0583280880023;1062.829947208443;6264;6390.904136437957;6467.967660161763;6481.351864813481;6560.081588577603;7013.614251216232;7024.789256322319;7029.507934444642;7037.472189585802;7039.824004399931;6581.177352830896;6586.934130658728;6591.110200123018;6593.835154121185;6595.736170553124;3736.1967177057063;3770.2836461072307;3774.1319496515957;3777.8866634000474;3788.318102741478;6888.483363747739;7121.394681452031;7170.856582868313;7178.102737157856;7199.712011519586;7138.535995160298;7146.606936618536;7155.821104472326;7160.10498687664;7175.067241258603;7141.571505709674;7142.142942846892;7162.4986250962975;7162.785116446515;7167.784966451015;6965.094537710065;6971;6977.1976222733;6978.47661425385;6999.965000175171;6671.366220209073;6866.965665171642;6911.343422374866;6924.376806087476;6928.549644273106;7149.213586505584;7164.89252661221;7177.282271772781;7184.533005354635;7197.856042879218;4565.132624801277;4594.908101838011;4601.4248218972625;4601.746903920316;4603.470600880942;6969.128858892638;6976.302369762983;6977.825554361181;6982.197047339621;6999.12510936133;6593.736250549924;6805.217399999064;6823.420009299265;6835.008923705936;6848.794536163923;6756.831079223059;6768;6787.762428314985;6788.117544719353;6796.252412234551;6672.698823729326;6680.298568650222;6690;6706.66466676674;6750.088738020305;6806.93193068063;6820;6820.079289295882;6833.45332373399;6840.521163518506;6363.236411630634;6611.504137189826;6659.866802664016;6666.26671066192;6668.599884006975 03:00:44 INFO - PROCESS | 13926 | |5;yui.html;911.585228720932;915.5102020419077;917.2020342302197;926.4441335198882;945.6690158444541;15241.085534867916;15368.61578460539;15396;15396.538103856903;15452.92273538632;14064.718705625906;14133.646658833508;14144.151350918926;14179.149251044944;14179.78730319046;761.5735188294559;892.9464232146059;896.3501461440469;897.7261935109789;898.469902757373;883.9955800221022;885.0397318908991;888.693400776731;890.2077151335317;893.1871996483202;801.4990630855715;949.6628696812636;953.3374304858127;954.1746389373177;954.6610953111649;951.6050838901847;953.2850362228329;954.3271993244781;954.5227386306847;954.5609019850876;698.6087790837147;701.8385771272635;701.8982247574073;701.9929800701979;702.2696395748416;14989.850101498954;15067;15094.622634434118;15118.546443606709;15120.39518419262;14638.487652932095;14840.554783356516;14997.775033374508;15408;15434.765218782582;12224.755504889941;12242.877571224262;12438.689032774253;12526.937365313115;12537.686557836036;3991.960080399188;4054.2904991626347;4079.551249362568;4081.2041651877894;4088;56484.43515564833;57138.428615713725;57246.42753572453;57371.13943290854;57450;11725.765484690259;12111.454984525717;12225.44985475638;12235.388230588434;12260.632181034583;20892.268770592957;21005.054772535274;21036.158553657988;21091.8945405272;21095.156193752384;9042.728718138467;9126.36115471924;9133.132352426508;9146.588403521857;9197.402168859002;5099.745012749348;5119.488051194925;5198.220266959911;5253.553447956967;5323.653962492425;3444.603870554918;3491.2144767427635;3509.5262139610827;3509.964900351015;3515.6660117288816;645.4545908707134;651.0429668387463;656.6421300391203;657.710607332772;667.4493542827187;624.4192900602393;691.8962155676588;702.68379229347;706.6537396675592;707.5860621536459;9130;9286.303527235485;9488.810223795486;9894.55474503649;10051.69844904654;614.6097228260087;656.9488817891336;675.8969778174859;704.5903011699999;736.5911918885071;4464.977675111669;4684.086603112429;4764.904701905943;4788.545088216614;4825.372701548777;70342;70492;70996;71013.2898671017;71553;58930;59933.40066599366;60100;61539;62134.37865621376;51839;52464.47535524672;55992.999999999185;56636;56737.43262567404;8955.41789783662;9104.180623743894;9193.402428842104;9199;9378.624855005723;41595.58404415917;41927.58072419237;42002.78998604987;42648.57351426446;42690.57309426866;50744.74627626838;52792.20811687905;52821;53976.730116350736;54004;10937.890621093688;11041.723956901142;11222.607208747655;11272.943635281772;11483.540658373571;12211.694707632025;12986.610401687965;13177.802332964822;13317.467301307839;13356.465741370625;12703.682407939876;13321.733565328444;13364.064515483822;13630.659233518845;14373.496927607484;11010.119190464904;11440.94279528597;11707.2975621463;12042.698932526757;12502.249865008129;13143.671408214872;13444.731105378034;13579.253141077335;13765.38055787512;13801.723965520432;11593.6521904343;11725.472353743931;11890.583829565923;11935.701607459883;11938.94529187296;11124.666260012213;11614.270646397921;11802.527898884291;11817.113716471127;11922 03:00:44 INFO - PROCESS | 13926 | __end_tp_report 03:00:44 INFO - PROCESS | 13926 | __start_cc_report 03:00:44 INFO - PROCESS | 13926 | _x_x_mozilla_cycle_collect,876 03:00:44 INFO - PROCESS | 13926 | __end_cc_report 03:00:44 INFO - PROCESS | 13926 | __startTimestamp1463824844034__endTimestamp 03:00:44 INFO - PROCESS | 13926 | 03:00:44 INFO - PROCESS | 13926 | ------- Summary: start ------- 03:00:44 INFO - PROCESS | 13926 | Number of tests: 6 03:00:44 INFO - PROCESS | 13926 | 03:00:44 INFO - PROCESS | 13926 | [#0] dojo.html Cycles:165 Average:5572.58 Median:5743.51 stddev:606.55 (10.6%) stddev-sans-first:581.83 03:00:44 INFO - PROCESS | 13926 | Values: 3308.6 3401.6 3417.0 3446.7 3454.1 5625.9 5650.1 5656.4 5663.4 5672.6 5658.2 5690.1 5692.1 5695.4 5700.9 4924.0 5147.6 5241.1 5312.1 5331.0 5109.3 5161.8 5164.3 5167.5 5171.1 5056.0 5128.0 5136.3 5137.0 5160.2 5165.3 5175.1 5194.8 5201.5 5233.6 4969.6 5103.6 5104.3 5111.0 5183.6 5466.5 5532.9 5536.7 5542.8 5555.5 5900.8 5901.5 5904.1 5905.9 5909.8 5967.5 6069.3 6095.2 6117.9 6145.9 5617.6 5665.5 5674.1 5675.1 5677.1 5989.9 6116.2 6124.5 6126.3 6135.1 5738.8 5799.5 5805.2 5814.2 5820.4 5988.9 6031.0 6035.9 6038.7 6040.2 5830.5 5894.0 5981.4 6003.2 6008.5 5955.6 5957.7 5964.3 5976.9 6003.1 4545.9 4546.2 4547.1 4553.6 4578.6 4040.8 4047.3 4078.5 4109.9 4115.0 5690.8 5701.6 5716.3 5737.7 5738.3 5996.2 6020.9 6044.0 6046.9 6047.7 5514.6 5651.0 5678.4 5728.1 5741.5 5037.4 5063.8 5063.8 5073.2 5137.9 6021.8 6078.6 6079.5 6089.5 6091.1 5762.9 6021.7 6083.1 6122.5 6124.0 6123.3 6131.7 6135.8 6136.6 6142.6 5784.6 5891.1 5891.7 5893.8 5903.2 5963.7 5974.0 6007.9 6047.6 6066.8 5867.6 5870.2 5932.0 5934.9 5941.2 5704.7 5874.8 5903.5 5912.1 5931.0 5701.6 5710.4 5730.1 5740.1 5761.6 5855.5 5860.4 5861.4 5864.4 5866.6 5681.6 5743.5 5780.9 5823.9 5895.6 03:00:44 INFO - PROCESS | 13926 | 03:00:44 INFO - PROCESS | 13926 | [#1] ext.html Cycles:180 Average:57424.24 Median:3827.32 stddev:111344.77 (2909.2%) stddev-sans-first:111575.58 03:00:44 INFO - PROCESS | 13926 | Values: 671.6 689.2 702.5 749.6 764.2 33174.5 40496.2 40828.8 40874.0 40903.2 42608.8 43299.4 43421.6 43450.1 43490.0 8107.2 8178.6 8660.8 8799.6 10361.2 10474.4 10652.4 10662.9 10669.4 10674.6 10767.6 10841.8 10860.6 10861.1 10862.6 8504.8 10465.9 10584.0 10603.2 10620.6 10601.4 10748.3 10752.1 10757.6 10758.6 41194.2 41768.0 41801.0 41821.4 41852.4 3855.1 3882.1 3980.4 4377.2 4484.4 34042.8 34345.3 34404.1 34576.0 35640.6 4254.5 4300.0 4311.9 4316.7 4319.0 327981.0 328695.0 328762.0 331501.0 332216.0 41088.6 67134.7 68077.3 68085.0 68117.0 38937.6 38950.2 39080.8 39092.8 39107.4 16820.5 17493.2 17650.7 17705.5 17729.6 14908.6 15257.6 15262.2 15262.2 15266.4 9512.2 9515.3 9548.0 9611.8 9616.7 3646.0 3694.2 3736.8 3778.5 3799.5 1152.4 1154.8 1176.6 1182.8 1210.9 29481.9 30232.2 30515.2 31059.2 31537.4 1191.7 1233.6 1234.2 1251.2 1370.7 16274.5 17900.7 18251.8 18576.5 18695.3 504492.0 510437.0 511534.0 512017.0 512285.0 60960.7 62084.4 62126.4 62222.7 62243.1 1499.4 1539.7 1542.9 1612.4 1649.4 30577.4 33017.7 33437.4 33543.0 33910.7 50745.2 51127.2 51597.5 51614.5 51671.7 399062.0 401351.0 403309.0 403357.0 403457.0 27643.3 30939.7 31306.8 31314.8 31379.8 41898.4 42992.0 43167.4 43579.3 44612.6 39820.6 39855.6 40403.4 40574.2 41260.8 39593.8 39775.8 40420.4 40550.8 41020.2 41148.8 41719.0 42355.2 42518.6 42698.1 35248.6 35389.0 35817.8 36241.3 36291.3 27362.7 27501.4 27670.3 27673.3 27786.1 03:00:44 INFO - PROCESS | 13926 | 03:00:44 INFO - PROCESS | 13926 | [#2] jquery.html Cycles:180 Average:30821.70 Median:11521.87 stddev:91076.15 (790.5%) stddev-sans-first:91303.02 03:00:44 INFO - PROCESS | 13926 | Values: 411.4 413.2 414.9 416.2 426.6 18787.2 19675.6 19684.0 20568.7 21404.6 18973.6 19569.5 19570.5 20949.6 21128.3 5011.1 5111.2 5185.8 5963.9 5979.5 5791.3 5875.0 5888.5 5901.6 5916.1 5030.7 5139.2 5751.4 5868.9 5869.1 5122.8 5148.7 5214.3 5219.7 5223.7 5047.5 5076.6 5131.5 5133.0 5143.4 13012.3 13296.0 13303.4 13341.4 13388.9 2414.4 2426.0 2446.9 2501.1 2509.3 10129.7 10205.9 13108.0 15010.8 15361.5 2011.1 2034.1 2053.7 2074.8 2181.3 82203.6 86177.0 86728.0 88501.6 89290.6 11095.0 11165.4 11266.5 11297.1 11431.7 16021.9 16079.3 16121.9 16180.4 16208.9 8844.2 8861.2 9014.9 9135.3 9164.5 9092.3 9098.2 9118.7 9230.4 9272.9 4719.8 4773.9 4829.8 4837.5 4838.7 1949.2 2072.4 2076.6 2084.9 2094.2 971.8 1032.5 1066.5 1092.4 1102.4 19455.5 19592.8 19704.2 19984.6 20171.9 1013.8 1037.2 1042.0 1090.3 1115.2 10641.8 11425.6 11460.9 11517.8 11576.5 535251.0 540819.0 543979.0 570408.0 573796.0 96621.0 98770.0 100199.0 100203.5 100588.0 1066.4 1068.1 1069.6 1072.2 1129.6 17395.3 17839.7 17900.8 17963.3 18105.6 38841.6 39068.0 39479.0 40069.8 41692.0 51396.5 52194.2 52312.5 52582.2 52647.2 7833.3 8028.6 8030.2 8249.3 8309.4 9091.1 12492.8 13283.6 13393.3 13546.7 11772.2 11847.9 11971.0 11977.5 12220.6 11344.2 11581.3 11839.6 11949.9 11961.1 11653.9 11760.2 11787.4 12131.6 12368.3 8269.9 8450.4 8452.4 8472.8 8534.4 7948.8 11539.5 12670.8 12835.0 12856.4 03:00:44 INFO - PROCESS | 13926 | 03:00:44 INFO - PROCESS | 13926 | [#3] mootools.html Cycles:180 Average:5532.25 Median:4717.48 stddev:3128.19 (66.3%) stddev-sans-first:3122.14 03:00:44 INFO - PROCESS | 13926 | Values: 1478.7 1579.1 1592.4 1805.0 1906.2 8191.4 8359.9 8367.2 8375.2 8379.8 8115.3 8277.3 8287.5 8294.2 8304.5 2082.4 2351.3 2396.0 2417.1 2430.2 2387.5 2397.3 2397.6 2400.0 2401.6 2296.8 2355.6 2362.8 2369.4 2377.1 2062.8 2335.5 2381.2 2384.3 2385.8 2333.0 2350.0 2356.3 2358.4 2394.1 8285.2 8380.8 8392.9 8393.0 8405.3 5107.1 5209.2 5214.1 5236.7 5265.3 3519.0 3527.5 3531.9 3556.7 3625.4 1144.7 1148.8 1179.3 1181.4 1182.4 11963.5 12011.8 12041.8 12043.8 12063.3 4391.9 4466.6 4524.6 4554.0 4564.0 10284.2 10299.5 10311.1 10312.9 10319.4 4442.2 4976.5 5015.2 5026.2 5029.5 4660.3 4711.3 4728.4 4749.9 4762.6 4017.6 4019.7 4190.4 4207.4 4224.2 1257.5 1333.9 1335.3 1349.2 1361.9 840.6 945.4 947.4 968.2 968.2 5563.1 5570.3 5596.8 5629.5 5711.6 432.9 433.4 434.2 443.8 444.2 3580.9 3596.3 3610.7 3621.8 3649.0 10126.8 10441.9 10565.2 10565.6 10588.4 10258.9 10373.6 10416.0 10433.9 10498.2 8012.1 8071.1 8160.1 8168.7 8197.9 5347.0 5414.8 5518.8 5561.5 5570.4 9165.9 9225.8 9402.2 9419.8 9566.4 9508.8 9687.8 9700.5 9858.1 9893.3 6840.8 6974.5 6974.6 6982.9 7209.6 7720.4 7740.0 7742.4 7752.0 7753.8 6890.4 6938.5 6981.6 6993.7 7243.4 6839.7 6887.7 7034.9 7118.0 7175.1 6460.4 6562.4 6574.7 6617.0 6624.4 4666.3 4683.5 4723.6 4760.3 4769.6 4627.8 4747.2 4756.6 4757.0 4857.3 03:00:44 INFO - PROCESS | 13926 | 03:00:44 INFO - PROCESS | 13926 | [#4] prototype.html Cycles:180 Average:5576.59 Median:6412.08 stddev:1741.93 (27.2%) stddev-sans-first:1701.36 03:00:44 INFO - PROCESS | 13926 | Values: 309.3 314.7 317.2 329.4 336.6 6290.4 6317.0 6399.8 6424.4 6431.7 6306.9 6320.4 6329.2 6335.8 6336.2 4521.6 4597.5 4606.5 4646.0 4667.0 4699.8 4734.5 4756.9 4759.7 4762.7 4668.2 4673.0 4676.2 4684.9 4686.3 4490.6 4563.5 4632.3 4679.8 4731.5 4096.4 4107.3 4111.3 4124.5 4126.0 6036.5 6038.5 6054.0 6057.5 6083.1 5431.1 5438.3 5442.7 5447.0 5461.4 6627.2 6629.8 6639.7 6645.8 6646.7 4333.3 4482.0 4486.7 4496.6 4536.1 6943.8 6983.2 6985.4 6991.7 7001.6 4545.5 4548.4 4551.8 4552.9 4555.3 4613.4 4614.2 4618.8 4618.8 4619.4 5407.3 5414.9 5425.6 5428.6 5429.5 6433.1 6624.0 6630.0 6728.3 6741.8 1601.0 1605.9 1619.0 1621.1 1624.6 1032.9 1038.5 1048.1 1058.1 1062.8 6264.0 6390.9 6468.0 6481.4 6560.1 7013.6 7024.8 7029.5 7037.5 7039.8 6581.2 6586.9 6591.1 6593.8 6595.7 3736.2 3770.3 3774.1 3777.9 3788.3 6888.5 7121.4 7170.9 7178.1 7199.7 7138.5 7146.6 7155.8 7160.1 7175.1 7141.6 7142.1 7162.5 7162.8 7167.8 6965.1 6971.0 6977.2 6978.5 7000.0 6671.4 6867.0 6911.3 6924.4 6928.5 7149.2 7164.9 7177.3 7184.5 7197.9 4565.1 4594.9 4601.4 4601.7 4603.5 6969.1 6976.3 6977.8 6982.2 6999.1 6593.7 6805.2 6823.4 6835.0 6848.8 6756.8 6768.0 6787.8 6788.1 6796.3 6672.7 6680.3 6690.0 6706.7 6750.1 6806.9 6820.0 6820.1 6833.5 6840.5 6363.2 6611.5 6659.9 6666.3 6668.6 03:00:44 INFO - PROCESS | 13926 | 03:00:44 INFO - PROCESS | 13926 | [#5] yui.html Cycles:180 Average:16181.83 Median:27785.06 stddev:19167.48 (69.0%) stddev-sans-first:19186.95 03:00:44 INFO - PROCESS | 13926 | Values: 911.6 915.5 917.2 926.4 945.7 15241.1 15368.6 15396.0 15396.5 15452.9 14064.7 14133.6 14144.2 14179.1 14179.8 761.6 892.9 896.4 897.7 898.5 884.0 885.0 888.7 890.2 893.2 801.5 949.7 953.3 954.2 954.7 951.6 953.3 954.3 954.5 954.6 698.6 701.8 701.9 702.0 702.3 14989.9 15067.0 15094.6 15118.5 15120.4 14638.5 14840.6 14997.8 15408.0 15434.8 12224.8 12242.9 12438.7 12526.9 12537.7 3992.0 4054.3 4079.6 4081.2 4088.0 56484.4 57138.4 57246.4 57371.1 57450.0 11725.8 12111.5 12225.4 12235.4 12260.6 20892.3 21005.1 21036.2 21091.9 21095.2 9042.7 9126.4 9133.1 9146.6 9197.4 5099.7 5119.5 5198.2 5253.6 5323.7 3444.6 3491.2 3509.5 3510.0 3515.7 645.5 651.0 656.6 657.7 667.4 624.4 691.9 702.7 706.7 707.6 9130.0 9286.3 9488.8 9894.6 10051.7 614.6 656.9 675.9 704.6 736.6 4465.0 4684.1 4764.9 4788.5 4825.4 70342.0 70492.0 70996.0 71013.3 71553.0 58930.0 59933.4 60100.0 61539.0 62134.4 51839.0 52464.5 55993.0 56636.0 56737.4 8955.4 9104.2 9193.4 9199.0 9378.6 41595.6 41927.6 42002.8 42648.6 42690.6 50744.7 52792.2 52821.0 53976.7 54004.0 10937.9 11041.7 11222.6 11272.9 11483.5 12211.7 12986.6 13177.8 13317.5 13356.5 12703.7 13321.7 13364.1 13630.7 14373.5 11010.1 11440.9 11707.3 12042.7 12502.2 13143.7 13444.7 13579.3 13765.4 13801.7 11593.7 11725.5 11890.6 11935.7 11938.9 11124.7 11614.3 11802.5 11817.1 11922.0 03:00:44 INFO - PROCESS | 13926 | -------- Summary: end -------- 03:00:44 INFO - PROCESS | 13926 | 03:00:44 INFO - TEST-INFO | 13926: exit 0 03:00:44 INFO - TEST-OK | dromaeo_css | took 1111452ms 03:00:44 INFO - TEST-START | kraken 03:00:44 INFO - operating with platform_type : linux_ 03:00:44 INFO - Initialising browser for kraken test... 03:00:44 INFO - TEST-INFO | started process 14112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM5psIl/profile http://localhost:45609/getInfo.html) 03:00:48 INFO - PROCESS | 14112 | __metrics Screen width/height:1600/1200 03:00:48 INFO - PROCESS | 14112 | colorDepth:24 03:00:48 INFO - PROCESS | 14112 | Browser inner width/height: 1024/697 03:00:48 INFO - PROCESS | 14112 | __metrics 03:00:49 ERROR - PROCESS | 14112 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:00:50 INFO - TEST-INFO | 14112: exit 0 03:00:50 INFO - Browser initialized. 03:00:50 INFO - Running cycle 1/1 for kraken test... 03:00:50 INFO - TEST-INFO | started process 14206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM5psIl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:02 INFO - PROCESS | 14206 | RSS: Main: 142172160 03:01:02 INFO - PROCESS | 14206 | 03:01:04 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45609/tests/kraken/driver.html?testName=audio-beat-detection) 03:01:05 INFO - PROCESS | 14206 | RSS: Main: 197136384 03:01:05 INFO - PROCESS | 14206 | 03:01:08 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45609/tests/kraken/driver.html?testName=audio-dft) 03:01:08 INFO - PROCESS | 14206 | RSS: Main: 182267904 03:01:08 INFO - PROCESS | 14206 | 03:01:11 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45609/tests/kraken/driver.html?testName=audio-fft) 03:01:12 INFO - PROCESS | 14206 | RSS: Main: 272392192 03:01:12 INFO - PROCESS | 14206 | 03:01:14 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45609/tests/kraken/driver.html?testName=audio-oscillator) 03:01:14 INFO - PROCESS | 14206 | RSS: Main: 178913280 03:01:14 INFO - PROCESS | 14206 | 03:01:16 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45609/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:01:17 INFO - PROCESS | 14206 | RSS: Main: 177467392 03:01:17 INFO - PROCESS | 14206 | 03:01:20 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45609/tests/kraken/driver.html?testName=imaging-darkroom) 03:01:21 INFO - PROCESS | 14206 | RSS: Main: 212586496 03:01:21 INFO - PROCESS | 14206 | 03:01:24 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45609/tests/kraken/driver.html?testName=imaging-desaturate) 03:01:24 INFO - PROCESS | 14206 | RSS: Main: 213159936 03:01:24 INFO - PROCESS | 14206 | 03:01:27 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45609/tests/kraken/driver.html?testName=json-parse-financial) 03:01:28 INFO - PROCESS | 14206 | RSS: Main: 212066304 03:01:28 INFO - PROCESS | 14206 | 03:01:29 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45609/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:01:30 INFO - PROCESS | 14206 | RSS: Main: 192278528 03:01:30 INFO - PROCESS | 14206 | 03:01:32 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45609/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:01:32 INFO - PROCESS | 14206 | RSS: Main: 194535424 03:01:32 INFO - PROCESS | 14206 | 03:01:34 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45609/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:01:35 INFO - PROCESS | 14206 | RSS: Main: 211660800 03:01:35 INFO - PROCESS | 14206 | 03:01:37 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:01:38 INFO - PROCESS | 14206 | RSS: Main: 213585920 03:01:38 INFO - PROCESS | 14206 | 03:01:41 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:01:41 INFO - PROCESS | 14206 | RSS: Main: 212557824 03:01:41 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | Cycle 1(1): loaded http://localhost:45609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45609/tests/kraken/driver.html?testName=ai-astar) 03:01:43 INFO - PROCESS | 14206 | RSS: Main: 276025344 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | __start_tp_report 03:01:43 INFO - PROCESS | 14206 | _x_x_mozilla_page_load 03:01:43 INFO - PROCESS | 14206 | _x_x_mozilla_page_load_details 03:01:43 INFO - PROCESS | 14206 | |i|pagename|runs| 03:01:43 INFO - PROCESS | 14206 | |0;ai-astar;112;114;109;111;111;112;108;112;110;108 03:01:43 INFO - PROCESS | 14206 | |1;audio-beat-detection;149;126;153;183;126;161;149;132;179;126 03:01:43 INFO - PROCESS | 14206 | |2;audio-dft;161;161;160;161;161;160;159;162;163;160 03:01:43 INFO - PROCESS | 14206 | |3;audio-fft;74;75;76;169;76;76;76;76;156;74 03:01:43 INFO - PROCESS | 14206 | |4;audio-oscillator;91;93;157;92;92;93;149;92;93;152 03:01:43 INFO - PROCESS | 14206 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 03:01:43 INFO - PROCESS | 14206 | |6;imaging-darkroom;146;145;145;146;145;145;145;145;145;145 03:01:43 INFO - PROCESS | 14206 | |7;imaging-desaturate;95;94;94;94;95;94;95;95;95;95 03:01:43 INFO - PROCESS | 14206 | |8;json-parse-financial;52;55;52;54;55;56;54;78;53;54 03:01:43 INFO - PROCESS | 14206 | |9;json-stringify-tinderbox;57;58;57;58;58;57;58;58;58;59 03:01:43 INFO - PROCESS | 14206 | |10;stanford-crypto-aes;72;72;73;72;73;73;73;73;72;72 03:01:43 INFO - PROCESS | 14206 | |11;stanford-crypto-ccm;116;113;113;113;121;113;113;111;129;140 03:01:43 INFO - PROCESS | 14206 | |12;stanford-crypto-pbkdf2;160;160;168;162;160;163;162;160;156;159 03:01:43 INFO - PROCESS | 14206 | |13;stanford-crypto-sha256-iterative;68;65;67;71;65;66;65;65;66;65 03:01:43 INFO - PROCESS | 14206 | __end_tp_report 03:01:43 INFO - PROCESS | 14206 | __start_cc_report 03:01:43 INFO - PROCESS | 14206 | _x_x_mozilla_cycle_collect,1557 03:01:43 INFO - PROCESS | 14206 | __end_cc_report 03:01:43 INFO - PROCESS | 14206 | __startTimestamp1463824903558__endTimestamp 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | ------- Summary: start ------- 03:01:43 INFO - PROCESS | 14206 | Number of tests: 14 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:1.95 (1.7%) stddev-sans-first:2.01 03:01:43 INFO - PROCESS | 14206 | Values: 112.0 114.0 109.0 111.0 111.0 112.0 108.0 112.0 110.0 108.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:151.00 stddev:21.31 (14.1%) stddev-sans-first:22.61 03:01:43 INFO - PROCESS | 14206 | Values: 149.0 126.0 153.0 183.0 126.0 161.0 149.0 132.0 179.0 126.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 03:01:43 INFO - PROCESS | 14206 | Values: 161.0 161.0 160.0 161.0 161.0 160.0 159.0 162.0 163.0 160.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:36.87 (48.5%) stddev-sans-first:38.48 03:01:43 INFO - PROCESS | 14206 | Values: 74.0 75.0 76.0 169.0 76.0 76.0 76.0 76.0 156.0 74.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:92.00 stddev:29.24 (31.8%) stddev-sans-first:30.15 03:01:43 INFO - PROCESS | 14206 | Values: 91.0 93.0 157.0 92.0 92.0 93.0 149.0 92.0 93.0 152.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:01:43 INFO - PROCESS | 14206 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 03:01:43 INFO - PROCESS | 14206 | Values: 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:01:43 INFO - PROCESS | 14206 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:54.50 stddev:7.73 (14.2%) stddev-sans-first:8.04 03:01:43 INFO - PROCESS | 14206 | Values: 52.0 55.0 52.0 54.0 55.0 56.0 54.0 78.0 53.0 54.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 03:01:43 INFO - PROCESS | 14206 | Values: 57.0 58.0 57.0 58.0 58.0 57.0 58.0 58.0 58.0 59.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:73.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 03:01:43 INFO - PROCESS | 14206 | Values: 72.0 72.0 73.0 72.0 73.0 73.0 73.0 73.0 72.0 72.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:114.50 stddev:9.38 (8.2%) stddev-sans-first:9.91 03:01:43 INFO - PROCESS | 14206 | Values: 116.0 113.0 113.0 113.0 121.0 113.0 113.0 111.0 129.0 140.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:3.13 (1.9%) stddev-sans-first:3.30 03:01:43 INFO - PROCESS | 14206 | Values: 160.0 160.0 168.0 162.0 160.0 163.0 162.0 160.0 156.0 159.0 03:01:43 INFO - PROCESS | 14206 | 03:01:43 INFO - PROCESS | 14206 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.95 (2.9%) stddev-sans-first:1.96 03:01:43 INFO - PROCESS | 14206 | Values: 68.0 65.0 67.0 71.0 65.0 66.0 65.0 65.0 66.0 65.0 03:01:43 INFO - PROCESS | 14206 | -------- Summary: end -------- 03:01:43 INFO - PROCESS | 14206 | 03:01:44 INFO - TEST-INFO | 14206: exit 0 03:01:44 INFO - TEST-OK | kraken | took 59925ms 03:01:44 INFO - SUITE-END | took 1171s 03:01:44 INFO - Completed test suite (00:19:31) 03:01:44 INFO - javascript benchmark 03:01:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.5698859148306, 3401.608814986277, 3416.991987363728, 3446.655334466552, 3454.1019334972916, 5625.887482250352, 5650.124230744231, 5656.406077361874, 5663.377028526869, 5672.574556908233, 5658.179563963223, 5690.146478028298, 5692.089265717486, 5695.401982791809, 5700.914486282709, 4924.0, 5147.562457191143, 5241.135212689902, 5312.07038768216, 5331.0, 5109.310243117187, 5161.767720452589, 5164.302819119408, 5167.509086636764, 5171.120909445403, 5055.9747201263945, 5128.0, 5136.306598609196, 5136.974315128419, 5160.174372100465, 5165.328507294046, 5175.120229560984, 5194.766235519411, 5201.531862132389, 5233.581313494911, 4969.577585905203, 5103.56619687327, 5104.259882317043, 5110.97444512775, 5183.559397451221, 5466.508014278695, 5532.861678458071, 5536.723163841792, 5542.8337149885565, 5555.50000499957, 5900.822975310747, 5901.527877769811, 5904.055351143839, 5905.852353691149, 5909.7636094556165, 5967.49276311514, 6069.332373438918, 6095.238095238095, 6117.908231376533, 6145.863015342176, 5617.634853734494, 5665.5467562594895, 5674.09214525678, 5675.091985282335, 5677.09166533361, 5989.880202396015, 6116.2048933639235, 6124.540659450559, 6126.264848218242, 6135.110408990671, 5738.827835164868, 5799.4780469757925, 5805.158252053513, 5814.156947242626, 5820.3888591698105, 5988.880222395528, 6030.969845150747, 6035.909461358083, 6038.6678732670125, 6040.244969378828, 5830.53355731549, 5893.970530147321, 5981.431763982415, 6003.21958145447, 6008.459238668541, 5955.642661440327, 5957.702114894238, 5964.31410387811, 5976.880462390728, 6003.129546215774, 4545.909081818345, 4546.227141385973, 4547.136044151601, 4553.612942899825, 4578.587927086578, 4040.8383664653675, 4047.3119569673227, 4078.490188726409, 4109.876703698894, 4115.0, 5690.800821971211, 5701.629394089371, 5716.342620598602, 5737.65574065549, 5738.254026976467, 5996.190514280604, 6020.879582408327, 6043.969780151159, 6046.939530604725, 6047.697615119227, 5514.558835293167, 5651.039323315046, 5678.432156784371, 5728.054870946247, 5741.540676745851, 5037.420696619863, 5063.822766203239, 5063.8480845574695, 5073.162928116893, 5137.922931156036, 6021.759129634853, 6078.635281883013, 6079.513638908877, 6089.482393996472, 6091.086337049478, 5762.855928601818, 6021.698915054318, 6083.057126145454, 6122.510199184144, 6123.969380153071, 6123.2652081750475, 6131.693415329305, 6135.815925522242, 6136.6011209271255, 6142.6314421134875, 5784.566157538117, 5891.05743081105, 5891.705414729332, 5893.764249430146, 5903.2325797646035, 5963.73163207648, 5973.970130149321, 6007.879842403215, 6047.637141771508, 6066.848328791815, 5867.618604790675, 5870.17817505541, 5932.0, 5934.881302374015, 5941.22764040672, 5704.657720536781, 5874.765009399576, 5903.498202652822, 5912.054071348563, 5931.0, 5701.600887937971, 5710.400407957105, 5730.054541000688, 5740.1102829061565, 5761.625494342854, 5855.502282306052, 5860.355360910211, 5861.413858614104, 5864.413558644102, 5866.560007999503, 5681.573881958787, 5743.511801496919, 5780.942190578208, 5823.854403639943, 5895.557833162616], "value": 5533.88526069622, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.5634837355718, 689.2211800665249, 702.4731451411438, 749.5540153608605, 764.2166779051475, 33174.502382464256, 40496.190076198494, 40828.795856020755, 40874.0, 40903.18193636125, 42608.786956065174, 43299.35050974238, 43421.56578434215, 43450.13099738003, 43490.0, 8107.189281071905, 8178.631961561744, 8660.783480412993, 8799.560021998906, 10361.171106311476, 10474.371537707724, 10652.414117223589, 10662.946685266563, 10669.359838409682, 10674.573017079347, 10767.569297228141, 10841.83737243942, 10860.565577376936, 10861.13110951122, 10862.61980830671, 8504.829903401927, 10465.895341046567, 10584.0, 10603.204759643058, 10620.628278010232, 10601.363918164934, 10748.301360411548, 10752.139828813677, 10757.62348317813, 10758.623448179276, 41194.1761164778, 41768.0, 41801.0, 41821.37267940983, 41852.372214416806, 3855.1325951660933, 3882.107115363482, 3980.4029395590605, 4377.212101821671, 4484.417025786627, 34042.82978585116, 34345.31309373824, 34404.13989650279, 34576.0, 35640.64359356425, 4254.532001479834, 4300.010997470568, 4311.913761724748, 4316.6978311518205, 4318.978405107986, 327981.0, 328695.0, 328762.0, 331501.0, 332216.0, 41088.589114109076, 67134.66432667903, 68077.3192268071, 68085.0, 68117.0, 38937.6106238934, 38950.220995580494, 39080.804595976835, 39092.804535977135, 39107.41338879919, 16820.495385138467, 17493.212805423787, 17650.735238971425, 17705.468835934942, 17729.645407091786, 14908.62728431798, 15257.6185595361, 15262.16058116792, 15262.236888155549, 15266.389344426321, 9512.239020878313, 9515.33392662507, 9547.952260238655, 9611.807763844685, 9616.663416780379, 3645.981770091186, 3694.150345420568, 3736.831842567091, 3778.4899038629983, 3799.50606421169, 1152.4410660829492, 1154.7805916875766, 1176.5587904535798, 1182.7575347053833, 1210.8546974362957, 29481.852590736908, 30232.244193895327, 30515.2371190722, 31059.223519412197, 31537.37770633623, 1191.666333426642, 1233.586748439265, 1234.1916044990546, 1251.249250449723, 1370.7327071221016, 16274.511764647079, 17900.731489027676, 18251.81748182501, 18576.485095378797, 18695.345662901735, 504492.0, 510437.0, 511534.0, 512017.0, 512285.0, 60960.69519652373, 62084.379156208764, 62126.378736212966, 62222.688886555276, 62243.066354004724, 1499.4227222519191, 1539.699758547095, 1542.8534289242505, 1612.4437069211103, 1649.4309463235165, 30577.388452231276, 33017.66982330146, 33437.39091407692, 33543.0, 33910.66089339174, 50745.23882141845, 51127.233091502916, 51597.48402515927, 51614.483855160965, 51671.741641291555, 399062.0, 401351.0, 403309.0, 403357.0, 403457.0, 27643.30891727723, 30939.69060309368, 31306.843465782524, 31314.843425783638, 31379.84310078435, 41898.37152442777, 42992.0, 43167.35248971205, 43579.34630980601, 44612.55387446084, 39820.60179398169, 39855.60144398635, 40403.393949091376, 40574.188516230104, 41260.79369603133, 39593.80203098966, 39775.80112099421, 40420.3936940952, 40550.79724601358, 41020.1795964085, 41148.79425602853, 41719.0, 42355.152896942505, 42518.574814251464, 42698.14603707846, 35248.647513524535, 35389.0, 35817.82091089528, 36241.27517449689, 36291.27417451689, 27362.726372736815, 27501.449971000868, 27670.308242294104, 27673.308167295978, 27786.12090944019], "value": 19959.55768066598, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.4281149202608, 413.1777762253115, 414.8983499042731, 416.1614347090612, 426.558511940142, 18787.2485100596, 19675.606487870253, 19684.0, 20568.691469627967, 21404.57190856182, 18973.62052758944, 19569.51076223095, 19570.51073723154, 20949.581008379824, 21128.260510882123, 5011.098002359565, 5111.198397032729, 5185.844424667266, 5963.880722385549, 5979.491743201811, 5791.276090488689, 5875.0, 5888.4700376966275, 5901.586888917777, 5916.053431450969, 5030.723310217955, 5139.15203991341, 5751.367349591542, 5868.882622347551, 5869.119632055204, 5122.820701275475, 5148.742562871879, 5214.322138122057, 5219.660722053073, 5223.6679646690045, 5047.520485553867, 5076.64463487556, 5131.461196574343, 5132.974335128338, 5143.408508021588, 13012.284324362156, 13296.0, 13303.40134693941, 13341.39963701626, 13388.866111338957, 2414.4326083370393, 2425.963610545843, 2446.8531888086595, 2501.1121052026633, 2509.3475696318906, 10129.746756331077, 10205.948970255102, 13108.0, 15010.849891501055, 15361.462348817739, 2011.1352118589, 2034.1456588232977, 2053.661145910923, 2074.7925207479284, 2181.2692747929464, 82203.5889820547, 86177.0, 86728.0, 88501.55749221277, 89290.5535472325, 11095.0, 11165.385903775208, 11266.549338026387, 11297.096232301396, 11431.657050288504, 16021.919890400473, 16079.276432560562, 16121.919390402973, 16180.43368482121, 16208.918955405148, 8844.159804818531, 8861.24679402258, 9014.909850901538, 9135.314851386172, 9164.541772911327, 9092.27261819053, 9098.226650734628, 9118.680846170351, 9230.400023998418, 9272.860907086399, 4719.764011799396, 4773.904521909542, 4829.758512074382, 4837.4920633332995, 4838.709677419366, 1949.1618604000132, 2072.4404410808997, 2076.6158260721513, 2084.8749075055543, 2094.151868493232, 971.8104969531015, 1032.464499716791, 1066.4507778494083, 1092.3609688332256, 1102.443266150589, 19455.513612159528, 19592.768753676755, 19704.21183152658, 19984.60030799405, 20171.899140504498, 1013.807376598444, 1037.159900480613, 1041.994790026045, 1090.33489571363, 1115.1914861725184, 10641.787164256672, 11425.60010399632, 11460.94269528647, 11517.827232591519, 11576.47905844239, 535251.0, 540819.0, 543979.0, 570408.0, 573796.0, 96621.0, 98770.0, 100199.0, 100203.49898250462, 100588.0, 1066.3868275741324, 1068.1454836131063, 1069.6363236499471, 1072.1637123044038, 1129.6215767717742, 17395.304187832346, 17839.73240401421, 17900.820991789915, 17963.281468741105, 18105.637887242447, 38841.6115838838, 39068.0, 39479.0, 40069.79965100156, 41692.0, 51396.48603513917, 52194.21708674297, 52312.47687523076, 52582.211266830265, 52647.21029184642, 7833.255840695125, 8028.638711258124, 8030.156833532628, 8249.29880960125, 8309.418340716333, 9091.136342047495, 12492.750144997231, 13283.601491955256, 13393.263370514715, 13546.729065418833, 11772.234804737665, 11847.940760296144, 11971.0, 11977.520899163936, 12220.572279970158, 11344.20590558653, 11581.305121692725, 11839.585614503796, 11949.940250298692, 11961.102917281412, 11653.88346116528, 11760.176787624785, 11787.351695656822, 12131.575394861491, 12368.257904525757, 8269.875951860606, 8450.366222533212, 8452.36607254446, 8472.788180295542, 8534.359923005675, 7948.84102317962, 11539.4807233673, 12670.809937850756, 12835.0, 12856.421461034462], "value": 9316.70077639261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.6525166585857, 1579.0920220872997, 1592.402848931651, 1804.9819501804986, 1906.2089232968328, 8191.3856460765455, 8359.91640083599, 8367.2469477747, 8375.204355586226, 8379.832403351937, 8115.269625733683, 8277.255047045765, 8287.46131501452, 8294.170582941702, 8304.50172989621, 2082.396105129518, 2351.2946116165167, 2395.9817077741977, 2417.0815090265764, 2430.2101816909485, 2387.510560335127, 2397.2927986244013, 2397.61638137898, 2399.9760002399926, 2401.591729406005, 2296.7703229677068, 2355.611324131516, 2362.763723627632, 2369.407648087978, 2377.1442280778906, 2062.82465990391, 2335.4861930375373, 2381.1903952656007, 2384.308550520347, 2385.797207237387, 2332.953340933172, 2349.977759674547, 2356.26955643751, 2358.4221865642858, 2394.1261439574605, 8285.212904774036, 8380.83238335236, 8392.874106888401, 8392.958035209846, 8405.327573794082, 5107.131787596118, 5209.244659524347, 5214.113600687892, 5236.659617124875, 5265.315508983807, 3519.0498565387456, 3527.4708793680898, 3531.8587256509963, 3556.697680697144, 3625.4380571011534, 1144.6680462665818, 1148.7817314710178, 1179.3277831635971, 1181.4388165621347, 1182.3615247766281, 11963.46164422603, 12011.759764804743, 12041.819372709417, 12043.759124817541, 12063.276203427822, 4391.912161756747, 4466.57567531084, 4524.615407690318, 4553.954460455419, 4564.0, 10284.228682848816, 10299.485025748683, 10311.123554497952, 10312.896871031193, 10319.380837149794, 4442.155990361821, 4976.5023497649945, 5015.197568389113, 5026.195808670595, 5029.497050295015, 4660.347551342815, 4711.340412342275, 4728.40894888139, 4749.928751068736, 4762.571368576845, 4017.6183262590007, 4019.737395633821, 4190.4419583351955, 4207.389928460356, 4224.197402493516, 1257.534712156508, 1333.919964802115, 1335.2722766092502, 1349.1532865653464, 1361.86381361865, 840.6385254340693, 945.4280160502797, 947.3652652722692, 968.1867231525412, 968.2093072704668, 5563.054280772279, 5570.303712035996, 5596.832095037155, 5629.493345598916, 5711.571632127524, 432.8982738929432, 433.4343681495615, 434.24874966308465, 443.7537166872352, 444.21817601022434, 3580.856765729394, 3596.2627661329366, 3610.6750392464805, 3621.8189090545366, 3648.9635103648625, 10126.848097278547, 10441.947790261, 10565.154787617126, 10565.577376904837, 10588.364698117983, 10258.897411025944, 10373.636922707668, 10416.0, 10433.947830260951, 10498.160147188206, 8012.0786109596975, 8071.07182674, 8160.102388737234, 8168.673253069811, 8197.918020819716, 5347.0, 5414.783408663609, 5518.822093226167, 5561.4716601922755, 5570.442955704397, 9165.862512062458, 9225.815483690423, 9402.15380615748, 9419.811603768023, 9566.426014439156, 9508.809823803624, 9687.806243874942, 9700.466474343697, 9858.112769850748, 9893.258005649748, 6840.828979275558, 6974.546654467444, 6974.616396098263, 6982.895256571257, 7209.567425954459, 7720.382369410321, 7740.0, 7742.4193185510185, 7752.0, 7753.767386978399, 6890.414314783299, 6938.479614028867, 6981.581105133709, 6993.650317484207, 7243.420526357984, 6839.658017099225, 6887.7244910203035, 7034.859302814018, 7118.0, 7175.103112110986, 6460.3862633049785, 6562.376574225441, 6574.704138313883, 6617.0, 6624.403803657501, 4666.2767271073035, 4683.531646835289, 4723.622110231242, 4760.333553302609, 4769.642276829182, 4627.814887404601, 4747.240441529477, 4756.619470442425, 4757.02480991389, 4857.344258525195], "value": 4404.682342996843, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.2809218566831, 314.66331025802384, 317.18325312320775, 329.4415964939429, 336.5759143479215, 6290.433860952519, 6317.0, 6399.776007839727, 6424.3896829801215, 6431.710573024214, 6306.905396419057, 6320.367963203677, 6329.2404911410695, 6335.809925702225, 6336.239651241846, 4521.615662668677, 4597.54024597541, 4606.493285738566, 4646.047560250141, 4666.953330466703, 4699.78850951708, 4734.479207287213, 4756.857294281177, 4759.666823322369, 4762.714237145782, 4668.229742092551, 4673.01866608011, 4676.228422310332, 4684.859454216379, 4686.343911852344, 4490.618297444705, 4563.543645635443, 4632.2819962905805, 4679.8362057328, 4731.4795372509, 4096.365063415175, 4107.281225785506, 4111.280525907954, 4124.546299907008, 4125.97937010316, 6036.494854635321, 6038.516918646542, 6054.031354983225, 6057.545684073712, 6083.087536869461, 5431.131019036935, 5438.265834112383, 5442.673439593597, 5447.0, 5461.399246082928, 6627.204735431731, 6629.801105966829, 6639.73441062357, 6645.80062598118, 6646.6676666166495, 4333.328334108218, 4481.955180448186, 4486.663500237462, 4496.617787488068, 4536.138133754576, 6943.79168624942, 6983.196932352794, 6985.371316581482, 6991.685374158124, 7001.579905205704, 4545.522720114341, 4548.385967894358, 4551.795169217393, 4552.88617784558, 4555.33947577606, 4613.446386433649, 4614.215583350839, 4618.769061546976, 4618.815247390134, 4619.3994780678295, 5407.270018547446, 5414.945850541523, 5425.620206585501, 5428.647137936022, 5429.53848922846, 6433.131527243762, 6624.039514270404, 6630.038644396535, 6728.259891411941, 6741.764038258638, 1600.9519714408586, 1605.855473007435, 1619.0204926019824, 1621.051684764426, 1624.63445724711, 1032.9018743219533, 1038.4963292802984, 1048.0567489259727, 1058.0583280880023, 1062.829947208443, 6264.0, 6390.904136437957, 6467.967660161763, 6481.351864813481, 6560.081588577603, 7013.614251216232, 7024.789256322319, 7029.507934444642, 7037.472189585802, 7039.824004399931, 6581.177352830896, 6586.934130658728, 6591.110200123018, 6593.835154121185, 6595.736170553124, 3736.1967177057063, 3770.2836461072307, 3774.1319496515957, 3777.8866634000474, 3788.318102741478, 6888.483363747739, 7121.394681452031, 7170.856582868313, 7178.102737157856, 7199.712011519586, 7138.535995160298, 7146.606936618536, 7155.821104472326, 7160.10498687664, 7175.067241258603, 7141.571505709674, 7142.142942846892, 7162.4986250962975, 7162.785116446515, 7167.784966451015, 6965.094537710065, 6971.0, 6977.1976222733, 6978.47661425385, 6999.965000175171, 6671.366220209073, 6866.965665171642, 6911.343422374866, 6924.376806087476, 6928.549644273106, 7149.213586505584, 7164.89252661221, 7177.282271772781, 7184.533005354635, 7197.856042879218, 4565.132624801277, 4594.908101838011, 4601.4248218972625, 4601.746903920316, 4603.470600880942, 6969.128858892638, 6976.302369762983, 6977.825554361181, 6982.197047339621, 6999.12510936133, 6593.736250549924, 6805.217399999064, 6823.420009299265, 6835.008923705936, 6848.794536163923, 6756.831079223059, 6768.0, 6787.762428314985, 6788.117544719353, 6796.252412234551, 6672.698823729326, 6680.298568650222, 6690.0, 6706.66466676674, 6750.088738020305, 6806.93193068063, 6820.0, 6820.079289295882, 6833.45332373399, 6840.521163518506, 6363.236411630634, 6611.504137189826, 6659.866802664016, 6666.26671066192, 6668.599884006975], "value": 4992.052766417327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.585228720932, 915.5102020419077, 917.2020342302197, 926.4441335198882, 945.6690158444541, 15241.085534867916, 15368.61578460539, 15396.0, 15396.538103856903, 15452.92273538632, 14064.718705625906, 14133.646658833508, 14144.151350918926, 14179.149251044944, 14179.78730319046, 761.5735188294559, 892.9464232146059, 896.3501461440469, 897.7261935109789, 898.469902757373, 883.9955800221022, 885.0397318908991, 888.693400776731, 890.2077151335317, 893.1871996483202, 801.4990630855715, 949.6628696812636, 953.3374304858127, 954.1746389373177, 954.6610953111649, 951.6050838901847, 953.2850362228329, 954.3271993244781, 954.5227386306847, 954.5609019850876, 698.6087790837147, 701.8385771272635, 701.8982247574073, 701.9929800701979, 702.2696395748416, 14989.850101498954, 15067.0, 15094.622634434118, 15118.546443606709, 15120.39518419262, 14638.487652932095, 14840.554783356516, 14997.775033374508, 15408.0, 15434.765218782582, 12224.755504889941, 12242.877571224262, 12438.689032774253, 12526.937365313115, 12537.686557836036, 3991.960080399188, 4054.2904991626347, 4079.551249362568, 4081.2041651877894, 4088.0, 56484.43515564833, 57138.428615713725, 57246.42753572453, 57371.13943290854, 57450.0, 11725.765484690259, 12111.454984525717, 12225.44985475638, 12235.388230588434, 12260.632181034583, 20892.268770592957, 21005.054772535274, 21036.158553657988, 21091.8945405272, 21095.156193752384, 9042.728718138467, 9126.36115471924, 9133.132352426508, 9146.588403521857, 9197.402168859002, 5099.745012749348, 5119.488051194925, 5198.220266959911, 5253.553447956967, 5323.653962492425, 3444.603870554918, 3491.2144767427635, 3509.5262139610827, 3509.964900351015, 3515.6660117288816, 645.4545908707134, 651.0429668387463, 656.6421300391203, 657.710607332772, 667.4493542827187, 624.4192900602393, 691.8962155676588, 702.68379229347, 706.6537396675592, 707.5860621536459, 9130.0, 9286.303527235485, 9488.810223795486, 9894.55474503649, 10051.69844904654, 614.6097228260087, 656.9488817891336, 675.8969778174859, 704.5903011699999, 736.5911918885071, 4464.977675111669, 4684.086603112429, 4764.904701905943, 4788.545088216614, 4825.372701548777, 70342.0, 70492.0, 70996.0, 71013.2898671017, 71553.0, 58930.0, 59933.40066599366, 60100.0, 61539.0, 62134.37865621376, 51839.0, 52464.47535524672, 55992.999999999185, 56636.0, 56737.43262567404, 8955.41789783662, 9104.180623743894, 9193.402428842104, 9199.0, 9378.624855005723, 41595.58404415917, 41927.58072419237, 42002.78998604987, 42648.57351426446, 42690.57309426866, 50744.74627626838, 52792.20811687905, 52821.0, 53976.730116350736, 54004.0, 10937.890621093688, 11041.723956901142, 11222.607208747655, 11272.943635281772, 11483.540658373571, 12211.694707632025, 12986.610401687965, 13177.802332964822, 13317.467301307839, 13356.465741370625, 12703.682407939876, 13321.733565328444, 13364.064515483822, 13630.659233518845, 14373.496927607484, 11010.119190464904, 11440.94279528597, 11707.2975621463, 12042.698932526757, 12502.249865008129, 13143.671408214872, 13444.731105378034, 13579.253141077335, 13765.38055787512, 13801.723965520432, 11593.6521904343, 11725.472353743931, 11890.583829565923, 11935.701607459883, 11938.94529187296, 11124.666260012213, 11614.270646397921, 11802.527898884291, 11817.113716471127, 11922.0], "value": 7206.207834572223, "unit": "score"}], "name": "dromaeo_css", "value": 7391.467193174965, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 109.0, 111.0, 111.0, 112.0, 108.0, 112.0, 110.0, 108.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 153.0, 183.0, 126.0, 161.0, 149.0, 132.0, 179.0, 126.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 160.0, 159.0, 162.0, 163.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 169.0, 76.0, 76.0, 76.0, 76.0, 156.0, 74.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 157.0, 92.0, 92.0, 93.0, 149.0, 92.0, 93.0, 152.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 52.0, 54.0, 55.0, 56.0, 54.0, 78.0, 53.0, 54.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 59.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 72.0, 73.0, 73.0, 73.0, 73.0, 72.0, 72.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 113.0, 113.0, 121.0, 113.0, 113.0, 111.0, 129.0, 140.0], "value": 118.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 168.0, 162.0, 160.0, 163.0, 162.0, 160.0, 156.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 67.0, 71.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1511.8, "alertThreshold": 2.0}]} 03:01:44 INFO - Return code: 0 03:01:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:01:44 ERROR - # TBPL SUCCESS # 03:01:44 INFO - Running post-action listener: _resource_record_post_action 03:01:44 INFO - Running post-run listener: _resource_record_post_run 03:01:45 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 278528; Write bytes: 512679936; Read time: 404; Write time: 443892 03:01:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 261173248; Read time: 160; Write time: 271868 03:01:45 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 274432; Write bytes: 251506688; Read time: 244; Write time: 172024 03:01:45 INFO - Running post-run listener: _upload_blobber_files 03:01:45 INFO - Blob upload gear active. 03:01:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:01:45 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 03:01:45 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'] 03:01:45 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 03:01:46 INFO - (blobuploader) - INFO - Open directory for files ... 03:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:01:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:47 INFO - (blobuploader) - INFO - Done attempting. 03:01:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:01:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:01:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:01:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:01:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:01:47 INFO - (blobuploader) - INFO - Done attempting. 03:01:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:01:47 INFO - Return code: 0 03:01:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:01:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:01:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b23990cc37866874fe13c7c5e95a155e0009682da3e51ad50488766d4f23a6a4e4f207594b86c59ff800f4184f84874d0d482de68258510490d28103e4b91849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03cbd75fc1d7c6e5d8175908a1e5acdb2d37d537b016bd6d66edeb2b64a6af4b5c6b7b400564766b2bf7a6922e39f9e8c476d7c2519789e8809f2b998c49d9ca"} 03:01:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:01:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:01:47 INFO - Contents: 03:01:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b23990cc37866874fe13c7c5e95a155e0009682da3e51ad50488766d4f23a6a4e4f207594b86c59ff800f4184f84874d0d482de68258510490d28103e4b91849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03cbd75fc1d7c6e5d8175908a1e5acdb2d37d537b016bd6d66edeb2b64a6af4b5c6b7b400564766b2bf7a6922e39f9e8c476d7c2519789e8809f2b998c49d9ca"} 03:01:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:01:47 INFO - Copying logs to upload dir... 03:01:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:01:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.433043 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-21 03:01:47.973946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 03:01:47.978278) ========= 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=6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676 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/b23990cc37866874fe13c7c5e95a155e0009682da3e51ad50488766d4f23a6a4e4f207594b86c59ff800f4184f84874d0d482de68258510490d28103e4b91849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03cbd75fc1d7c6e5d8175908a1e5acdb2d37d537b016bd6d66edeb2b64a6af4b5c6b7b400564766b2bf7a6922e39f9e8c476d7c2519789e8809f2b998c49d9ca"} build_url:https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011472 build_url: 'https://queue.taskcluster.net/v1/task/WFfm4lZmTJG9Sx_ZmjX7mA/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/b23990cc37866874fe13c7c5e95a155e0009682da3e51ad50488766d4f23a6a4e4f207594b86c59ff800f4184f84874d0d482de68258510490d28103e4b91849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03cbd75fc1d7c6e5d8175908a1e5acdb2d37d537b016bd6d66edeb2b64a6af4b5c6b7b400564766b2bf7a6922e39f9e8c476d7c2519789e8809f2b998c49d9ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 03:01:48.003819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 03:01:48.004162) ========= 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=6dbc10da6d83fee962c624be000001a8-1463823496.461473-244546676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 03:01:48.086694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 03:01:48.087039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 03:01:48.087947) ========= ========= Total master_lag: 0.18 =========