builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1465211057.31 results: success (0) buildid: 20160606010529 builduid: 78750d9664274d05bee96204469a3a74 revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:17.308358) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:17.308907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:17.309195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:17.324336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:17.324748) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 04:04:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-06-06 04:04:18 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:17.461099) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:17.461721) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017304 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:17.512747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 04:04:17.513111) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --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 d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --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=6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 04:04:18,654 truncating revision to first 12 chars 2016-06-06 04:04:18,654 Setting DEBUG logging. 2016-06-06 04:04:18,654 attempt 1/10 2016-06-06 04:04:18,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d8adb38dd576?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 04:04:19,766 unpacking tar archive at: mozilla-aurora-d8adb38dd576/testing/mozharness/ program finished with exit code 0 elapsedTime=1.434214 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 04:04:18.961132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:18.961504) ========= script_repo_revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:18.961986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:18.962295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 04:04:18.972030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-06 04:04:18.972480) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:04:20 INFO - MultiFileLogger online at 20160606 04:04:20 in /builds/slave/test 04:04:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:04:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:04:20 INFO - {'append_to_log': False, 04:04:20 INFO - 'base_work_dir': '/builds/slave/test', 04:04:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:04:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:04:20 INFO - 'branch': 'Mozilla-Aurora', 04:04:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:20 INFO - 'config_files': ('talos/linux_config.py',), 04:04:20 INFO - 'default_actions': ('clobber', 04:04:20 INFO - 'read-buildbot-config', 04:04:20 INFO - 'download-and-extract', 04:04:20 INFO - 'populate-webroot', 04:04:20 INFO - 'create-virtualenv', 04:04:20 INFO - 'install', 04:04:20 INFO - 'run-tests'), 04:04:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:20 INFO - 'download_minidump_stackwalk': True, 04:04:20 INFO - 'download_symbols': 'ondemand', 04:04:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:20 INFO - 'installer_path': 'installer.exe', 04:04:20 INFO - 'log_level': 'info', 04:04:20 INFO - 'log_name': 'talos', 04:04:20 INFO - 'log_to_console': True, 04:04:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:04:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:04:20 INFO - 'opt_config_files': (), 04:04:20 INFO - 'pip_index': False, 04:04:20 INFO - 'sps_profile': False, 04:04:20 INFO - 'sps_profile_interval': 0, 04:04:20 INFO - 'suite': 'dromaeojs-e10s', 04:04:20 INFO - 'system_bits': '32', 04:04:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:20 INFO - 'title': 'talos-linux64-ix-023', 04:04:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:20 INFO - 'use_talos_json': True, 04:04:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:04:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:20 INFO - 'work_dir': 'build'} 04:04:20 INFO - ##### 04:04:20 INFO - ##### Running clobber step. 04:04:20 INFO - ##### 04:04:20 INFO - Running pre-action listener: _resource_record_pre_action 04:04:20 INFO - Running main action method: clobber 04:04:20 INFO - rmtree: /builds/slave/test/build 04:04:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:04:20 INFO - Running post-action listener: _resource_record_post_action 04:04:20 INFO - ##### 04:04:20 INFO - ##### Running read-buildbot-config step. 04:04:20 INFO - ##### 04:04:20 INFO - Running pre-action listener: _resource_record_pre_action 04:04:20 INFO - Running main action method: read_buildbot_config 04:04:20 INFO - Using buildbot properties: 04:04:20 INFO - { 04:04:20 INFO - "project": "", 04:04:20 INFO - "product": "firefox", 04:04:20 INFO - "script_repo_revision": "production", 04:04:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:04:20 INFO - "repository": "", 04:04:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:04:20 INFO - "buildid": "20160606010529", 04:04:20 INFO - "pgo_build": "True", 04:04:20 INFO - "basedir": "/builds/slave/test", 04:04:20 INFO - "buildnumber": 387, 04:04:20 INFO - "slavename": "talos-linux64-ix-023", 04:04:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:04:20 INFO - "platform": "ubuntu64_hw", 04:04:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:04:20 INFO - "branch": "mozilla-aurora", 04:04:20 INFO - "repo_path": "releases/mozilla-aurora", 04:04:20 INFO - "revision": "d8adb38dd576398dacbfb96d2c247f8e0158bdf1", 04:04:20 INFO - "stage_platform": "linux64-pgo", 04:04:20 INFO - "builduid": "78750d9664274d05bee96204469a3a74", 04:04:20 INFO - "slavebuilddir": "test" 04:04:20 INFO - } 04:04:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:04:20 INFO - Running post-action listener: _resource_record_post_action 04:04:20 INFO - ##### 04:04:20 INFO - ##### Running download-and-extract step. 04:04:20 INFO - ##### 04:04:20 INFO - Running pre-action listener: _resource_record_pre_action 04:04:20 INFO - Running main action method: download_and_extract 04:04:20 INFO - mkdir: /builds/slave/test/build/tests 04:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:20 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:21 INFO - Downloaded 1361 bytes. 04:04:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:04:21 INFO - Using the following test package requirements: 04:04:21 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:04:21 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:04:21 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:04:21 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:21 INFO - u'jsshell-linux-x86_64.zip'], 04:04:21 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:04:21 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:04:21 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:04:21 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:04:21 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:04:21 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:04:21 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:04:21 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')]} 04:04:21 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:04:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:04:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:04:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:22 INFO - Downloaded 24177411 bytes. 04:04:22 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'] 04:04:22 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 04:04:23 INFO - Return code: 0 04:04:23 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 04:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:23 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:24 INFO - Downloaded 24177411 bytes. 04:04:24 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'] 04:04:24 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 04:04:26 INFO - Return code: 0 04:04: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')]} 04:04:26 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:27 INFO - Downloaded 10840145 bytes. 04:04:27 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'] 04:04:27 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 04:04:27 INFO - Return code: 0 04:04:27 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')]} 04:04:27 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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 04:04:29 INFO - Downloaded 62805945 bytes. 04:04:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:04:29 INFO - mkdir: /builds/slave/test/properties 04:04:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:04:29 INFO - Writing to file /builds/slave/test/properties/build_url 04:04:29 INFO - Contents: 04:04:29 INFO - build_url:https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:04:29 INFO - Running post-action listener: _resource_record_post_action 04:04:29 INFO - Running post-action listener: set_extra_try_arguments 04:04:29 INFO - ##### 04:04:29 INFO - ##### Running populate-webroot step. 04:04:29 INFO - ##### 04:04:29 INFO - Running pre-action listener: _resource_record_pre_action 04:04:29 INFO - Running main action method: populate_webroot 04:04:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:04:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:04:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:04:29 INFO - '--tppagecycles', 04:04:29 INFO - '7'], 04:04:29 INFO - 'tests': ['tsvgm']}}, 04:04:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:04:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:04:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:04:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:04:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:29 INFO - 'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:29 INFO - 'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['damp', 'tps']}, 04:04:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:29 INFO - 'tests': ['damp', 'tps']}, 04:04:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['dromaeo_dom']}, 04:04:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:04:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['a11yr', 04:04:29 INFO - 'ts_paint', 04:04:29 INFO - 'tpaint', 04:04:29 INFO - 'sessionrestore', 04:04:29 INFO - 'sessionrestore_no_auto_restore', 04:04:29 INFO - 'tabpaint']}, 04:04:29 INFO - 'other-e10s': {'tests': ['a11yr', 04:04:29 INFO - 'ts_paint', 04:04:29 INFO - 'tpaint', 04:04:29 INFO - 'sessionrestore', 04:04:29 INFO - 'sessionrestore_no_auto_restore', 04:04:29 INFO - 'tabpaint']}, 04:04:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:04:29 INFO - 'ts_paint', 04:04:29 INFO - 'tpaint', 04:04:29 INFO - 'sessionrestore', 04:04:29 INFO - 'sessionrestore_no_auto_restore', 04:04:29 INFO - 'tabpaint']}, 04:04:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:04:29 INFO - 'ts_paint', 04:04:29 INFO - 'tpaint', 04:04:29 INFO - 'sessionrestore', 04:04:29 INFO - 'sessionrestore_no_auto_restore', 04:04:29 INFO - 'tabpaint']}, 04:04:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['a11yr', 04:04:29 INFO - 'ts_paint', 04:04:29 INFO - 'tpaint', 04:04:29 INFO - 'sessionrestore', 04:04:29 INFO - 'sessionrestore_no_auto_restore', 04:04:29 INFO - 'tabpaint']}, 04:04:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['a11yr', 04:04:29 INFO - 'ts_paint', 04:04:29 INFO - 'tpaint', 04:04:29 INFO - 'sessionrestore', 04:04:29 INFO - 'sessionrestore_no_auto_restore', 04:04:29 INFO - 'tabpaint']}, 04:04:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['tsvgx', 04:04:29 INFO - 'tsvgr_opacity', 04:04:29 INFO - 'tart', 04:04:29 INFO - 'tscrollx', 04:04:29 INFO - 'cart']}, 04:04:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:04:29 INFO - 'tsvgr_opacity', 04:04:29 INFO - 'tart', 04:04:29 INFO - 'tscrollx', 04:04:29 INFO - 'cart']}, 04:04:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:29 INFO - 'talos_options': ['--disable-e10s'], 04:04:29 INFO - 'tests': ['tp5o']}, 04:04:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:29 INFO - 'tests': ['tp5o']}, 04:04:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:29 INFO - 'talos_options': ['--disable-e10s', 04:04:29 INFO - '--xperf_path', 04:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:29 INFO - 'tests': ['tp5n']}, 04:04:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:29 INFO - 'talos_options': ['--xperf_path', 04:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:29 INFO - 'tests': ['tp5n']}}, 04:04:29 INFO - 'talos.zip': {'path': '', 04:04:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:04:29 INFO - Running post-action listener: _resource_record_post_action 04:04:29 INFO - ##### 04:04:29 INFO - ##### Running create-virtualenv step. 04:04:29 INFO - ##### 04:04:29 INFO - Running pre-action listener: _resource_record_pre_action 04:04:29 INFO - Running main action method: create_virtualenv 04:04:29 INFO - Creating virtualenv /builds/slave/test/build/venv 04:04:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:04:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:04:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:04:29 INFO - Using real prefix '/usr' 04:04:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:04:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:04:32 INFO - Installing pip.................done. 04:04:32 INFO - Return code: 0 04:04:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63af40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', '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 04:04:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:04:32 INFO - Using env: {'DISPLAY': ':0', 04:04:32 INFO - 'HOME': '/home/cltbld', 04:04:32 INFO - 'LANG': 'en_US.UTF-8', 04:04:32 INFO - 'LANGUAGE': 'en_US:en', 04:04:32 INFO - 'LOGNAME': 'cltbld', 04:04:32 INFO - 'MAIL': '/var/mail/cltbld', 04:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:32 INFO - 'MOZ_NO_REMOTE': '1', 04:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:32 INFO - 'NO_EM_RESTART': '1', 04:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:32 INFO - 'PWD': '/builds/slave/test', 04:04:32 INFO - 'SHELL': '/bin/bash', 04:04:32 INFO - 'SHLVL': '1', 04:04:32 INFO - 'TERM': 'linux', 04:04:32 INFO - 'TMOUT': '86400', 04:04:32 INFO - 'USER': 'cltbld', 04:04:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:32 INFO - '_': '/tools/buildbot/bin/python'} 04:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:32 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 04:04:32 INFO - Cleaning up... 04:04:32 INFO - Return code: 0 04:04:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff63af40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', '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 04:04:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:04:32 INFO - Using env: {'DISPLAY': ':0', 04:04:32 INFO - 'HOME': '/home/cltbld', 04:04:32 INFO - 'LANG': 'en_US.UTF-8', 04:04:32 INFO - 'LANGUAGE': 'en_US:en', 04:04:32 INFO - 'LOGNAME': 'cltbld', 04:04:32 INFO - 'MAIL': '/var/mail/cltbld', 04:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:32 INFO - 'MOZ_NO_REMOTE': '1', 04:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:32 INFO - 'NO_EM_RESTART': '1', 04:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:32 INFO - 'PWD': '/builds/slave/test', 04:04:32 INFO - 'SHELL': '/bin/bash', 04:04:32 INFO - 'SHLVL': '1', 04:04:32 INFO - 'TERM': 'linux', 04:04:32 INFO - 'TMOUT': '86400', 04:04:32 INFO - 'USER': 'cltbld', 04:04:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:32 INFO - '_': '/tools/buildbot/bin/python'} 04:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:32 INFO - Downloading/unpacking psutil>=0.7.1 04:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:04:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:34 INFO - Installing collected packages: psutil 04:04:34 INFO - Running setup.py install for psutil 04:04:34 INFO - building 'psutil._psutil_linux' extension 04:04:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:04:35 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 04:04:35 INFO - building 'psutil._psutil_posix' extension 04:04:35 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 04:04:35 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 04:04:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:35 INFO - Successfully installed psutil 04:04:35 INFO - Cleaning up... 04:04:35 INFO - Return code: 0 04:04:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:04:35 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')]} 04:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:35 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')]} 04:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:35 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 0x7ff63af40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', '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 04:04:35 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 04:04:35 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 04:04:35 INFO - Using env: {'DISPLAY': ':0', 04:04:35 INFO - 'HOME': '/home/cltbld', 04:04:35 INFO - 'LANG': 'en_US.UTF-8', 04:04:35 INFO - 'LANGUAGE': 'en_US:en', 04:04:35 INFO - 'LOGNAME': 'cltbld', 04:04:35 INFO - 'MAIL': '/var/mail/cltbld', 04:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:35 INFO - 'MOZ_NO_REMOTE': '1', 04:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:35 INFO - 'NO_EM_RESTART': '1', 04:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:35 INFO - 'PWD': '/builds/slave/test', 04:04:35 INFO - 'SHELL': '/bin/bash', 04:04:35 INFO - 'SHLVL': '1', 04:04:35 INFO - 'TERM': 'linux', 04:04:35 INFO - 'TMOUT': '86400', 04:04:35 INFO - 'USER': 'cltbld', 04:04:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:35 INFO - '_': '/tools/buildbot/bin/python'} 04:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:04:37 INFO - Installing collected packages: mozsystemmonitor 04:04:37 INFO - Running setup.py install for mozsystemmonitor 04:04:37 INFO - Successfully installed mozsystemmonitor 04:04:37 INFO - Cleaning up... 04:04:37 INFO - Return code: 0 04:04:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:04: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')]} 04:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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')]} 04:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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', '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 0x7ff63af40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', '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 04:04: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:04: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 blobuploader==1.2.4 04:04:37 INFO - Using env: {'DISPLAY': ':0', 04:04:37 INFO - 'HOME': '/home/cltbld', 04:04:37 INFO - 'LANG': 'en_US.UTF-8', 04:04:37 INFO - 'LANGUAGE': 'en_US:en', 04:04:37 INFO - 'LOGNAME': 'cltbld', 04:04:37 INFO - 'MAIL': '/var/mail/cltbld', 04:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:37 INFO - 'MOZ_NO_REMOTE': '1', 04:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:37 INFO - 'NO_EM_RESTART': '1', 04:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:37 INFO - 'PWD': '/builds/slave/test', 04:04:37 INFO - 'SHELL': '/bin/bash', 04:04:37 INFO - 'SHLVL': '1', 04:04:37 INFO - 'TERM': 'linux', 04:04:37 INFO - 'TMOUT': '86400', 04:04:37 INFO - 'USER': 'cltbld', 04:04:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:37 INFO - '_': '/tools/buildbot/bin/python'} 04:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:04:38 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 04:04:38 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 04:04:38 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 04:04:38 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 04:04:38 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 04:04:38 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 04:04:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:04:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:04:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:04:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:40 INFO - Downloading docopt-0.6.1.tar.gz 04:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:04:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:04:40 INFO - Running setup.py install for blobuploader 04:04:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:04:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:04:40 INFO - Running setup.py install for requests 04:04:41 INFO - Running setup.py install for docopt 04:04:41 INFO - Successfully installed blobuploader requests docopt 04:04:41 INFO - Cleaning up... 04:04:41 INFO - Return code: 0 04:04:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:41 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')]} 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:41 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')]} 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:41 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 0x7ff63af40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', '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 04:04:41 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 04:04:41 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 04:04:41 INFO - Using env: {'DISPLAY': ':0', 04:04:41 INFO - 'HOME': '/home/cltbld', 04:04:41 INFO - 'LANG': 'en_US.UTF-8', 04:04:41 INFO - 'LANGUAGE': 'en_US:en', 04:04:41 INFO - 'LOGNAME': 'cltbld', 04:04:41 INFO - 'MAIL': '/var/mail/cltbld', 04:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:41 INFO - 'MOZ_NO_REMOTE': '1', 04:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:41 INFO - 'NO_EM_RESTART': '1', 04:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:41 INFO - 'PWD': '/builds/slave/test', 04:04:41 INFO - 'SHELL': '/bin/bash', 04:04:41 INFO - 'SHLVL': '1', 04:04:41 INFO - 'TERM': 'linux', 04:04:41 INFO - 'TMOUT': '86400', 04:04:41 INFO - 'USER': 'cltbld', 04:04:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:41 INFO - '_': '/tools/buildbot/bin/python'} 04:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:41 INFO - Running setup.py (path:/tmp/pip-sUlR34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:41 INFO - Running setup.py (path:/tmp/pip-izcJsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:41 INFO - Running setup.py (path:/tmp/pip-HP3Uwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:41 INFO - Running setup.py (path:/tmp/pip-NvCFah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:41 INFO - Running setup.py (path:/tmp/pip-5kqbei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:41 INFO - Running setup.py (path:/tmp/pip-xvqpR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:41 INFO - Running setup.py (path:/tmp/pip-tGu_6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:42 INFO - Running setup.py (path:/tmp/pip-skoobE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:42 INFO - Running setup.py (path:/tmp/pip-acqVG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:42 INFO - Running setup.py (path:/tmp/pip-2n0cZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:42 INFO - Running setup.py (path:/tmp/pip-NcJjIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:42 INFO - Running setup.py (path:/tmp/pip-N7tO9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:42 INFO - Running setup.py (path:/tmp/pip-wHzuis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:42 INFO - Running setup.py (path:/tmp/pip-0OdOdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:42 INFO - Running setup.py (path:/tmp/pip-6X9XD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:42 INFO - Running setup.py (path:/tmp/pip-XRJ0O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:42 INFO - Running setup.py (path:/tmp/pip-snMMp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:04:42 INFO - Running setup.py install for manifestparser 04:04:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:04:42 INFO - Running setup.py install for mozcrash 04:04:42 INFO - Running setup.py install for mozdebug 04:04:43 INFO - Running setup.py install for mozdevice 04:04:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Running setup.py install for mozfile 04:04:43 INFO - Running setup.py install for mozhttpd 04:04:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Running setup.py install for mozinfo 04:04:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Running setup.py install for mozInstall 04:04:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Running setup.py install for mozleak 04:04:43 INFO - Running setup.py install for mozlog 04:04:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Running setup.py install for moznetwork 04:04:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:04:43 INFO - Running setup.py install for mozprocess 04:04:43 INFO - Running setup.py install for mozprofile 04:04:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:04:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:04:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:04:44 INFO - Running setup.py install for mozrunner 04:04:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:04:44 INFO - Running setup.py install for mozscreenshot 04:04:44 INFO - Running setup.py install for moztest 04:04:44 INFO - Running setup.py install for mozversion 04:04:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:04:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:04:44 INFO - Cleaning up... 04:04:44 INFO - Return code: 0 04:04:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:44 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 0x7ff63af40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', '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 04:04:44 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 04:04:44 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 04:04:44 INFO - Using env: {'DISPLAY': ':0', 04:04:44 INFO - 'HOME': '/home/cltbld', 04:04:44 INFO - 'LANG': 'en_US.UTF-8', 04:04:44 INFO - 'LANGUAGE': 'en_US:en', 04:04:44 INFO - 'LOGNAME': 'cltbld', 04:04:44 INFO - 'MAIL': '/var/mail/cltbld', 04:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:44 INFO - 'MOZ_NO_REMOTE': '1', 04:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:44 INFO - 'NO_EM_RESTART': '1', 04:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:44 INFO - 'PWD': '/builds/slave/test', 04:04:44 INFO - 'SHELL': '/bin/bash', 04:04:44 INFO - 'SHLVL': '1', 04:04:44 INFO - 'TERM': 'linux', 04:04:44 INFO - 'TMOUT': '86400', 04:04:44 INFO - 'USER': 'cltbld', 04:04:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:44 INFO - '_': '/tools/buildbot/bin/python'} 04:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:44 INFO - Running setup.py (path:/tmp/pip-232m4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:44 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)) 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:44 INFO - Running setup.py (path:/tmp/pip-16CfYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:44 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)) 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:44 INFO - Running setup.py (path:/tmp/pip-NpmzSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:44 INFO - Running setup.py (path:/tmp/pip-kzS3CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:45 INFO - Running setup.py (path:/tmp/pip-4SuKdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:45 INFO - Running setup.py (path:/tmp/pip-YGnn4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:45 INFO - Running setup.py (path:/tmp/pip-WiwvQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:45 INFO - Running setup.py (path:/tmp/pip-W2H3fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:45 INFO - Running setup.py (path:/tmp/pip-f_1R3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:45 INFO - Running setup.py (path:/tmp/pip-K3iESw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:45 INFO - Running setup.py (path:/tmp/pip-SNyjpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:45 INFO - Running setup.py (path:/tmp/pip-t3jSlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:45 INFO - Running setup.py (path:/tmp/pip-eplxak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:45 INFO - Running setup.py (path:/tmp/pip-RxNzns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:45 INFO - Running setup.py (path:/tmp/pip-R7g7d1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:45 INFO - Running setup.py (path:/tmp/pip-1uP0rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:45 INFO - Running setup.py (path:/tmp/pip-Pwg2JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:04:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:47 INFO - Downloading blessings-1.6.tar.gz 04:04:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:04:47 INFO - Installing collected packages: blessings 04:04:47 INFO - Running setup.py install for blessings 04:04:48 INFO - Successfully installed blessings 04:04:48 INFO - Cleaning up... 04:04:48 INFO - Return code: 0 04:04:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:04:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:48 INFO - Reading from file tmpfile_stdout 04:04:48 INFO - Current package versions: 04:04:48 INFO - argparse == 1.2.1 04:04:48 INFO - blessings == 1.6 04:04:48 INFO - blobuploader == 1.2.4 04:04:48 INFO - docopt == 0.6.1 04:04:48 INFO - manifestparser == 1.1 04:04:48 INFO - mozInstall == 1.12 04:04:48 INFO - mozcrash == 0.17 04:04:48 INFO - mozdebug == 0.1 04:04:48 INFO - mozdevice == 0.48 04:04:48 INFO - mozfile == 1.2 04:04:48 INFO - mozhttpd == 0.7 04:04:48 INFO - mozinfo == 0.9 04:04:48 INFO - mozleak == 0.1 04:04:48 INFO - mozlog == 3.1 04:04:48 INFO - moznetwork == 0.27 04:04:48 INFO - mozprocess == 0.22 04:04:48 INFO - mozprofile == 0.28 04:04:48 INFO - mozrunner == 6.11 04:04:48 INFO - mozscreenshot == 0.1 04:04:48 INFO - mozsystemmonitor == 0.0 04:04:48 INFO - moztest == 0.7 04:04:48 INFO - mozversion == 1.4 04:04:48 INFO - psutil == 3.1.1 04:04:48 INFO - requests == 1.2.3 04:04:48 INFO - wsgiref == 0.1.2 04:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:48 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')]} 04:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:48 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')]} 04:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:48 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 0x7ff63af40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', '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 04:04:48 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 04:04:48 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 04:04:48 INFO - Using env: {'DISPLAY': ':0', 04:04:48 INFO - 'HOME': '/home/cltbld', 04:04:48 INFO - 'LANG': 'en_US.UTF-8', 04:04:48 INFO - 'LANGUAGE': 'en_US:en', 04:04:48 INFO - 'LOGNAME': 'cltbld', 04:04:48 INFO - 'MAIL': '/var/mail/cltbld', 04:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:48 INFO - 'MOZ_NO_REMOTE': '1', 04:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:48 INFO - 'NO_EM_RESTART': '1', 04:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:48 INFO - 'PWD': '/builds/slave/test', 04:04:48 INFO - 'SHELL': '/bin/bash', 04:04:48 INFO - 'SHLVL': '1', 04:04:48 INFO - 'TERM': 'linux', 04:04:48 INFO - 'TMOUT': '86400', 04:04:48 INFO - 'USER': 'cltbld', 04:04:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:48 INFO - '_': '/tools/buildbot/bin/python'} 04:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:48 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)) 04:04:48 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)) 04:04:48 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)) 04:04:48 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)) 04:04:48 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)) 04:04:48 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)) 04:04:48 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)) 04:04:48 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)) 04:04:48 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)) 04:04:48 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)) 04:04:48 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)) 04:04:48 INFO - Cleaning up... 04:04:48 INFO - Return code: 0 04:04:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:04:48 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')]} 04:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:48 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')]} 04:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:48 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 0x7ff63af40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', '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 04:04:48 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 04:04:48 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 04:04:48 INFO - Using env: {'DISPLAY': ':0', 04:04:48 INFO - 'HOME': '/home/cltbld', 04:04:48 INFO - 'LANG': 'en_US.UTF-8', 04:04:48 INFO - 'LANGUAGE': 'en_US:en', 04:04:48 INFO - 'LOGNAME': 'cltbld', 04:04:48 INFO - 'MAIL': '/var/mail/cltbld', 04:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:48 INFO - 'MOZ_NO_REMOTE': '1', 04:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:48 INFO - 'NO_EM_RESTART': '1', 04:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:48 INFO - 'PWD': '/builds/slave/test', 04:04:48 INFO - 'SHELL': '/bin/bash', 04:04:48 INFO - 'SHLVL': '1', 04:04:48 INFO - 'TERM': 'linux', 04:04:48 INFO - 'TMOUT': '86400', 04:04:48 INFO - 'USER': 'cltbld', 04:04:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:48 INFO - '_': '/tools/buildbot/bin/python'} 04:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:48 INFO - Downloading/unpacking jsonschema 04:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:04:50 INFO - Downloading/unpacking functools32 (from jsonschema) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:04:50 INFO - warning: no files found matching '*.txt' 04:04:50 INFO - no previously-included directories found matching 'build' 04:04:50 INFO - no previously-included directories found matching 'dist' 04:04:50 INFO - no previously-included directories found matching '.git*' 04:04:50 INFO - Installing collected packages: jsonschema, functools32 04:04:50 INFO - Running setup.py install for functools32 04:04:51 INFO - warning: no files found matching '*.txt' 04:04:51 INFO - no previously-included directories found matching 'build' 04:04:51 INFO - no previously-included directories found matching 'dist' 04:04:51 INFO - no previously-included directories found matching '.git*' 04:04:51 INFO - Successfully installed jsonschema functools32 04:04:51 INFO - Cleaning up... 04:04:51 INFO - Return code: 0 04:04:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:04:51 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')]} 04:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:51 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')]} 04:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:51 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 0x7ff63af40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27cd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', '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 04:04:51 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 04:04:51 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 04:04:51 INFO - Using env: {'DISPLAY': ':0', 04:04:51 INFO - 'HOME': '/home/cltbld', 04:04:51 INFO - 'LANG': 'en_US.UTF-8', 04:04:51 INFO - 'LANGUAGE': 'en_US:en', 04:04:51 INFO - 'LOGNAME': 'cltbld', 04:04:51 INFO - 'MAIL': '/var/mail/cltbld', 04:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:51 INFO - 'MOZ_NO_REMOTE': '1', 04:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:51 INFO - 'NO_EM_RESTART': '1', 04:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:51 INFO - 'PWD': '/builds/slave/test', 04:04:51 INFO - 'SHELL': '/bin/bash', 04:04:51 INFO - 'SHLVL': '1', 04:04:51 INFO - 'TERM': 'linux', 04:04:51 INFO - 'TMOUT': '86400', 04:04:51 INFO - 'USER': 'cltbld', 04:04:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:51 INFO - '_': '/tools/buildbot/bin/python'} 04:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:51 INFO - Downloading/unpacking flake8 04:04:51 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 04:04:51 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 04:04:51 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 04:04:51 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 04:04:51 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 04:04:51 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 04:04:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:04:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:04:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:53 INFO - no previously-included directories found matching 'docs/_build' 04:04:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:04:53 INFO - Running setup.py install for pep8 04:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:54 INFO - no previously-included directories found matching 'docs/_build' 04:04:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:04:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:04:54 INFO - Cleaning up... 04:04:54 INFO - Return code: 0 04:04:54 INFO - Running post-action listener: _resource_record_post_action 04:04:54 INFO - Running post-action listener: _start_resource_monitoring 04:04:54 INFO - Starting resource monitoring. 04:04:54 INFO - ##### 04:04:54 INFO - ##### Running install step. 04:04:54 INFO - ##### 04:04:54 INFO - Running pre-action listener: _resource_record_pre_action 04:04:54 INFO - Running main action method: install 04:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:54 INFO - Reading from file tmpfile_stdout 04:04:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:04:54 INFO - Reading from file tmpfile_stdout 04:04:54 INFO - Output received: 04:04:54 INFO - Usage: mozinstall [options] installer 04:04:54 INFO - Options: 04:04:54 INFO - -h, --help show this help message and exit 04:04:54 INFO - -d DEST, --destination=DEST 04:04:54 INFO - Directory to install application into. [default: 04:04:54 INFO - "/builds/slave/test"] 04:04:54 INFO - --app=APP Application being installed. [default: firefox] 04:04:54 INFO - mkdir: /builds/slave/test/build/application 04:04:54 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'] 04:04:54 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 04:05:10 INFO - Reading from file tmpfile_stdout 04:05:10 INFO - Output received: 04:05:10 INFO - /builds/slave/test/build/application/firefox/firefox 04:05:10 INFO - Running post-action listener: _resource_record_post_action 04:05:10 INFO - ##### 04:05:10 INFO - ##### Running run-tests step. 04:05:10 INFO - ##### 04:05:10 INFO - Running pre-action listener: _resource_record_pre_action 04:05:10 INFO - Running main action method: run_tests 04:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:05:10 INFO - Python 2.7.3 04:05:10 INFO - Return code: 0 04:05:10 INFO - grabbing minidump binary from tooltool 04:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285c410>, '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 0x285d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:05:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:05:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:05:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:10 INFO - Return code: 0 04:05:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:05:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:05:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:05:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:05:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:05:11 INFO - Return code: 0 04:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:05:11 INFO - Using env: {'DISPLAY': ':0', 04:05:11 INFO - 'HOME': '/home/cltbld', 04:05:11 INFO - 'LANG': 'en_US.UTF-8', 04:05:11 INFO - 'LANGUAGE': 'en_US:en', 04:05:11 INFO - 'LOGNAME': 'cltbld', 04:05:11 INFO - 'MAIL': '/var/mail/cltbld', 04:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:11 INFO - 'MOZ_NO_REMOTE': '1', 04:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:11 INFO - 'NO_EM_RESTART': '1', 04:05:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:11 INFO - 'PWD': '/builds/slave/test', 04:05:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:05:11 INFO - 'SHELL': '/bin/bash', 04:05:11 INFO - 'SHLVL': '1', 04:05:11 INFO - 'TERM': 'linux', 04:05:11 INFO - 'TMOUT': '86400', 04:05:11 INFO - 'USER': 'cltbld', 04:05:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744', 04:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:11 INFO - '_': '/tools/buildbot/bin/python'} 04:05:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:05:11 INFO - mozversion application_buildid: 20160606010529 04:05:11 INFO - mozversion application_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 04:05:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:05:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:11 INFO - mozversion application_name: Firefox 04:05:11 INFO - mozversion application_remotingname: firefox-dev 04:05:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:05:11 INFO - mozversion application_vendor: Mozilla 04:05:11 INFO - mozversion application_version: 48.0a2 04:05:11 INFO - mozversion platform_buildid: 20160606010529 04:05:11 INFO - mozversion platform_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 04:05:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:05:11 INFO - mozversion platform_version: 48.0a2 04:05:11 INFO - using testdate: 1465211111 04:05:11 INFO - actual date: 1465211111 04:05:11 INFO - starting webserver on 'localhost:46843' 04:05:11 INFO - SUITE-START | Running 2 tests 04:05:11 INFO - TEST-START | dromaeo_css 04:05:11 INFO - operating with platform_type : linux_ 04:05:11 INFO - Initialising browser for dromaeo_css test... 04:05:11 INFO - TEST-INFO | started process 11138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRGTVK/profile http://localhost:46843/getInfo.html) 04:05:14 INFO - PROCESS | 11138 | 04:05:14 INFO - PROCESS | 11138 | (process:11217): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:05:15 INFO - PROCESS | 11138 | __metrics Screen width/height:1600/1200 04:05:15 INFO - PROCESS | 11138 | colorDepth:24 04:05:15 INFO - PROCESS | 11138 | Browser inner width/height: 1024/697 04:05:15 INFO - PROCESS | 11138 | __metrics 04:05:16 ERROR - PROCESS | 11138 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 04:05:17 INFO - TEST-INFO | 11138: exit 0 04:05:17 INFO - Browser initialized. 04:05:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:05:17 INFO - TEST-INFO | started process 11268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRGTVK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:18 INFO - PROCESS | 11268 | 04:05:18 INFO - PROCESS | 11268 | (process:11335): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:05:28 INFO - PROCESS | 11268 | RSS: Main: 152117248 04:05:28 INFO - PROCESS | 11268 | 04:06:18 INFO - PROCESS | 11268 | 1465211178507 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] 04:08:26 INFO - PROCESS | 11268 | Cycle 1(1): loaded http://localhost:46843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46843/tests/dromaeo/cssquery-ext.html) 04:08:27 INFO - PROCESS | 11268 | RSS: Main: 155516928 04:08:27 INFO - PROCESS | 11268 | 04:11:29 INFO - PROCESS | 11268 | Cycle 1(1): loaded http://localhost:46843/tests/dromaeo/cssquery-ext.html (next: http://localhost:46843/tests/dromaeo/cssquery-jquery.html) 04:11:29 INFO - PROCESS | 11268 | RSS: Main: 153952256 04:11:29 INFO - PROCESS | 11268 | 04:14:31 INFO - PROCESS | 11268 | Cycle 1(1): loaded http://localhost:46843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46843/tests/dromaeo/cssquery-mootools.html) 04:14:32 INFO - PROCESS | 11268 | RSS: Main: 153833472 04:14:32 INFO - PROCESS | 11268 | 04:17:33 INFO - PROCESS | 11268 | Cycle 1(1): loaded http://localhost:46843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46843/tests/dromaeo/cssquery-prototype.html) 04:17:34 INFO - PROCESS | 11268 | RSS: Main: 153255936 04:17:34 INFO - PROCESS | 11268 | 04:20:36 INFO - PROCESS | 11268 | Cycle 1(1): loaded http://localhost:46843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46843/tests/dromaeo/cssquery-yui.html) 04:20:37 INFO - PROCESS | 11268 | RSS: Main: 154669056 04:20:37 INFO - PROCESS | 11268 | 04:23:39 INFO - PROCESS | 11268 | Cycle 1(1): loaded http://localhost:46843/tests/dromaeo/cssquery-yui.html (next: http://localhost:46843/tests/dromaeo/cssquery-dojo.html) 04:23:39 INFO - PROCESS | 11268 | RSS: Main: 156282880 04:23:39 INFO - PROCESS | 11268 | 04:23:39 INFO - PROCESS | 11268 | __start_tp_report 04:23:39 INFO - PROCESS | 11268 | _x_x_mozilla_page_load 04:23:39 INFO - PROCESS | 11268 | _x_x_mozilla_page_load_details 04:23:39 INFO - PROCESS | 11268 | |i|pagename|runs| 04:23:39 INFO - PROCESS | 11268 | |0;dojo.html;3398.320335932813;3423.760336776426;3443.0875817908245;3451.5512983312165;3461.532693086434;5703.914441283378;5743.54051675866;5745.9138112928285;5777.364489906107;5809.95420824252;5663.546916246701;5721.713914304279;5744.569157313197;5751.942480575193;5756.050251708463;5195.19474481455;5205.687658740488;5232.3197984262;5264.447233040533;5272.868178295555;5153.2785410042625;5251.527362537371;5253.212018197282;5343.706096164709;5368.892622147555;5178.611604129686;5246.737663116848;5253.185756207794;5267.104592219332;5271.103912334912;5262.92105618416;5275.973620131913;5276.129438642658;5279.788808447657;5281.471852814707;5135.589152867761;5180.067587834188;5220.8694782630355;5243.344581927259;5251.4223435422455;5514;5539.307586551681;5629.831105066854;5634.323881134249;5642.04085305499;6154.138420621117;6170.969145154246;6188;6199.752009919643;6207.844803879939;6001.399860014008;6239.594426362272;6248.5313601480075;6255.280642726099;6266.310705822356;5759.48164665178;5790.189373487715;5797.652140871562;5807.070868660994;5821.941780582182;6282.246130464374;6286.779962701375;6305.527085468608;6323.9683801580695;6336.112944187817;5959.642421454727;5978.940210597925;6035.034394496859;6053.182820319201;6054.939450605438;6190.288116866618;6196.504279657616;6198.659073750987;6217.937820621826;6225.501959843202;6081.939180608226;6166.352532983972;6177.382261773787;6184.969075154595;6195.2255968004;5969.552283578749;6141.416565426367;6165.815025549241;6189.226346706661;6201.565890387629;4563.361129441881;4573.062522182944;4581.518940511265;4589.770511474413;4607.193741095295;4121.690873184523;4127.236461254677;4131.173765246963;4137;4168.062186008124;5864.266966629171;6004.789832355934;6042.425969532887;6046.758129674852;6089.512838972872;6084.756609735649;6092.72582733778;6152.415520525543;6152.477039451607;6157.876842463125;6008.729607167688;6020.096985452217;6024.216851809237;6025.0359942409;6027.668478233739;5149.845504634867;5164.948350516447;5276.894462110737;5277.1292736698015;5326.92009619856;6445.291017988017;6468.870622587616;6500.5449618526245;6509.088727578142;6513.283538810727;6200.782972595937;6227.688615569294;6236.688165591611;6243.188385509855;6267.905981410191;6318.968405158129;6451.41937225652;6461.0954466373805;6488.286288508355;6494.967525162533;6127.403330890726;6141.355157708376;6148.538859585638;6149.200603921461;6149.938500615115;6192.071189321638;6225.252969643671;6238.313785483684;6246.094316324016;6265.686715664289;5852.063669812809;6035.215421995113;6068.605540639845;6071.332153463204;6123.4488895999575;6037.698115094316;6042.939570604413;6049.122877182872;6060.030395136757;6080.422359875804;5940.138679891478;5955.91066134017;5975.820725378246;5978.760849565969;5981.401859813984;5993.340732519332;5998.190244316961;6058.151858739868;6092.086187071975;6134.877302454015;5830.2420685310635;5834.445727655866;5838.241028666246;5844.590878638454;5856.648601083949 04:23:39 INFO - PROCESS | 11268 | |1;ext.html;622.4180391334103;662.8442316055728;673.2493270003944;679.8504329047607;751.8909758085074;33605.495917561224;39756.40365394518;40161.59838401622;40314.39528407069;40367.79816100915;42411.15177696444;42427;42607.14785704292;42639;43109.35335969963;8626.309895208367;8785.165409286108;8787.64849406023;8802.471851688888;8845.911540884605;8640.135986401372;8710.564471776386;8750.912490875106;8783.341249406289;9037.457752534869;8984.955075224614;9064.909350906506;9068.229200517964;9068.365214434993;9086.681966131187;8949.821003579924;8972.730818075468;8972.910270897306;9018.233450156744;9038.141376569249;8909.465432074096;8989.280857531381;9006.369554131214;9023.774405639846;9025;43216;43694;43757.78121109406;43765.56234437646;44038;3781.2437512497336;3880.941785873214;3905.7265991380614;3919.7256192066566;3976.1252524444576;32379.514307285408;32596.837015815006;32936.835315823264;33296.6670333296;33387.16532086693;4371.103923695635;4387;4389.604935555815;4412.0734645724115;4457.665675074382;509364;516398;520102;520218.7978120246;523507;61220;61453;61682.69158654268;61739.38260617426;61838.072428913605;69175.65412172907;70061;70472.2952770476;70581;70681.2931870685;18800.247990080516;19136.808631913504;19213.807861921483;19328.806711932702;19364.70952935707;14938.253087345589;14946.103233806007;14993.175375354242;15012.924935375253;15039.172845493604;20737.89631051835;20830;20873.89563052175;20911.163553457995;20944.476388090116;7565.167831538526;7735.49719268257;7810.804729881685;7842.333401660922;7849.960750196213;1119.1103073056938;1147.3746807989667;1179.1274456902001;1182.8876256755595;1201.8197270409335;32863.342733145684;33091.66908330934;33689;33770;33865.32269354599;1207.897328727068;1208.9214201076902;1220.2190598017276;1326.84741254755;1356.776131938239;16996.320147193972;17219;17371.401275786746;17441.825581744273;17587.032713200897;476032;502425;507107;510283;513016;56641.716791415776;56956.715216423654;57410.71294643584;57561;57578;1510.7431736604804;1521.178563575679;1523.504860920183;1523.6114790728293;1528.3198976455592;31104.844475777478;33172.00967941931;33277.66722332746;33481;33900.83049584736;53460;53932.191017135556;54004.72997634987;54087;54100.729496352265;432977;437149;441731;442700;443036;30661;30715.846420767753;30791.38417231598;30833.537496938014;31145.221369465038;47506.52493475159;48090.5190948086;48534.271985919535;48692;50680;36943.81528092342;37114.814425927696;37465.06337341479;37678.62321376751;41878;39029;39468;39605;40456.59543404528;40775.98060048522;41138.38292425556;41938.00650518263;42040.78979605083;42510.787446062575;43094.56905430905;35372;35516.467252991744;36154;36199.27601447904;36281.274374511835;28924.42151156923;29090.854545727136;29356.119316420543;29373.26566835846;29461.410771784875 04:23:39 INFO - PROCESS | 11268 | |2;jquery.html;424.6814888833374;435.22999739058946;439.87463572881734;443.4722680010789;443.4766974969536;18550.628987420245;18812.9652869092;19391.806081939176;19414.126364313604;19520.609587808234;18749.625007499875;18826.34107806227;19102.235910563562;19290.32483863065;19300.324488642902;5597.468240517144;5686.658800471964;5871.500922421578;5924.555658325643;5929.822105336847;5800.7679692812235;5926.940730592682;5942.851428714273;5946.672932988684;5983.611065280743;6007.729652165641;6011.2786465624185;6031.24609423822;6039.094135879609;6058.303295121052;5866.237389139427;6080.969595152018;6129.417705317987;6169.043798211284;6171.691415429211;5951.880962380771;5982.042873140276;5995.310539287951;6000.249968753906;6024.367441418632;22269.554608907732;22875.77124228753;23218.3034508965;24168.879155604285;24173.87913060441;2431.161249368965;2440.4264997725522;2538.695356557225;2579.8839052242506;3005.143534092795;10397;10492.79014419715;10599.47002649872;10674.306170098918;10798.73003174927;1960.6372821028156;1995.122146255643;2009.357005758158;2021.8685785424047;2035.1248962945926;80108;90221.74445638912;91438.54280728554;93436;100556.49721751417;17668.823311766973;18344.449666509758;18530.25878964853;19162.425127245926;19277;33401.49897751536;33844.32311353759;34453.310933781184;34454;34480.48279275813;10357.378557286587;10712.946435267773;10800.78398432027;10828.62099826518;11140.777184456265;9171.082891710908;9445.244380449547;9449.952750236342;9451.905480945241;9471.431714097176;9322.533873306307;9415.6704515343;9440.716778496657;9505.857412138823;9622.663206787729;3473.0915202505494;3614.98192509041;3679.742418030712;3711.832967516468;3915.9622699984525;1004.2969921055291;1082.0910435234284;1098.741795678015;1146.4726225935997;1175.1421462332546;19112.713309300372;19764.308249211495;19792.70310945337;20049.59900801976;20379.286724964553;1104.7403860092872;1140.3272069479046;1162.9360385178727;1163.5171403867469;1187.9287242765288;10961;11064.376912419915;11146.164037697205;11256.718582035515;11283.66149015531;493455;493962;501399;507923;512989;90694.54652726694;91611.54194228986;92347.53826230826;93256.53371733234;93455;1082.8592283003159;1084.7938891610568;1140.4639819284923;1149.172595731089;1161.9941900290614;17360.305587776347;17464.952102873867;17765.200565974304;17782;18013.819861801214;38008.80995595004;38451.615483845926;39264.80367598258;40131.1973760529;40278.19443611053;52144.21783673324;56486.71756641355;57231;57731;57787;8806.779830504289;8899.911000890168;8919.866202007104;9109.635614575343;9272.582733777132;9315.953420232856;11986.820197697216;12325.938370308091;12495.25028498293;12525.74948501043;10697.839532407175;10924.235303528676;11094.611688590861;11374.090072793992;11508.309501429942;10910.836337454786;11012.724681883017;11025.44872756343;11205.943970280096;11312.321260724382;11396.373199474108;11525.88474115248;11591.420428978687;11630.825537617111;11687.357195354338;8960.103989600988;8988.28093752485;9051.657594757187;9115;9215.216706580015;8627.35294852876;11577.942110289732;11906.642800715992;11909.82135267989;11960.64118076459 04:23:39 INFO - PROCESS | 11268 | |3;mootools.html;1569.5683686986076;1573.4571572807376;1743.6948534006547;1797.1463554811467;1808.5297822566145;8578.39951203416;8711.869321960176;8793.868091978626;8806.691765788191;8842.51366174861;8843.690470833522;8901.287896968242;8923.063078376774;8931.464112153275;8982.416142950704;2442.8534287942693;2468.5926822074334;2475.1708177760383;2476.554220240365;2482.056818409002;2455.1897873701637;2526.84838909666;2526.861022643754;2526.936826579341;2529.519391315653;2440.4386990992084;2447.19242649926;2488.713797913245;2496.400863792686;2505.574052411085;2431.1490978157767;2437.475942672325;2443.2914454808083;2443.5479436304163;2458.2625212436287;2446.339488338139;2448.987755061231;2458.9754102458924;2469.2098528470897;2507.0849140063747;8894.155055269739;8933.59798809055;8957.507337096456;8974.596143173507;8978.595963181608;5297.973510132425;5390.6226564140525;5428.67427954324;5438.755256013489;5452.073147564884;3479.425894727367;3480.7911525308564;3537.398642230827;3560.1455650643916;3561.519194908706;1178.5816035307514;1190.1133655426763;1201.2192075151222;1210.2435977514053;1223;12599.811002834966;12603.747925041447;12642.2414655121;12707.174033687874;12718.236905785683;4704.129735998851;4754.786034628381;4755.239161734106;4777.880552986203;4789.449213340441;10092.798144037079;10109.898901011044;10119.24105692076;10120.342177758423;10140.645077422254;5467.781288748485;5470.972645136749;5472.808451704251;5479.397266300703;5537.307836520435;4462.308342206963;4847.2729090635985;4929.580985616191;4979.676321039121;5076.593872490192;4097.344424892003;4129.896577886091;4160.916781664349;4197.160567886435;4203.0543127796;1225.9632211033684;1252.2298786246392;1254.874512548756;1259.741752940645;1278.3288773394042;1065.3927261460892;1082.9350238985687;1087.2823936202226;1099.587654629514;1106.9335839849634;6176.3514830943;6221.96889015552;6282.308946015934;6282.874342513124;6341.112244285804;486.8247430924864;494.4733858440749;495.3016247091584;495.46489791025607;503.22754571732213;4220.957790422118;4223.472065991751;4314.80583373749;4322.135572885372;4399.5160532341415;10763.83854242187;11112.277701949348;11248;11275.830862537068;11344.092472602171;11022.283551569122;11054.226204165792;11067.50196241171;11073.889261107286;11085;7852.607369631495;8026.799330016679;8044.597770111471;8049.6377663005305;8433.325333973267;5842.737076831468;5915.260592425947;6002.609830361012;6009.338972713085;6083.543734219863;9344.719658410258;9405.247580193705;9452.95273523628;9468.431894086378;9623.807523849344;9389.765255868384;9526.904730952601;9567.808643826946;9705.320627556004;9764.804703906024;7122.60825654594;7496.287852653989;7686.154523002353;8051.637676304464;8260.710875119343;8386.790330241793;8498.532580707873;8546.572671366283;8581.14188581162;8585.141485851365;7377.852442951218;7573.734919277799;7595.240475952582;7637.923620763721;7659.617019149132;7391.482596218213;7498.512596681198;7512.9624351880075;7541.208173141741;7558.055243094614;7317.231690672403;7318.975343452027;7323.707051717872;7371.152317483558;7377.926220737724;5079.568236699922;5120.539151476236;5172.689638621695;5174.404943431554;5196;5373.892522149457;5401.864953376197;5404.675719456845;5412;5497.340319161726 04:23:39 INFO - PROCESS | 11268 | |4;prototype.html;360.281238928338;368.9280590284892;373.05058625797346;373.34850685553715;376.37333839157805;6569.277379488252;6574.375434333737;6635.104260924773;6683.565568238061;6694.96652516738;6630.602163870171;6674.799756007315;6676.566023208488;6697.732090716378;6722.529422940396;5105.821296254632;5136.666116702421;5136.948630513684;5137.871553211181;5151.793928242866;5140.126178549637;5151.6136289778415;5152.175651895697;5152.484751524855;5162.174052151657;5101.489851014888;5102.821401250957;5103.821366252182;5110;5110.565601923841;4807.807687692505;4918.606511479073;4942.159832828428;5103.668261562986;5110.259012443194;4282.807273672661;4284.807183676711;4296.677749168824;4325.091730736549;4334.804933777956;6441.83895402614;6445.001024841157;6450;6456.967715161441;6462.868997925344;5700.6579605223405;5789.465791565239;5912.586118971673;5913.526917846562;5922.7038648067855;7019.333163349474;7059.2234854166;7064;7072.8939065914055;7073.752418665374;4812.494688057738;4832.178529649968;4843.975780121112;4857.587105096071;4859.635527335464;7363.079615048119;7392.667329970164;7440;7446.702131914771;7457.1051473822945;4802.111609352281;4922.163232250526;4947.1837146871085;4957.677750946177;5005.399352077774;4920.901581968341;4940.6788558743565;4971.279164521125;4972.030454061495;4986.950130498649;5740.052891272893;5763.510101641407;5840.123981402823;5846.7076646167525;5860.208871802252;7049.365557099885;7080.92919070813;7086.858262834818;7090.751823686146;7130.286971302932;1756.3325936144438;1773.733939908998;1778.8221177882367;1784.9910750446165;1786.7230579260236;1052.6631477927142;1101.5373543111912;1122.6126986189752;1129.0403157316216;1146.3236690352564;6877.037214789933;6887.070245516791;6887.896681549781;6907.723691052302;6909.827254318682;7246.275372462712;7294.358769276871;7296.854062918712;7308.5614863108385;7312.305330993547;6844.4182244509775;6848.589084654936;6858.622775747382;6864.691088901011;6878.65606719672;3889.1638297766117;3927.7054220933546;3955.564887862333;3966.0679740261016;3966.186931678999;7582.772516824504;7601.353884919733;7629.7329593463965;7651.69393224276;7671.53970761756;7513.647543442124;7549.282818132268;7562;7573.939648449222;7577.772666820004;7699.653515591812;7715.382769378436;7738.845223095619;7745.922540774633;7768.145503994443;7245.529040612343;7383.040204773345;7387.372073373824;7414.8887766682465;7435.814104647211;7236.20401755796;7236.565806051653;7279.199288078201;7291;7304.379127774198;7743;7750;7759.2628700275645;7760.573168475788;7769.572673503011;4881.536254055859;4928.581070609039;4952.059108769322;4955.1823949048;4975;7258.89111663336;7389.889151662622;7400.703971841066;7402.222766609644;7436.702531898663;7087.681054352463;7097.645117744195;7137.964310178416;7162.785116446515;7168.139823221039;7150.892736608851;7155.892661610184;7157.711611909906;7160.498765086394;7163.2478589747325;6969.372756451944;6993.545419547713;7004.0544526488275;7008.264132266038;7018.33325834045;7030.683619237249;7179.533330333512;7223.783286501413;7229.060222171294;7234.16807067194;6881.587104773529;7077.893831592633;7087.64561771899;7095.574265544084;7101.928980710127 04:23:39 INFO - PROCESS | 11268 | |5;yui.html;781.644351819922;812.7439856445216;841.3815845353666;877.8683197520368;883.982320353593;14472.493462728806;14581.270936453175;14597.197154156516;14633.634159146;14681.192534410617;12740.55408060718;12760.80858787119;12762.55331063413;12837.743245135092;12906.22562646242;881.1320848963766;895.7133717210495;895.7939673875013;896.0770406481334;898.2993265253114;760.0271652285084;880.810625715471;898.2050884966819;898.7034278688018;905.9411138275991;929.7257309093834;945.5697657565792;948.2745699539857;948.2840455456121;948.672707915768;929.029164523075;935.2331088507426;946.1579194516886;946.1579194516886;947.5262368815557;690.1855810144078;690.4200471603876;690.5994523176596;692.7852365766629;693.4348505967671;13517;13563.321833908363;13618.319084045757;13625.591232263048;13681.589552313446;14023;14611.488597899022;14746.410143594243;14796;14828.777568336483;10504;10595.629152979609;10729.517171727291;11301.434928253555;11432;4679.134360143385;4685.367475390813;4779;4785.186518291899;4793.832215872462;57842.7107864458;57990.710046449916;58201;58222.41777582255;58509.41490585082;11632.127590430582;11661.416929153509;11851.466683999068;11881.465334059814;12026.518939242507;21504;21554.245601403876;21581.460463488223;21582.244621438174;21628.243011494524;8208.548529830916;8327.875081873655;8438;8500.872486912702;8687.869681954775;4624.722516648944;4802.423709154924;4832.033593281358;4888.95111048885;4961.08219979305;3632.6912212462234;3684.9631503685155;3688.7786732796117;3693.4829123922673;3694.4273637586216;622.4615707413055;652.2043107408954;653.7875190563086;655.2104713819836;660.2934859700075;734.8897665350133;785.0696924144906;796.7530065679658;803.333233416263;807.7415227127262;10086.697399078039;10123.797524049625;10125.64560240388;10166.593336266615;10174.745631359276;790.213737331359;790.6600161930426;797.1789057270904;801.631249625179;803.6423791412882;4534.478534968521;4765.285207218945;4861.27080937855;4870.659053866196;4923.75381230937;59728;60652.393476065554;60671.393286067454;69681.65159174171;69968;56829.147562786595;58217;58796.11805822916;59418.10872836911;60254.0961885572;53371.466285337425;53537;55370.44629553653;55690.886182276125;56123.158152627744;9403.576839042124;9478.763030924281;9692;9709.5145242739;9772.218222542322;37824;39936.00159996023;40051.599484004786;40865.79567102146;40965.79517102396;48867.75566122147;49297.753511232215;49592.504074960234;50907.98184036224;52857.7357113212;11373.260738052;11652.592159274385;12229.694257643274;12968.935155324163;13167.868321316664;12990.090693651731;13248.602541923758;13771.311434428038;14058.507952221624;14339.856601434269;13027.609171724864;13147.408366623333;13244.602661920158;13736.725265494833;13890.374933127832;12789.552365667158;12792.424340904869;12837.422315995616;12910.483580657045;13050.738985220432;12074.939625301817;12477.937610312254;12585.307808070644;12701.174423662433;13632.659183520094;9979.550920208463;10024.056540340684;10054.34646747959;10063.39619622825;10153.543090560795;10199.184065274909;10233.232507561814;10245.975402459993;10329.070383665507;10351.378917264989 04:23:39 INFO - PROCESS | 11268 | __end_tp_report 04:23:39 INFO - PROCESS | 11268 | __start_cc_report 04:23:39 INFO - PROCESS | 11268 | _x_x_mozilla_cycle_collect,318 04:23:39 INFO - PROCESS | 11268 | __end_cc_report 04:23:39 INFO - PROCESS | 11268 | __startTimestamp1465212219755__endTimestamp 04:23:39 INFO - PROCESS | 11268 | 04:23:39 INFO - PROCESS | 11268 | ------- Summary: start ------- 04:23:39 INFO - PROCESS | 11268 | Number of tests: 6 04:23:39 INFO - PROCESS | 11268 | 04:23:39 INFO - PROCESS | 11268 | [#0] dojo.html Cycles:165 Average:5738.08 Median:6001.40 stddev:664.68 (11.1%) stddev-sans-first:640.88 04:23:39 INFO - PROCESS | 11268 | Values: 3398.3 3423.8 3443.1 3451.6 3461.5 5703.9 5743.5 5745.9 5777.4 5810.0 5663.5 5721.7 5744.6 5751.9 5756.1 5195.2 5205.7 5232.3 5264.4 5272.9 5153.3 5251.5 5253.2 5343.7 5368.9 5178.6 5246.7 5253.2 5267.1 5271.1 5262.9 5276.0 5276.1 5279.8 5281.5 5135.6 5180.1 5220.9 5243.3 5251.4 5514.0 5539.3 5629.8 5634.3 5642.0 6154.1 6171.0 6188.0 6199.8 6207.8 6001.4 6239.6 6248.5 6255.3 6266.3 5759.5 5790.2 5797.7 5807.1 5821.9 6282.2 6286.8 6305.5 6324.0 6336.1 5959.6 5978.9 6035.0 6053.2 6054.9 6190.3 6196.5 6198.7 6217.9 6225.5 6081.9 6166.4 6177.4 6185.0 6195.2 5969.6 6141.4 6165.8 6189.2 6201.6 4563.4 4573.1 4581.5 4589.8 4607.2 4121.7 4127.2 4131.2 4137.0 4168.1 5864.3 6004.8 6042.4 6046.8 6089.5 6084.8 6092.7 6152.4 6152.5 6157.9 6008.7 6020.1 6024.2 6025.0 6027.7 5149.8 5164.9 5276.9 5277.1 5326.9 6445.3 6468.9 6500.5 6509.1 6513.3 6200.8 6227.7 6236.7 6243.2 6267.9 6319.0 6451.4 6461.1 6488.3 6495.0 6127.4 6141.4 6148.5 6149.2 6149.9 6192.1 6225.3 6238.3 6246.1 6265.7 5852.1 6035.2 6068.6 6071.3 6123.4 6037.7 6042.9 6049.1 6060.0 6080.4 5940.1 5955.9 5975.8 5978.8 5981.4 5993.3 5998.2 6058.2 6092.1 6134.9 5830.2 5834.4 5838.2 5844.6 5856.6 04:23:39 INFO - PROCESS | 11268 | 04:23:39 INFO - PROCESS | 11268 | [#1] ext.html Cycles:180 Average:64699.74 Median:42558.97 stddev:129272.98 (303.8%) stddev-sans-first:129546.10 04:23:39 INFO - PROCESS | 11268 | Values: 622.4 662.8 673.2 679.9 751.9 33605.5 39756.4 40161.6 40314.4 40367.8 42411.2 42427.0 42607.1 42639.0 43109.4 8626.3 8785.2 8787.6 8802.5 8845.9 8640.1 8710.6 8750.9 8783.3 9037.5 8985.0 9064.9 9068.2 9068.4 9086.7 8949.8 8972.7 8972.9 9018.2 9038.1 8909.5 8989.3 9006.4 9023.8 9025.0 43216.0 43694.0 43757.8 43765.6 44038.0 3781.2 3880.9 3905.7 3919.7 3976.1 32379.5 32596.8 32936.8 33296.7 33387.2 4371.1 4387.0 4389.6 4412.1 4457.7 509364.0 516398.0 520102.0 520218.8 523507.0 61220.0 61453.0 61682.7 61739.4 61838.1 69175.7 70061.0 70472.3 70581.0 70681.3 18800.2 19136.8 19213.8 19328.8 19364.7 14938.3 14946.1 14993.2 15012.9 15039.2 20737.9 20830.0 20873.9 20911.2 20944.5 7565.2 7735.5 7810.8 7842.3 7850.0 1119.1 1147.4 1179.1 1182.9 1201.8 32863.3 33091.7 33689.0 33770.0 33865.3 1207.9 1208.9 1220.2 1326.8 1356.8 16996.3 17219.0 17371.4 17441.8 17587.0 476032.0 502425.0 507107.0 510283.0 513016.0 56641.7 56956.7 57410.7 57561.0 57578.0 1510.7 1521.2 1523.5 1523.6 1528.3 31104.8 33172.0 33277.7 33481.0 33900.8 53460.0 53932.2 54004.7 54087.0 54100.7 432977.0 437149.0 441731.0 442700.0 443036.0 30661.0 30715.8 30791.4 30833.5 31145.2 47506.5 48090.5 48534.3 48692.0 50680.0 36943.8 37114.8 37465.1 37678.6 41878.0 39029.0 39468.0 39605.0 40456.6 40776.0 41138.4 41938.0 42040.8 42510.8 43094.6 35372.0 35516.5 36154.0 36199.3 36281.3 28924.4 29090.9 29356.1 29373.3 29461.4 04:23:39 INFO - PROCESS | 11268 | 04:23:39 INFO - PROCESS | 11268 | [#2] jquery.html Cycles:180 Average:30574.62 Median:2489.56 stddev:82721.10 (3322.7%) stddev-sans-first:82922.18 04:23:39 INFO - PROCESS | 11268 | Values: 424.7 435.2 439.9 443.5 443.5 18550.6 18813.0 19391.8 19414.1 19520.6 18749.6 18826.3 19102.2 19290.3 19300.3 5597.5 5686.7 5871.5 5924.6 5929.8 5800.8 5926.9 5942.9 5946.7 5983.6 6007.7 6011.3 6031.2 6039.1 6058.3 5866.2 6081.0 6129.4 6169.0 6171.7 5951.9 5982.0 5995.3 6000.2 6024.4 22269.6 22875.8 23218.3 24168.9 24173.9 2431.2 2440.4 2538.7 2579.9 3005.1 10397.0 10492.8 10599.5 10674.3 10798.7 1960.6 1995.1 2009.4 2021.9 2035.1 80108.0 90221.7 91438.5 93436.0 100556.5 17668.8 18344.4 18530.3 19162.4 19277.0 33401.5 33844.3 34453.3 34454.0 34480.5 10357.4 10712.9 10800.8 10828.6 11140.8 9171.1 9445.2 9450.0 9451.9 9471.4 9322.5 9415.7 9440.7 9505.9 9622.7 3473.1 3615.0 3679.7 3711.8 3916.0 1004.3 1082.1 1098.7 1146.5 1175.1 19112.7 19764.3 19792.7 20049.6 20379.3 1104.7 1140.3 1162.9 1163.5 1187.9 10961.0 11064.4 11146.2 11256.7 11283.7 493455.0 493962.0 501399.0 507923.0 512989.0 90694.5 91611.5 92347.5 93256.5 93455.0 1082.9 1084.8 1140.5 1149.2 1162.0 17360.3 17465.0 17765.2 17782.0 18013.8 38008.8 38451.6 39264.8 40131.2 40278.2 52144.2 56486.7 57231.0 57731.0 57787.0 8806.8 8899.9 8919.9 9109.6 9272.6 9316.0 11986.8 12325.9 12495.3 12525.7 10697.8 10924.2 11094.6 11374.1 11508.3 10910.8 11012.7 11025.4 11205.9 11312.3 11396.4 11525.9 11591.4 11630.8 11687.4 8960.1 8988.3 9051.7 9115.0 9215.2 8627.4 11577.9 11906.6 11909.8 11960.6 04:23:39 INFO - PROCESS | 11268 | 04:23:39 INFO - PROCESS | 11268 | [#3] mootools.html Cycles:180 Average:5854.41 Median:495.38 stddev:3259.88 (658.1%) stddev-sans-first:3253.12 04:23:39 INFO - PROCESS | 11268 | Values: 1569.6 1573.5 1743.7 1797.1 1808.5 8578.4 8711.9 8793.9 8806.7 8842.5 8843.7 8901.3 8923.1 8931.5 8982.4 2442.9 2468.6 2475.2 2476.6 2482.1 2455.2 2526.8 2526.9 2526.9 2529.5 2440.4 2447.2 2488.7 2496.4 2505.6 2431.1 2437.5 2443.3 2443.5 2458.3 2446.3 2449.0 2459.0 2469.2 2507.1 8894.2 8933.6 8957.5 8974.6 8978.6 5298.0 5390.6 5428.7 5438.8 5452.1 3479.4 3480.8 3537.4 3560.1 3561.5 1178.6 1190.1 1201.2 1210.2 1223.0 12599.8 12603.7 12642.2 12707.2 12718.2 4704.1 4754.8 4755.2 4777.9 4789.4 10092.8 10109.9 10119.2 10120.3 10140.6 5467.8 5471.0 5472.8 5479.4 5537.3 4462.3 4847.3 4929.6 4979.7 5076.6 4097.3 4129.9 4160.9 4197.2 4203.1 1226.0 1252.2 1254.9 1259.7 1278.3 1065.4 1082.9 1087.3 1099.6 1106.9 6176.4 6222.0 6282.3 6282.9 6341.1 486.8 494.5 495.3 495.5 503.2 4221.0 4223.5 4314.8 4322.1 4399.5 10763.8 11112.3 11248.0 11275.8 11344.1 11022.3 11054.2 11067.5 11073.9 11085.0 7852.6 8026.8 8044.6 8049.6 8433.3 5842.7 5915.3 6002.6 6009.3 6083.5 9344.7 9405.2 9453.0 9468.4 9623.8 9389.8 9526.9 9567.8 9705.3 9764.8 7122.6 7496.3 7686.2 8051.6 8260.7 8386.8 8498.5 8546.6 8581.1 8585.1 7377.9 7573.7 7595.2 7637.9 7659.6 7391.5 7498.5 7513.0 7541.2 7558.1 7317.2 7319.0 7323.7 7371.2 7377.9 5079.6 5120.5 5172.7 5174.4 5196.0 5373.9 5401.9 5404.7 5412.0 5497.3 04:23:39 INFO - PROCESS | 11268 | 04:23:39 INFO - PROCESS | 11268 | [#4] prototype.html Cycles:180 Average:5938.21 Median:6846.50 stddev:1829.43 (26.7%) stddev-sans-first:1786.01 04:23:39 INFO - PROCESS | 11268 | Values: 360.3 368.9 373.1 373.3 376.4 6569.3 6574.4 6635.1 6683.6 6695.0 6630.6 6674.8 6676.6 6697.7 6722.5 5105.8 5136.7 5136.9 5137.9 5151.8 5140.1 5151.6 5152.2 5152.5 5162.2 5101.5 5102.8 5103.8 5110.0 5110.6 4807.8 4918.6 4942.2 5103.7 5110.3 4282.8 4284.8 4296.7 4325.1 4334.8 6441.8 6445.0 6450.0 6457.0 6462.9 5700.7 5789.5 5912.6 5913.5 5922.7 7019.3 7059.2 7064.0 7072.9 7073.8 4812.5 4832.2 4844.0 4857.6 4859.6 7363.1 7392.7 7440.0 7446.7 7457.1 4802.1 4922.2 4947.2 4957.7 5005.4 4920.9 4940.7 4971.3 4972.0 4987.0 5740.1 5763.5 5840.1 5846.7 5860.2 7049.4 7080.9 7086.9 7090.8 7130.3 1756.3 1773.7 1778.8 1785.0 1786.7 1052.7 1101.5 1122.6 1129.0 1146.3 6877.0 6887.1 6887.9 6907.7 6909.8 7246.3 7294.4 7296.9 7308.6 7312.3 6844.4 6848.6 6858.6 6864.7 6878.7 3889.2 3927.7 3955.6 3966.1 3966.2 7582.8 7601.4 7629.7 7651.7 7671.5 7513.6 7549.3 7562.0 7573.9 7577.8 7699.7 7715.4 7738.8 7745.9 7768.1 7245.5 7383.0 7387.4 7414.9 7435.8 7236.2 7236.6 7279.2 7291.0 7304.4 7743.0 7750.0 7759.3 7760.6 7769.6 4881.5 4928.6 4952.1 4955.2 4975.0 7258.9 7389.9 7400.7 7402.2 7436.7 7087.7 7097.6 7138.0 7162.8 7168.1 7150.9 7155.9 7157.7 7160.5 7163.2 6969.4 6993.5 7004.1 7008.3 7018.3 7030.7 7179.5 7223.8 7229.1 7234.2 6881.6 7077.9 7087.6 7095.6 7101.9 04:23:39 INFO - PROCESS | 11268 | 04:23:39 INFO - PROCESS | 11268 | [#5] yui.html Cycles:180 Average:15689.72 Median:4789.51 stddev:18417.70 (384.5%) stddev-sans-first:18435.34 04:23:39 INFO - PROCESS | 11268 | Values: 781.6 812.7 841.4 877.9 884.0 14472.5 14581.3 14597.2 14633.6 14681.2 12740.6 12760.8 12762.6 12837.7 12906.2 881.1 895.7 895.8 896.1 898.3 760.0 880.8 898.2 898.7 905.9 929.7 945.6 948.3 948.3 948.7 929.0 935.2 946.2 946.2 947.5 690.2 690.4 690.6 692.8 693.4 13517.0 13563.3 13618.3 13625.6 13681.6 14023.0 14611.5 14746.4 14796.0 14828.8 10504.0 10595.6 10729.5 11301.4 11432.0 4679.1 4685.4 4779.0 4785.2 4793.8 57842.7 57990.7 58201.0 58222.4 58509.4 11632.1 11661.4 11851.5 11881.5 12026.5 21504.0 21554.2 21581.5 21582.2 21628.2 8208.5 8327.9 8438.0 8500.9 8687.9 4624.7 4802.4 4832.0 4889.0 4961.1 3632.7 3685.0 3688.8 3693.5 3694.4 622.5 652.2 653.8 655.2 660.3 734.9 785.1 796.8 803.3 807.7 10086.7 10123.8 10125.6 10166.6 10174.7 790.2 790.7 797.2 801.6 803.6 4534.5 4765.3 4861.3 4870.7 4923.8 59728.0 60652.4 60671.4 69681.7 69968.0 56829.1 58217.0 58796.1 59418.1 60254.1 53371.5 53537.0 55370.4 55690.9 56123.2 9403.6 9478.8 9692.0 9709.5 9772.2 37824.0 39936.0 40051.6 40865.8 40965.8 48867.8 49297.8 49592.5 50908.0 52857.7 11373.3 11652.6 12229.7 12968.9 13167.9 12990.1 13248.6 13771.3 14058.5 14339.9 13027.6 13147.4 13244.6 13736.7 13890.4 12789.6 12792.4 12837.4 12910.5 13050.7 12074.9 12477.9 12585.3 12701.2 13632.7 9979.6 10024.1 10054.3 10063.4 10153.5 10199.2 10233.2 10246.0 10329.1 10351.4 04:23:39 INFO - PROCESS | 11268 | -------- Summary: end -------- 04:23:39 INFO - PROCESS | 11268 | 04:23:40 INFO - TEST-INFO | 11268: exit 0 04:23:40 INFO - TEST-OK | dromaeo_css | took 1108997ms 04:23:40 INFO - TEST-START | kraken 04:23:40 INFO - operating with platform_type : linux_ 04:23:40 INFO - Initialising browser for kraken test... 04:23:40 INFO - TEST-INFO | started process 11515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVLQTEG/profile http://localhost:46843/getInfo.html) 04:23:43 INFO - PROCESS | 11515 | 04:23:43 INFO - PROCESS | 11515 | (process:11591): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:23:44 INFO - PROCESS | 11515 | __metrics Screen width/height:1600/1200 04:23:44 INFO - PROCESS | 11515 | colorDepth:24 04:23:44 INFO - PROCESS | 11515 | Browser inner width/height: 1024/697 04:23:44 INFO - PROCESS | 11515 | __metrics 04:23:45 ERROR - PROCESS | 11515 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 04:23:46 INFO - TEST-INFO | 11515: exit 0 04:23:46 INFO - Browser initialized. 04:23:46 INFO - Running cycle 1/1 for kraken test... 04:23:46 INFO - TEST-INFO | started process 11642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVLQTEG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:47 INFO - PROCESS | 11642 | 04:23:47 INFO - PROCESS | 11642 | (process:11710): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:23:57 INFO - PROCESS | 11642 | RSS: Main: 152166400 04:23:57 INFO - PROCESS | 11642 | 04:24:00 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46843/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:01 INFO - PROCESS | 11642 | RSS: Main: 157192192 04:24:01 INFO - PROCESS | 11642 | 04:24:03 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46843/tests/kraken/driver.html?testName=audio-dft) 04:24:04 INFO - PROCESS | 11642 | RSS: Main: 157339648 04:24:04 INFO - PROCESS | 11642 | 04:24:07 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46843/tests/kraken/driver.html?testName=audio-fft) 04:24:07 INFO - PROCESS | 11642 | RSS: Main: 157212672 04:24:07 INFO - PROCESS | 11642 | 04:24:10 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46843/tests/kraken/driver.html?testName=audio-oscillator) 04:24:10 INFO - PROCESS | 11642 | RSS: Main: 157048832 04:24:10 INFO - PROCESS | 11642 | 04:24:12 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:13 INFO - PROCESS | 11642 | RSS: Main: 157110272 04:24:13 INFO - PROCESS | 11642 | 04:24:16 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46843/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:17 INFO - PROCESS | 11642 | RSS: Main: 158138368 04:24:17 INFO - PROCESS | 11642 | 04:24:20 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46843/tests/kraken/driver.html?testName=imaging-desaturate) 04:24:21 INFO - PROCESS | 11642 | RSS: Main: 157495296 04:24:21 INFO - PROCESS | 11642 | 04:24:23 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46843/tests/kraken/driver.html?testName=json-parse-financial) 04:24:24 INFO - PROCESS | 11642 | RSS: Main: 157716480 04:24:24 INFO - PROCESS | 11642 | 04:24:25 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:24:26 INFO - PROCESS | 11642 | RSS: Main: 157425664 04:24:26 INFO - PROCESS | 11642 | 04:24:28 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46843/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:24:28 INFO - PROCESS | 11642 | RSS: Main: 157335552 04:24:28 INFO - PROCESS | 11642 | 04:24:30 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:24:31 INFO - PROCESS | 11642 | RSS: Main: 157507584 04:24:31 INFO - PROCESS | 11642 | 04:24:34 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:24:34 INFO - PROCESS | 11642 | RSS: Main: 158355456 04:24:34 INFO - PROCESS | 11642 | 04:24:37 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:24:37 INFO - PROCESS | 11642 | RSS: Main: 158605312 04:24:37 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | Cycle 1(1): loaded http://localhost:46843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46843/tests/kraken/driver.html?testName=ai-astar) 04:24:39 INFO - PROCESS | 11642 | RSS: Main: 159797248 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | __start_tp_report 04:24:39 INFO - PROCESS | 11642 | _x_x_mozilla_page_load 04:24:39 INFO - PROCESS | 11642 | _x_x_mozilla_page_load_details 04:24:39 INFO - PROCESS | 11642 | |i|pagename|runs| 04:24:39 INFO - PROCESS | 11642 | |0;ai-astar;107;112;104;112;112;113;102;112;112;110 04:24:39 INFO - PROCESS | 11642 | |1;audio-beat-detection;157;126;156;175;130;152;161;132;197;133 04:24:39 INFO - PROCESS | 11642 | |2;audio-dft;162;162;164;162;162;161;165;161;161;163 04:24:39 INFO - PROCESS | 11642 | |3;audio-fft;73;77;78;186;73;77;74;85;167;76 04:24:39 INFO - PROCESS | 11642 | |4;audio-oscillator;93;92;160;93;93;92;148;91;92;141 04:24:39 INFO - PROCESS | 11642 | |5;imaging-gaussian-blur;117;118;118;117;117;117;117;117;117;117 04:24:39 INFO - PROCESS | 11642 | |6;imaging-darkroom;148;147;149;146;148;148;148;147;148;148 04:24:39 INFO - PROCESS | 11642 | |7;imaging-desaturate;96;95;95;95;95;96;95;96;96;95 04:24:39 INFO - PROCESS | 11642 | |8;json-parse-financial;56;56;59;55;58;56;59;67;55;55 04:24:39 INFO - PROCESS | 11642 | |9;json-stringify-tinderbox;58;58;58;58;58;58;58;58;59;58 04:24:39 INFO - PROCESS | 11642 | |10;stanford-crypto-aes;73;73;73;74;82;75;76;77;74;74 04:24:39 INFO - PROCESS | 11642 | |11;stanford-crypto-ccm;126;121;113;123;117;115;114;112;129;124 04:24:39 INFO - PROCESS | 11642 | |12;stanford-crypto-pbkdf2;157;161;163;160;158;159;160;158;159;160 04:24:39 INFO - PROCESS | 11642 | |13;stanford-crypto-sha256-iterative;70;68;70;69;70;68;69;74;66;68 04:24:39 INFO - PROCESS | 11642 | __end_tp_report 04:24:39 INFO - PROCESS | 11642 | __start_cc_report 04:24:39 INFO - PROCESS | 11642 | _x_x_mozilla_cycle_collect,864 04:24:39 INFO - PROCESS | 11642 | __end_cc_report 04:24:39 INFO - PROCESS | 11642 | __startTimestamp1465212279900__endTimestamp 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | ------- Summary: start ------- 04:24:39 INFO - PROCESS | 11642 | Number of tests: 14 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:3.89 (3.5%) stddev-sans-first:4.01 04:24:39 INFO - PROCESS | 11642 | Values: 107.0 112.0 104.0 112.0 112.0 113.0 102.0 112.0 112.0 110.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.50 stddev:22.60 (14.4%) stddev-sans-first:23.90 04:24:39 INFO - PROCESS | 11642 | Values: 157.0 126.0 156.0 175.0 130.0 152.0 161.0 132.0 197.0 133.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 04:24:39 INFO - PROCESS | 11642 | Values: 162.0 162.0 164.0 162.0 162.0 161.0 165.0 161.0 161.0 163.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#3] audio-fft Cycles:10 Average:96.60 Median:76.50 stddev:42.49 (55.5%) stddev-sans-first:44.20 04:24:39 INFO - PROCESS | 11642 | Values: 73.0 77.0 78.0 186.0 73.0 77.0 74.0 85.0 167.0 76.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:28.09 (30.5%) stddev-sans-first:29.15 04:24:39 INFO - PROCESS | 11642 | Values: 93.0 92.0 160.0 93.0 93.0 92.0 148.0 91.0 92.0 141.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:24:39 INFO - PROCESS | 11642 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:24:39 INFO - PROCESS | 11642 | Values: 148.0 147.0 149.0 146.0 148.0 148.0 148.0 147.0 148.0 148.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:24:39 INFO - PROCESS | 11642 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:3.66 (6.4%) stddev-sans-first:3.83 04:24:39 INFO - PROCESS | 11642 | Values: 56.0 56.0 59.0 55.0 58.0 56.0 59.0 67.0 55.0 55.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:24:39 INFO - PROCESS | 11642 | Values: 58.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 59.0 58.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.50 stddev:2.77 (3.7%) stddev-sans-first:2.83 04:24:39 INFO - PROCESS | 11642 | Values: 73.0 73.0 73.0 74.0 82.0 75.0 76.0 77.0 74.0 74.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:122.00 stddev:5.99 (4.9%) stddev-sans-first:5.85 04:24:39 INFO - PROCESS | 11642 | Values: 126.0 121.0 113.0 123.0 117.0 115.0 114.0 112.0 129.0 124.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:160.00 stddev:1.72 (1.1%) stddev-sans-first:1.56 04:24:39 INFO - PROCESS | 11642 | Values: 157.0 161.0 163.0 160.0 158.0 159.0 160.0 158.0 159.0 160.0 04:24:39 INFO - PROCESS | 11642 | 04:24:39 INFO - PROCESS | 11642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:2.10 (3.0%) stddev-sans-first:2.20 04:24:39 INFO - PROCESS | 11642 | Values: 70.0 68.0 70.0 69.0 70.0 68.0 69.0 74.0 66.0 68.0 04:24:39 INFO - PROCESS | 11642 | -------- Summary: end -------- 04:24:39 INFO - PROCESS | 11642 | 04:24:40 INFO - TEST-INFO | 11642: exit 0 04:24:40 INFO - TEST-OK | kraken | took 60442ms 04:24:40 INFO - SUITE-END | took 1169s 04:24:41 INFO - Completed test suite (00:19:29) 04:24:41 INFO - javascript benchmark 04:24:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3398.320335932813, 3423.760336776426, 3443.0875817908245, 3451.5512983312165, 3461.532693086434, 5703.914441283378, 5743.54051675866, 5745.9138112928285, 5777.364489906107, 5809.95420824252, 5663.546916246701, 5721.713914304279, 5744.569157313197, 5751.942480575193, 5756.050251708463, 5195.19474481455, 5205.687658740488, 5232.3197984262, 5264.447233040533, 5272.868178295555, 5153.2785410042625, 5251.527362537371, 5253.212018197282, 5343.706096164709, 5368.892622147555, 5178.611604129686, 5246.737663116848, 5253.185756207794, 5267.104592219332, 5271.103912334912, 5262.92105618416, 5275.973620131913, 5276.129438642658, 5279.788808447657, 5281.471852814707, 5135.589152867761, 5180.067587834188, 5220.8694782630355, 5243.344581927259, 5251.4223435422455, 5514.0, 5539.307586551681, 5629.831105066854, 5634.323881134249, 5642.04085305499, 6154.138420621117, 6170.969145154246, 6188.0, 6199.752009919643, 6207.844803879939, 6001.399860014008, 6239.594426362272, 6248.5313601480075, 6255.280642726099, 6266.310705822356, 5759.48164665178, 5790.189373487715, 5797.652140871562, 5807.070868660994, 5821.941780582182, 6282.246130464374, 6286.779962701375, 6305.527085468608, 6323.9683801580695, 6336.112944187817, 5959.642421454727, 5978.940210597925, 6035.034394496859, 6053.182820319201, 6054.939450605438, 6190.288116866618, 6196.504279657616, 6198.659073750987, 6217.937820621826, 6225.501959843202, 6081.939180608226, 6166.352532983972, 6177.382261773787, 6184.969075154595, 6195.2255968004, 5969.552283578749, 6141.416565426367, 6165.815025549241, 6189.226346706661, 6201.565890387629, 4563.361129441881, 4573.062522182944, 4581.518940511265, 4589.770511474413, 4607.193741095295, 4121.690873184523, 4127.236461254677, 4131.173765246963, 4137.0, 4168.062186008124, 5864.266966629171, 6004.789832355934, 6042.425969532887, 6046.758129674852, 6089.512838972872, 6084.756609735649, 6092.72582733778, 6152.415520525543, 6152.477039451607, 6157.876842463125, 6008.729607167688, 6020.096985452217, 6024.216851809237, 6025.0359942409, 6027.668478233739, 5149.845504634867, 5164.948350516447, 5276.894462110737, 5277.1292736698015, 5326.92009619856, 6445.291017988017, 6468.870622587616, 6500.5449618526245, 6509.088727578142, 6513.283538810727, 6200.782972595937, 6227.688615569294, 6236.688165591611, 6243.188385509855, 6267.905981410191, 6318.968405158129, 6451.41937225652, 6461.0954466373805, 6488.286288508355, 6494.967525162533, 6127.403330890726, 6141.355157708376, 6148.538859585638, 6149.200603921461, 6149.938500615115, 6192.071189321638, 6225.252969643671, 6238.313785483684, 6246.094316324016, 6265.686715664289, 5852.063669812809, 6035.215421995113, 6068.605540639845, 6071.332153463204, 6123.4488895999575, 6037.698115094316, 6042.939570604413, 6049.122877182872, 6060.030395136757, 6080.422359875804, 5940.138679891478, 5955.91066134017, 5975.820725378246, 5978.760849565969, 5981.401859813984, 5993.340732519332, 5998.190244316961, 6058.151858739868, 6092.086187071975, 6134.877302454015, 5830.2420685310635, 5834.445727655866, 5838.241028666246, 5844.590878638454, 5856.648601083949], "value": 5692.923193651101, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.4180391334103, 662.8442316055728, 673.2493270003944, 679.8504329047607, 751.8909758085074, 33605.495917561224, 39756.40365394518, 40161.59838401622, 40314.39528407069, 40367.79816100915, 42411.15177696444, 42427.0, 42607.14785704292, 42639.0, 43109.35335969963, 8626.309895208367, 8785.165409286108, 8787.64849406023, 8802.471851688888, 8845.911540884605, 8640.135986401372, 8710.564471776386, 8750.912490875106, 8783.341249406289, 9037.457752534869, 8984.955075224614, 9064.909350906506, 9068.229200517964, 9068.365214434993, 9086.681966131187, 8949.821003579924, 8972.730818075468, 8972.910270897306, 9018.233450156744, 9038.141376569249, 8909.465432074096, 8989.280857531381, 9006.369554131214, 9023.774405639846, 9025.0, 43216.0, 43694.0, 43757.78121109406, 43765.56234437646, 44038.0, 3781.2437512497336, 3880.941785873214, 3905.7265991380614, 3919.7256192066566, 3976.1252524444576, 32379.514307285408, 32596.837015815006, 32936.835315823264, 33296.6670333296, 33387.16532086693, 4371.103923695635, 4387.0, 4389.604935555815, 4412.0734645724115, 4457.665675074382, 509364.0, 516398.0, 520102.0, 520218.7978120246, 523507.0, 61220.0, 61453.0, 61682.69158654268, 61739.38260617426, 61838.072428913605, 69175.65412172907, 70061.0, 70472.2952770476, 70581.0, 70681.2931870685, 18800.247990080516, 19136.808631913504, 19213.807861921483, 19328.806711932702, 19364.70952935707, 14938.253087345589, 14946.103233806007, 14993.175375354242, 15012.924935375253, 15039.172845493604, 20737.89631051835, 20830.0, 20873.89563052175, 20911.163553457995, 20944.476388090116, 7565.167831538526, 7735.49719268257, 7810.804729881685, 7842.333401660922, 7849.960750196213, 1119.1103073056938, 1147.3746807989667, 1179.1274456902001, 1182.8876256755595, 1201.8197270409335, 32863.342733145684, 33091.66908330934, 33689.0, 33770.0, 33865.32269354599, 1207.897328727068, 1208.9214201076902, 1220.2190598017276, 1326.84741254755, 1356.776131938239, 16996.320147193972, 17219.0, 17371.401275786746, 17441.825581744273, 17587.032713200897, 476032.0, 502425.0, 507107.0, 510283.0, 513016.0, 56641.716791415776, 56956.715216423654, 57410.71294643584, 57561.0, 57578.0, 1510.7431736604804, 1521.178563575679, 1523.504860920183, 1523.6114790728293, 1528.3198976455592, 31104.844475777478, 33172.00967941931, 33277.66722332746, 33481.0, 33900.83049584736, 53460.0, 53932.191017135556, 54004.72997634987, 54087.0, 54100.729496352265, 432977.0, 437149.0, 441731.0, 442700.0, 443036.0, 30661.0, 30715.846420767753, 30791.38417231598, 30833.537496938014, 31145.221369465038, 47506.52493475159, 48090.5190948086, 48534.271985919535, 48692.0, 50680.0, 36943.81528092342, 37114.814425927696, 37465.06337341479, 37678.62321376751, 41878.0, 39029.0, 39468.0, 39605.0, 40456.59543404528, 40775.98060048522, 41138.38292425556, 41938.00650518263, 42040.78979605083, 42510.787446062575, 43094.56905430905, 35372.0, 35516.467252991744, 36154.0, 36199.27601447904, 36281.274374511835, 28924.42151156923, 29090.854545727136, 29356.119316420543, 29373.26566835846, 29461.410771784875], "value": 21111.858438831565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.6814888833374, 435.22999739058946, 439.87463572881734, 443.4722680010789, 443.4766974969536, 18550.628987420245, 18812.9652869092, 19391.806081939176, 19414.126364313604, 19520.609587808234, 18749.625007499875, 18826.34107806227, 19102.235910563562, 19290.32483863065, 19300.324488642902, 5597.468240517144, 5686.658800471964, 5871.500922421578, 5924.555658325643, 5929.822105336847, 5800.7679692812235, 5926.940730592682, 5942.851428714273, 5946.672932988684, 5983.611065280743, 6007.729652165641, 6011.2786465624185, 6031.24609423822, 6039.094135879609, 6058.303295121052, 5866.237389139427, 6080.969595152018, 6129.417705317987, 6169.043798211284, 6171.691415429211, 5951.880962380771, 5982.042873140276, 5995.310539287951, 6000.249968753906, 6024.367441418632, 22269.554608907732, 22875.77124228753, 23218.3034508965, 24168.879155604285, 24173.87913060441, 2431.161249368965, 2440.4264997725522, 2538.695356557225, 2579.8839052242506, 3005.143534092795, 10397.0, 10492.79014419715, 10599.47002649872, 10674.306170098918, 10798.73003174927, 1960.6372821028156, 1995.122146255643, 2009.357005758158, 2021.8685785424047, 2035.1248962945926, 80108.0, 90221.74445638912, 91438.54280728554, 93436.0, 100556.49721751417, 17668.823311766973, 18344.449666509758, 18530.25878964853, 19162.425127245926, 19277.0, 33401.49897751536, 33844.32311353759, 34453.310933781184, 34454.0, 34480.48279275813, 10357.378557286587, 10712.946435267773, 10800.78398432027, 10828.62099826518, 11140.777184456265, 9171.082891710908, 9445.244380449547, 9449.952750236342, 9451.905480945241, 9471.431714097176, 9322.533873306307, 9415.6704515343, 9440.716778496657, 9505.857412138823, 9622.663206787729, 3473.0915202505494, 3614.98192509041, 3679.742418030712, 3711.832967516468, 3915.9622699984525, 1004.2969921055291, 1082.0910435234284, 1098.741795678015, 1146.4726225935997, 1175.1421462332546, 19112.713309300372, 19764.308249211495, 19792.70310945337, 20049.59900801976, 20379.286724964553, 1104.7403860092872, 1140.3272069479046, 1162.9360385178727, 1163.5171403867469, 1187.9287242765288, 10961.0, 11064.376912419915, 11146.164037697205, 11256.718582035515, 11283.66149015531, 493455.0, 493962.0, 501399.0, 507923.0, 512989.0, 90694.54652726694, 91611.54194228986, 92347.53826230826, 93256.53371733234, 93455.0, 1082.8592283003159, 1084.7938891610568, 1140.4639819284923, 1149.172595731089, 1161.9941900290614, 17360.305587776347, 17464.952102873867, 17765.200565974304, 17782.0, 18013.819861801214, 38008.80995595004, 38451.615483845926, 39264.80367598258, 40131.1973760529, 40278.19443611053, 52144.21783673324, 56486.71756641355, 57231.0, 57731.0, 57787.0, 8806.779830504289, 8899.911000890168, 8919.866202007104, 9109.635614575343, 9272.582733777132, 9315.953420232856, 11986.820197697216, 12325.938370308091, 12495.25028498293, 12525.74948501043, 10697.839532407175, 10924.235303528676, 11094.611688590861, 11374.090072793992, 11508.309501429942, 10910.836337454786, 11012.724681883017, 11025.44872756343, 11205.943970280096, 11312.321260724382, 11396.373199474108, 11525.88474115248, 11591.420428978687, 11630.825537617111, 11687.357195354338, 8960.103989600988, 8988.28093752485, 9051.657594757187, 9115.0, 9215.216706580015, 8627.35294852876, 11577.942110289732, 11906.642800715992, 11909.82135267989, 11960.64118076459], "value": 10286.386579344125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.5683686986076, 1573.4571572807376, 1743.6948534006547, 1797.1463554811467, 1808.5297822566145, 8578.39951203416, 8711.869321960176, 8793.868091978626, 8806.691765788191, 8842.51366174861, 8843.690470833522, 8901.287896968242, 8923.063078376774, 8931.464112153275, 8982.416142950704, 2442.8534287942693, 2468.5926822074334, 2475.1708177760383, 2476.554220240365, 2482.056818409002, 2455.1897873701637, 2526.84838909666, 2526.861022643754, 2526.936826579341, 2529.519391315653, 2440.4386990992084, 2447.19242649926, 2488.713797913245, 2496.400863792686, 2505.574052411085, 2431.1490978157767, 2437.475942672325, 2443.2914454808083, 2443.5479436304163, 2458.2625212436287, 2446.339488338139, 2448.987755061231, 2458.9754102458924, 2469.2098528470897, 2507.0849140063747, 8894.155055269739, 8933.59798809055, 8957.507337096456, 8974.596143173507, 8978.595963181608, 5297.973510132425, 5390.6226564140525, 5428.67427954324, 5438.755256013489, 5452.073147564884, 3479.425894727367, 3480.7911525308564, 3537.398642230827, 3560.1455650643916, 3561.519194908706, 1178.5816035307514, 1190.1133655426763, 1201.2192075151222, 1210.2435977514053, 1223.0, 12599.811002834966, 12603.747925041447, 12642.2414655121, 12707.174033687874, 12718.236905785683, 4704.129735998851, 4754.786034628381, 4755.239161734106, 4777.880552986203, 4789.449213340441, 10092.798144037079, 10109.898901011044, 10119.24105692076, 10120.342177758423, 10140.645077422254, 5467.781288748485, 5470.972645136749, 5472.808451704251, 5479.397266300703, 5537.307836520435, 4462.308342206963, 4847.2729090635985, 4929.580985616191, 4979.676321039121, 5076.593872490192, 4097.344424892003, 4129.896577886091, 4160.916781664349, 4197.160567886435, 4203.0543127796, 1225.9632211033684, 1252.2298786246392, 1254.874512548756, 1259.741752940645, 1278.3288773394042, 1065.3927261460892, 1082.9350238985687, 1087.2823936202226, 1099.587654629514, 1106.9335839849634, 6176.3514830943, 6221.96889015552, 6282.308946015934, 6282.874342513124, 6341.112244285804, 486.8247430924864, 494.4733858440749, 495.3016247091584, 495.46489791025607, 503.22754571732213, 4220.957790422118, 4223.472065991751, 4314.80583373749, 4322.135572885372, 4399.5160532341415, 10763.83854242187, 11112.277701949348, 11248.0, 11275.830862537068, 11344.092472602171, 11022.283551569122, 11054.226204165792, 11067.50196241171, 11073.889261107286, 11085.0, 7852.607369631495, 8026.799330016679, 8044.597770111471, 8049.6377663005305, 8433.325333973267, 5842.737076831468, 5915.260592425947, 6002.609830361012, 6009.338972713085, 6083.543734219863, 9344.719658410258, 9405.247580193705, 9452.95273523628, 9468.431894086378, 9623.807523849344, 9389.765255868384, 9526.904730952601, 9567.808643826946, 9705.320627556004, 9764.804703906024, 7122.60825654594, 7496.287852653989, 7686.154523002353, 8051.637676304464, 8260.710875119343, 8386.790330241793, 8498.532580707873, 8546.572671366283, 8581.14188581162, 8585.141485851365, 7377.852442951218, 7573.734919277799, 7595.240475952582, 7637.923620763721, 7659.617019149132, 7391.482596218213, 7498.512596681198, 7512.9624351880075, 7541.208173141741, 7558.055243094614, 7317.231690672403, 7318.975343452027, 7323.707051717872, 7371.152317483558, 7377.926220737724, 5079.568236699922, 5120.539151476236, 5172.689638621695, 5174.404943431554, 5196.0, 5373.892522149457, 5401.864953376197, 5404.675719456845, 5412.0, 5497.340319161726], "value": 4672.919934581647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.281238928338, 368.9280590284892, 373.05058625797346, 373.34850685553715, 376.37333839157805, 6569.277379488252, 6574.375434333737, 6635.104260924773, 6683.565568238061, 6694.96652516738, 6630.602163870171, 6674.799756007315, 6676.566023208488, 6697.732090716378, 6722.529422940396, 5105.821296254632, 5136.666116702421, 5136.948630513684, 5137.871553211181, 5151.793928242866, 5140.126178549637, 5151.6136289778415, 5152.175651895697, 5152.484751524855, 5162.174052151657, 5101.489851014888, 5102.821401250957, 5103.821366252182, 5110.0, 5110.565601923841, 4807.807687692505, 4918.606511479073, 4942.159832828428, 5103.668261562986, 5110.259012443194, 4282.807273672661, 4284.807183676711, 4296.677749168824, 4325.091730736549, 4334.804933777956, 6441.83895402614, 6445.001024841157, 6450.0, 6456.967715161441, 6462.868997925344, 5700.6579605223405, 5789.465791565239, 5912.586118971673, 5913.526917846562, 5922.7038648067855, 7019.333163349474, 7059.2234854166, 7064.0, 7072.8939065914055, 7073.752418665374, 4812.494688057738, 4832.178529649968, 4843.975780121112, 4857.587105096071, 4859.635527335464, 7363.079615048119, 7392.667329970164, 7440.0, 7446.702131914771, 7457.1051473822945, 4802.111609352281, 4922.163232250526, 4947.1837146871085, 4957.677750946177, 5005.399352077774, 4920.901581968341, 4940.6788558743565, 4971.279164521125, 4972.030454061495, 4986.950130498649, 5740.052891272893, 5763.510101641407, 5840.123981402823, 5846.7076646167525, 5860.208871802252, 7049.365557099885, 7080.92919070813, 7086.858262834818, 7090.751823686146, 7130.286971302932, 1756.3325936144438, 1773.733939908998, 1778.8221177882367, 1784.9910750446165, 1786.7230579260236, 1052.6631477927142, 1101.5373543111912, 1122.6126986189752, 1129.0403157316216, 1146.3236690352564, 6877.037214789933, 6887.070245516791, 6887.896681549781, 6907.723691052302, 6909.827254318682, 7246.275372462712, 7294.358769276871, 7296.854062918712, 7308.5614863108385, 7312.305330993547, 6844.4182244509775, 6848.589084654936, 6858.622775747382, 6864.691088901011, 6878.65606719672, 3889.1638297766117, 3927.7054220933546, 3955.564887862333, 3966.0679740261016, 3966.186931678999, 7582.772516824504, 7601.353884919733, 7629.7329593463965, 7651.69393224276, 7671.53970761756, 7513.647543442124, 7549.282818132268, 7562.0, 7573.939648449222, 7577.772666820004, 7699.653515591812, 7715.382769378436, 7738.845223095619, 7745.922540774633, 7768.145503994443, 7245.529040612343, 7383.040204773345, 7387.372073373824, 7414.8887766682465, 7435.814104647211, 7236.20401755796, 7236.565806051653, 7279.199288078201, 7291.0, 7304.379127774198, 7743.0, 7750.0, 7759.2628700275645, 7760.573168475788, 7769.572673503011, 4881.536254055859, 4928.581070609039, 4952.059108769322, 4955.1823949048, 4975.0, 7258.89111663336, 7389.889151662622, 7400.703971841066, 7402.222766609644, 7436.702531898663, 7087.681054352463, 7097.645117744195, 7137.964310178416, 7162.785116446515, 7168.139823221039, 7150.892736608851, 7155.892661610184, 7157.711611909906, 7160.498765086394, 7163.2478589747325, 6969.372756451944, 6993.545419547713, 7004.0544526488275, 7008.264132266038, 7018.33325834045, 7030.683619237249, 7179.533330333512, 7223.783286501413, 7229.060222171294, 7234.16807067194, 6881.587104773529, 7077.893831592633, 7087.64561771899, 7095.574265544084, 7101.928980710127], "value": 5334.5424196125105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.644351819922, 812.7439856445216, 841.3815845353666, 877.8683197520368, 883.982320353593, 14472.493462728806, 14581.270936453175, 14597.197154156516, 14633.634159146, 14681.192534410617, 12740.55408060718, 12760.80858787119, 12762.55331063413, 12837.743245135092, 12906.22562646242, 881.1320848963766, 895.7133717210495, 895.7939673875013, 896.0770406481334, 898.2993265253114, 760.0271652285084, 880.810625715471, 898.2050884966819, 898.7034278688018, 905.9411138275991, 929.7257309093834, 945.5697657565792, 948.2745699539857, 948.2840455456121, 948.672707915768, 929.029164523075, 935.2331088507426, 946.1579194516886, 946.1579194516886, 947.5262368815557, 690.1855810144078, 690.4200471603876, 690.5994523176596, 692.7852365766629, 693.4348505967671, 13517.0, 13563.321833908363, 13618.319084045757, 13625.591232263048, 13681.589552313446, 14023.0, 14611.488597899022, 14746.410143594243, 14796.0, 14828.777568336483, 10504.0, 10595.629152979609, 10729.517171727291, 11301.434928253555, 11432.0, 4679.134360143385, 4685.367475390813, 4779.0, 4785.186518291899, 4793.832215872462, 57842.7107864458, 57990.710046449916, 58201.0, 58222.41777582255, 58509.41490585082, 11632.127590430582, 11661.416929153509, 11851.466683999068, 11881.465334059814, 12026.518939242507, 21504.0, 21554.245601403876, 21581.460463488223, 21582.244621438174, 21628.243011494524, 8208.548529830916, 8327.875081873655, 8438.0, 8500.872486912702, 8687.869681954775, 4624.722516648944, 4802.423709154924, 4832.033593281358, 4888.95111048885, 4961.08219979305, 3632.6912212462234, 3684.9631503685155, 3688.7786732796117, 3693.4829123922673, 3694.4273637586216, 622.4615707413055, 652.2043107408954, 653.7875190563086, 655.2104713819836, 660.2934859700075, 734.8897665350133, 785.0696924144906, 796.7530065679658, 803.333233416263, 807.7415227127262, 10086.697399078039, 10123.797524049625, 10125.64560240388, 10166.593336266615, 10174.745631359276, 790.213737331359, 790.6600161930426, 797.1789057270904, 801.631249625179, 803.6423791412882, 4534.478534968521, 4765.285207218945, 4861.27080937855, 4870.659053866196, 4923.75381230937, 59728.0, 60652.393476065554, 60671.393286067454, 69681.65159174171, 69968.0, 56829.147562786595, 58217.0, 58796.11805822916, 59418.10872836911, 60254.0961885572, 53371.466285337425, 53537.0, 55370.44629553653, 55690.886182276125, 56123.158152627744, 9403.576839042124, 9478.763030924281, 9692.0, 9709.5145242739, 9772.218222542322, 37824.0, 39936.00159996023, 40051.599484004786, 40865.79567102146, 40965.79517102396, 48867.75566122147, 49297.753511232215, 49592.504074960234, 50907.98184036224, 52857.7357113212, 11373.260738052, 11652.592159274385, 12229.694257643274, 12968.935155324163, 13167.868321316664, 12990.090693651731, 13248.602541923758, 13771.311434428038, 14058.507952221624, 14339.856601434269, 13027.609171724864, 13147.408366623333, 13244.602661920158, 13736.725265494833, 13890.374933127832, 12789.552365667158, 12792.424340904869, 12837.422315995616, 12910.483580657045, 13050.738985220432, 12074.939625301817, 12477.937610312254, 12585.307808070644, 12701.174423662433, 13632.659183520094, 9979.550920208463, 10024.056540340684, 10054.34646747959, 10063.39619622825, 10153.543090560795, 10199.184065274909, 10233.232507561814, 10245.975402459993, 10329.070383665507, 10351.378917264989], "value": 7129.615320997378, "unit": "score"}], "name": "dromaeo_css", "value": 7768.178369025528, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 104.0, 112.0, 112.0, 113.0, 102.0, 112.0, 112.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 156.0, 175.0, 130.0, 152.0, 161.0, 132.0, 197.0, 133.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 162.0, 162.0, 161.0, 165.0, 161.0, 161.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 78.0, 186.0, 73.0, 77.0, 74.0, 85.0, 167.0, 76.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 160.0, 93.0, 93.0, 92.0, 148.0, 91.0, 92.0, 141.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 146.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 59.0, 55.0, 58.0, 56.0, 59.0, 67.0, 55.0, 55.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 74.0, 82.0, 75.0, 76.0, 77.0, 74.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 113.0, 123.0, 117.0, 115.0, 114.0, 112.0, 129.0, 124.0], "value": 119.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 163.0, 160.0, 158.0, 159.0, 160.0, 158.0, 159.0, 160.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 70.0, 69.0, 70.0, 68.0, 69.0, 74.0, 66.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1529.1, "alertThreshold": 2.0}]} 04:24:41 INFO - Return code: 0 04:24:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:24:41 ERROR - # TBPL SUCCESS # 04:24:41 INFO - Running post-action listener: _resource_record_post_action 04:24:41 INFO - Running post-run listener: _resource_record_post_run 04:24:42 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 501440512; Read time: 0; Write time: 457424 04:24:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249483264; Read time: 0; Write time: 301356 04:24:42 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 251957248; Read time: 0; Write time: 156068 04:24:42 INFO - Running post-run listener: _upload_blobber_files 04:24:42 INFO - Blob upload gear active. 04:24:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:24:42 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 04:24:42 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'] 04:24:42 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 04:24:42 INFO - (blobuploader) - INFO - Open directory for files ... 04:24:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:24:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:24:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:43 INFO - (blobuploader) - INFO - Done attempting. 04:24:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:24:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:24:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:44 INFO - (blobuploader) - INFO - Done attempting. 04:24:44 INFO - (blobuploader) - INFO - Iteration through files over. 04:24:44 INFO - Return code: 0 04:24:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:24:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:24:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ed9f8ad0fd26da0e287a7c2bb1d0bbd69500e5ea7a97c214f947edbe42ebb6bb032ac2a46f8abab2fed85be8c714fbed86bbd6b25dffec31e1f4f099b149e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81c99c9acfcf488d6fe8abfda68946c2f082e9c0e70cb118ecd4dcaa2f8a6df43b8b79a3755930b6fb68d3f41ea284c981aeffae9fa90304da195cfad756a6cd"} 04:24:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:24:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:24:44 INFO - Contents: 04:24:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ed9f8ad0fd26da0e287a7c2bb1d0bbd69500e5ea7a97c214f947edbe42ebb6bb032ac2a46f8abab2fed85be8c714fbed86bbd6b25dffec31e1f4f099b149e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81c99c9acfcf488d6fe8abfda68946c2f082e9c0e70cb118ecd4dcaa2f8a6df43b8b79a3755930b6fb68d3f41ea284c981aeffae9fa90304da195cfad756a6cd"} 04:24:44 INFO - Running post-run listener: copy_logs_to_upload_dir 04:24:44 INFO - Copying logs to upload dir... 04:24:44 INFO - mkdir: /builds/slave/test/build/upload/logs 04:24:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.133543 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-06 04:24:43.115332) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 04:24:43.119183) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ed9f8ad0fd26da0e287a7c2bb1d0bbd69500e5ea7a97c214f947edbe42ebb6bb032ac2a46f8abab2fed85be8c714fbed86bbd6b25dffec31e1f4f099b149e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81c99c9acfcf488d6fe8abfda68946c2f082e9c0e70cb118ecd4dcaa2f8a6df43b8b79a3755930b6fb68d3f41ea284c981aeffae9fa90304da195cfad756a6cd"} build_url:https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ed9f8ad0fd26da0e287a7c2bb1d0bbd69500e5ea7a97c214f947edbe42ebb6bb032ac2a46f8abab2fed85be8c714fbed86bbd6b25dffec31e1f4f099b149e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81c99c9acfcf488d6fe8abfda68946c2f082e9c0e70cb118ecd4dcaa2f8a6df43b8b79a3755930b6fb68d3f41ea284c981aeffae9fa90304da195cfad756a6cd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 04:24:43.145280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:24:43.145635) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465211057.775948-1740799744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 04:24:43.233041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 04:24:43.233405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 04:24:43.233790) ========= ========= Total master_lag: 0.17 =========