builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1461152345.03 results: success (0) buildid: 20160420015738 builduid: 04b97639d3d34b7492e51a968cfd8920 revision: 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:05.029853) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:05.030373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:05.030655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:05.043959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:05.044250) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 04:39:05-- 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% 227M=0s 2016-04-20 04:39:05 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080036 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:05.135180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:05.135497) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:05.185315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 04:39:05.185679) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 --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 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 04:39:05,339 truncating revision to first 12 chars 2016-04-20 04:39:05,339 Setting DEBUG logging. 2016-04-20 04:39:05,339 attempt 1/10 2016-04-20 04:39:05,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/834fed3f42db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 04:39:06,069 unpacking tar archive at: mozilla-aurora-834fed3f42db/testing/mozharness/ program finished with exit code 0 elapsedTime=1.000128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 04:39:06.199403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:06.199757) ========= script_repo_revision: 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:06.200197) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:06.200480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:39:06.209671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-20 04:39:06.210059) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:39:06 INFO - MultiFileLogger online at 20160420 04:39:06 in /builds/slave/test 04:39:06 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:39:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:39:06 INFO - {'append_to_log': False, 04:39:06 INFO - 'base_work_dir': '/builds/slave/test', 04:39:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:39:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:39:06 INFO - 'branch': 'Mozilla-Aurora', 04:39:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:39:06 INFO - 'config_files': ('talos/linux_config.py',), 04:39:06 INFO - 'default_actions': ('clobber', 04:39:06 INFO - 'read-buildbot-config', 04:39:06 INFO - 'download-and-extract', 04:39:06 INFO - 'populate-webroot', 04:39:06 INFO - 'create-virtualenv', 04:39:06 INFO - 'install', 04:39:06 INFO - 'run-tests'), 04:39:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:39:06 INFO - 'download_minidump_stackwalk': True, 04:39:06 INFO - 'download_symbols': 'ondemand', 04:39:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:39:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:39:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:39:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:39:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:39:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:39:06 INFO - 'installer_path': 'installer.exe', 04:39:06 INFO - 'log_level': 'info', 04:39:06 INFO - 'log_name': 'talos', 04:39:06 INFO - 'log_to_console': True, 04:39:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:39:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:39:06 INFO - 'opt_config_files': (), 04:39:06 INFO - 'pip_index': False, 04:39:06 INFO - 'sps_profile': False, 04:39:06 INFO - 'sps_profile_interval': 0, 04:39:06 INFO - 'suite': 'dromaeojs-e10s', 04:39:06 INFO - 'system_bits': '32', 04:39:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:39:06 INFO - 'title': 'talos-linux64-ix-038', 04:39:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:39:06 INFO - 'use_talos_json': True, 04:39:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:39:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:39:06 INFO - 'work_dir': 'build'} 04:39:06 INFO - ##### 04:39:06 INFO - ##### Running clobber step. 04:39:06 INFO - ##### 04:39:06 INFO - Running pre-action listener: _resource_record_pre_action 04:39:06 INFO - Running main action method: clobber 04:39:06 INFO - rmtree: /builds/slave/test/build 04:39:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:39:06 INFO - Running post-action listener: _resource_record_post_action 04:39:06 INFO - ##### 04:39:06 INFO - ##### Running read-buildbot-config step. 04:39:06 INFO - ##### 04:39:06 INFO - Running pre-action listener: _resource_record_pre_action 04:39:06 INFO - Running main action method: read_buildbot_config 04:39:06 INFO - Using buildbot properties: 04:39:06 INFO - { 04:39:06 INFO - "project": "", 04:39:06 INFO - "product": "firefox", 04:39:06 INFO - "script_repo_revision": "production", 04:39:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:39:06 INFO - "repository": "", 04:39:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:39:06 INFO - "buildid": "20160420015738", 04:39:06 INFO - "pgo_build": "True", 04:39:06 INFO - "basedir": "/builds/slave/test", 04:39:06 INFO - "buildnumber": 218, 04:39:06 INFO - "slavename": "talos-linux64-ix-038", 04:39:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:39:06 INFO - "platform": "ubuntu64_hw", 04:39:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:39:06 INFO - "branch": "mozilla-aurora", 04:39:06 INFO - "repo_path": "releases/mozilla-aurora", 04:39:06 INFO - "revision": "834fed3f42db37b6427d1140a6e32a3cb6af1ed9", 04:39:06 INFO - "stage_platform": "linux64-pgo", 04:39:06 INFO - "builduid": "04b97639d3d34b7492e51a968cfd8920", 04:39:06 INFO - "slavebuilddir": "test" 04:39:06 INFO - } 04:39:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 04:39:06 INFO - Running post-action listener: _resource_record_post_action 04:39:06 INFO - ##### 04:39:06 INFO - ##### Running download-and-extract step. 04:39:06 INFO - ##### 04:39:06 INFO - Running pre-action listener: _resource_record_pre_action 04:39:06 INFO - Running main action method: download_and_extract 04:39:06 INFO - mkdir: /builds/slave/test/build/tests 04:39:06 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:39:06 INFO - https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:39:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 04:39:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 04:39:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 04:39:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:39:07 INFO - Downloaded 1448 bytes. 04:39:07 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 04:39:07 INFO - Using the following test package requirements: 04:39:07 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 04:39:07 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 04:39:07 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:39:07 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 04:39:07 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:39:07 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 04:39:07 INFO - u'jsshell-linux-x86_64.zip'], 04:39:07 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 04:39:07 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:39:07 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 04:39:07 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 04:39:07 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:39:07 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 04:39:07 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:39:07 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 04:39:07 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:39:07 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 04:39:07 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 04:39:07 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:39:07 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:07 INFO - https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:39:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 04:39:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 04:39:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 04:39:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:39:08 INFO - Downloaded 23352759 bytes. 04:39:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:39:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:39:10 INFO - Return code: 0 04:39:10 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:39: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:39:10 INFO - https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:39:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 04:39:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 04:39:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 04:39:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:39:11 INFO - Downloaded 23352759 bytes. 04:39:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:39:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:39:12 INFO - Return code: 0 04:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:12 INFO - https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:39:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 04:39:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 04:39:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 04:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:39:13 INFO - Downloaded 10845168 bytes. 04:39:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:39:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:39:14 INFO - Return code: 0 04:39:14 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:39:14 INFO - https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:39:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 04:39:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 04:39:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 04:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:39:15 INFO - Downloaded 60597462 bytes. 04:39:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 04:39:15 INFO - mkdir: /builds/slave/test/properties 04:39:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:15 INFO - Contents: 04:39:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 04:39:16 INFO - Running post-action listener: _resource_record_post_action 04:39:16 INFO - Running post-action listener: set_extra_try_arguments 04:39:16 INFO - ##### 04:39:16 INFO - ##### Running populate-webroot step. 04:39:16 INFO - ##### 04:39:16 INFO - Running pre-action listener: _resource_record_pre_action 04:39:16 INFO - Running main action method: populate_webroot 04:39:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:16 INFO - '--tppagecycles', 04:39:16 INFO - '7'], 04:39:16 INFO - 'tests': ['tsvgm']}}, 04:39:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:39:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:39:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:39:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:39:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:16 INFO - 'talos_options': ['--e10s'], 04:39:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:16 INFO - 'tests': ['damp', 'tps']}, 04:39:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:16 INFO - 'talos_options': ['--e10s'], 04:39:16 INFO - 'tests': ['damp', 'tps']}, 04:39:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:39:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:16 INFO - 'other': {'tests': ['a11yr', 04:39:16 INFO - 'ts_paint', 04:39:16 INFO - 'tpaint', 04:39:16 INFO - 'sessionrestore', 04:39:16 INFO - 'sessionrestore_no_auto_restore', 04:39:16 INFO - 'tabpaint']}, 04:39:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:39:16 INFO - 'tests': ['a11yr', 04:39:16 INFO - 'ts_paint', 04:39:16 INFO - 'tpaint', 04:39:16 INFO - 'sessionrestore', 04:39:16 INFO - 'sessionrestore_no_auto_restore', 04:39:16 INFO - 'tabpaint']}, 04:39:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:39:16 INFO - 'tests': ['a11yr', 04:39:16 INFO - 'ts_paint', 04:39:16 INFO - 'tpaint', 04:39:16 INFO - 'sessionrestore', 04:39:16 INFO - 'sessionrestore_no_auto_restore', 04:39:16 INFO - 'tabpaint']}, 04:39:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:39:16 INFO - 'tests': ['a11yr', 04:39:16 INFO - 'ts_paint', 04:39:16 INFO - 'tpaint', 04:39:16 INFO - 'sessionrestore', 04:39:16 INFO - 'sessionrestore_no_auto_restore', 04:39:16 INFO - 'tabpaint']}, 04:39:16 INFO - 'other_l64': {'tests': ['a11yr', 04:39:16 INFO - 'ts_paint', 04:39:16 INFO - 'tpaint', 04:39:16 INFO - 'sessionrestore', 04:39:16 INFO - 'sessionrestore_no_auto_restore', 04:39:16 INFO - 'tabpaint']}, 04:39:16 INFO - 'other_nol64': {'tests': ['a11yr', 04:39:16 INFO - 'ts_paint', 04:39:16 INFO - 'tpaint', 04:39:16 INFO - 'sessionrestore', 04:39:16 INFO - 'sessionrestore_no_auto_restore', 04:39:16 INFO - 'tabpaint']}, 04:39:16 INFO - 'svgr': {'tests': ['tsvgx', 04:39:16 INFO - 'tsvgr_opacity', 04:39:16 INFO - 'tart', 04:39:16 INFO - 'tscrollx', 04:39:16 INFO - 'cart']}, 04:39:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:39:16 INFO - 'tests': ['tsvgx', 04:39:16 INFO - 'tsvgr_opacity', 04:39:16 INFO - 'tart', 04:39:16 INFO - 'tscrollx', 04:39:16 INFO - 'cart']}, 04:39:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:16 INFO - 'tests': ['tp5o']}, 04:39:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:16 INFO - 'talos_options': ['--e10s'], 04:39:16 INFO - 'tests': ['tp5o']}, 04:39:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:16 INFO - 'talos_options': ['--xperf_path', 04:39:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:16 INFO - 'tests': ['tp5n']}, 04:39:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:16 INFO - 'talos_options': ['--e10s', 04:39:16 INFO - '--xperf_path', 04:39:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:16 INFO - 'tests': ['tp5n']}}, 04:39:16 INFO - 'talos.zip': {'path': '', 04:39:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:16 INFO - Running post-action listener: _resource_record_post_action 04:39:16 INFO - ##### 04:39:16 INFO - ##### Running create-virtualenv step. 04:39:16 INFO - ##### 04:39:16 INFO - Running pre-action listener: _resource_record_pre_action 04:39:16 INFO - Running main action method: create_virtualenv 04:39:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:16 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:39:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:16 INFO - Using real prefix '/usr' 04:39:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:19 INFO - Installing pip.................done. 04:39:19 INFO - Return code: 0 04:39:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:19 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 0x7fc4006aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2979410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', '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:39:19 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:39:19 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:39:19 INFO - Using env: {'DISPLAY': ':0', 04:39:19 INFO - 'HOME': '/home/cltbld', 04:39:19 INFO - 'LANG': 'en_US.UTF-8', 04:39:19 INFO - 'LANGUAGE': 'en_US:en', 04:39:19 INFO - 'LOGNAME': 'cltbld', 04:39:19 INFO - 'MAIL': '/var/mail/cltbld', 04:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:19 INFO - 'MOZ_NO_REMOTE': '1', 04:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:19 INFO - 'NO_EM_RESTART': '1', 04:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:19 INFO - 'PWD': '/builds/slave/test', 04:39:19 INFO - 'SHELL': '/bin/bash', 04:39:19 INFO - 'SHLVL': '1', 04:39:19 INFO - 'TERM': 'linux', 04:39:19 INFO - 'TMOUT': '86400', 04:39:19 INFO - 'USER': 'cltbld', 04:39:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:19 INFO - '_': '/tools/buildbot/bin/python'} 04:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:19 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:39:19 INFO - Cleaning up... 04:39:19 INFO - Return code: 0 04:39:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:19 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 0x7fc4006aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2979410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', '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:39:19 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:39:19 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:39:19 INFO - Using env: {'DISPLAY': ':0', 04:39:19 INFO - 'HOME': '/home/cltbld', 04:39:19 INFO - 'LANG': 'en_US.UTF-8', 04:39:19 INFO - 'LANGUAGE': 'en_US:en', 04:39:19 INFO - 'LOGNAME': 'cltbld', 04:39:19 INFO - 'MAIL': '/var/mail/cltbld', 04:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:19 INFO - 'MOZ_NO_REMOTE': '1', 04:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:19 INFO - 'NO_EM_RESTART': '1', 04:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:19 INFO - 'PWD': '/builds/slave/test', 04:39:19 INFO - 'SHELL': '/bin/bash', 04:39:19 INFO - 'SHLVL': '1', 04:39:19 INFO - 'TERM': 'linux', 04:39:19 INFO - 'TMOUT': '86400', 04:39:19 INFO - 'USER': 'cltbld', 04:39:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:19 INFO - '_': '/tools/buildbot/bin/python'} 04:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:19 INFO - Downloading/unpacking psutil>=0.7.1 04:39:19 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:39:19 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:39:19 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:39:19 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:39:19 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:39:19 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:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:21 INFO - Installing collected packages: psutil 04:39:21 INFO - Running setup.py install for psutil 04:39:21 INFO - building 'psutil._psutil_linux' extension 04:39:21 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:39:21 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:39:21 INFO - building 'psutil._psutil_posix' extension 04:39:21 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:39:22 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:39:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:22 INFO - Successfully installed psutil 04:39:22 INFO - Cleaning up... 04:39:22 INFO - Return code: 0 04:39:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc4006aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2979410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', '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:39:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:39:22 INFO - Using env: {'DISPLAY': ':0', 04:39:22 INFO - 'HOME': '/home/cltbld', 04:39:22 INFO - 'LANG': 'en_US.UTF-8', 04:39:22 INFO - 'LANGUAGE': 'en_US:en', 04:39:22 INFO - 'LOGNAME': 'cltbld', 04:39:22 INFO - 'MAIL': '/var/mail/cltbld', 04:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:22 INFO - 'MOZ_NO_REMOTE': '1', 04:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:22 INFO - 'NO_EM_RESTART': '1', 04:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:22 INFO - 'PWD': '/builds/slave/test', 04:39:22 INFO - 'SHELL': '/bin/bash', 04:39:22 INFO - 'SHLVL': '1', 04:39:22 INFO - 'TERM': 'linux', 04:39:22 INFO - 'TMOUT': '86400', 04:39:22 INFO - 'USER': 'cltbld', 04:39:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:22 INFO - '_': '/tools/buildbot/bin/python'} 04:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:39:22 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:39:22 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:39:22 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:39:22 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:39:22 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:39:22 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:39:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:24 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:39:24 INFO - Installing collected packages: mozsystemmonitor 04:39:24 INFO - Running setup.py install for mozsystemmonitor 04:39:24 INFO - Successfully installed mozsystemmonitor 04:39:24 INFO - Cleaning up... 04:39:24 INFO - Return code: 0 04:39:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:24 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 0x7fc4006aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2979410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', '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:39:24 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:39:24 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:39:24 INFO - Using env: {'DISPLAY': ':0', 04:39:24 INFO - 'HOME': '/home/cltbld', 04:39:24 INFO - 'LANG': 'en_US.UTF-8', 04:39:24 INFO - 'LANGUAGE': 'en_US:en', 04:39:24 INFO - 'LOGNAME': 'cltbld', 04:39:24 INFO - 'MAIL': '/var/mail/cltbld', 04:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:24 INFO - 'MOZ_NO_REMOTE': '1', 04:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:24 INFO - 'NO_EM_RESTART': '1', 04:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:24 INFO - 'PWD': '/builds/slave/test', 04:39:24 INFO - 'SHELL': '/bin/bash', 04:39:24 INFO - 'SHLVL': '1', 04:39:24 INFO - 'TERM': 'linux', 04:39:24 INFO - 'TMOUT': '86400', 04:39:24 INFO - 'USER': 'cltbld', 04:39:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:24 INFO - '_': '/tools/buildbot/bin/python'} 04:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:24 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:39:24 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:39:24 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:39:24 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:39:24 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:39:24 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:39:27 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:28 INFO - Downloading docopt-0.6.1.tar.gz 04:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:28 INFO - Running setup.py install for blobuploader 04:39:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:28 INFO - Running setup.py install for requests 04:39:28 INFO - Running setup.py install for docopt 04:39:28 INFO - Successfully installed blobuploader requests docopt 04:39:28 INFO - Cleaning up... 04:39:29 INFO - Return code: 0 04:39:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:29 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 0x7fc4006aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2979410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', '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:39:29 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:39:29 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:39:29 INFO - Using env: {'DISPLAY': ':0', 04:39:29 INFO - 'HOME': '/home/cltbld', 04:39:29 INFO - 'LANG': 'en_US.UTF-8', 04:39:29 INFO - 'LANGUAGE': 'en_US:en', 04:39:29 INFO - 'LOGNAME': 'cltbld', 04:39:29 INFO - 'MAIL': '/var/mail/cltbld', 04:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:29 INFO - 'MOZ_NO_REMOTE': '1', 04:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:29 INFO - 'NO_EM_RESTART': '1', 04:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:29 INFO - 'PWD': '/builds/slave/test', 04:39:29 INFO - 'SHELL': '/bin/bash', 04:39:29 INFO - 'SHLVL': '1', 04:39:29 INFO - 'TERM': 'linux', 04:39:29 INFO - 'TMOUT': '86400', 04:39:29 INFO - 'USER': 'cltbld', 04:39:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:29 INFO - '_': '/tools/buildbot/bin/python'} 04:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:29 INFO - Running setup.py (path:/tmp/pip-jqU3sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:29 INFO - Running setup.py (path:/tmp/pip-50R4sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:29 INFO - Running setup.py (path:/tmp/pip-cvMKgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:29 INFO - Running setup.py (path:/tmp/pip-5whfwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:29 INFO - Running setup.py (path:/tmp/pip-EsJUOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:29 INFO - Running setup.py (path:/tmp/pip-YXdXE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:29 INFO - Running setup.py (path:/tmp/pip-V1DE38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:29 INFO - Running setup.py (path:/tmp/pip-GGdzDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:29 INFO - Running setup.py (path:/tmp/pip-b6WK6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:29 INFO - Running setup.py (path:/tmp/pip-gGzh2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:29 INFO - Running setup.py (path:/tmp/pip-9n6JSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:30 INFO - Running setup.py (path:/tmp/pip-UY2gR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:30 INFO - Running setup.py (path:/tmp/pip-lClYx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:30 INFO - Running setup.py (path:/tmp/pip-Lu2jG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:30 INFO - Running setup.py (path:/tmp/pip-r4eRDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:30 INFO - Running setup.py (path:/tmp/pip-v1IslP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:30 INFO - Running setup.py (path:/tmp/pip-QvxFkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:30 INFO - Running setup.py install for manifestparser 04:39:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:30 INFO - Running setup.py install for mozcrash 04:39:30 INFO - Running setup.py install for mozdebug 04:39:30 INFO - Running setup.py install for mozdevice 04:39:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:30 INFO - Running setup.py install for mozfile 04:39:31 INFO - Running setup.py install for mozhttpd 04:39:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Running setup.py install for mozinfo 04:39:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Running setup.py install for mozInstall 04:39:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Running setup.py install for mozleak 04:39:31 INFO - Running setup.py install for mozlog 04:39:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Running setup.py install for moznetwork 04:39:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Running setup.py install for mozprocess 04:39:31 INFO - Running setup.py install for mozprofile 04:39:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Running setup.py install for mozrunner 04:39:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:31 INFO - Running setup.py install for mozscreenshot 04:39:32 INFO - Running setup.py install for moztest 04:39:32 INFO - Running setup.py install for mozversion 04:39:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:32 INFO - Cleaning up... 04:39:32 INFO - Return code: 0 04:39:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39: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:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:32 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 0x7fc4006aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2979410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', '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:39:32 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:39:32 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:39:32 INFO - Using env: {'DISPLAY': ':0', 04:39:32 INFO - 'HOME': '/home/cltbld', 04:39:32 INFO - 'LANG': 'en_US.UTF-8', 04:39:32 INFO - 'LANGUAGE': 'en_US:en', 04:39:32 INFO - 'LOGNAME': 'cltbld', 04:39:32 INFO - 'MAIL': '/var/mail/cltbld', 04:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:32 INFO - 'MOZ_NO_REMOTE': '1', 04:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:32 INFO - 'NO_EM_RESTART': '1', 04:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:32 INFO - 'PWD': '/builds/slave/test', 04:39:32 INFO - 'SHELL': '/bin/bash', 04:39:32 INFO - 'SHLVL': '1', 04:39:32 INFO - 'TERM': 'linux', 04:39:32 INFO - 'TMOUT': '86400', 04:39:32 INFO - 'USER': 'cltbld', 04:39:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:32 INFO - '_': '/tools/buildbot/bin/python'} 04:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:32 INFO - Running setup.py (path:/tmp/pip-Tvl3fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:32 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:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:32 INFO - Running setup.py (path:/tmp/pip-v0Q4rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:32 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:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:32 INFO - Running setup.py (path:/tmp/pip-9wMBCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:32 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:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:32 INFO - Running setup.py (path:/tmp/pip-Brl8OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:32 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:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:32 INFO - Running setup.py (path:/tmp/pip-hxBVkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:32 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:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:32 INFO - Running setup.py (path:/tmp/pip-0dydlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:32 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:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:32 INFO - Running setup.py (path:/tmp/pip-rlvQ_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:32 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:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:32 INFO - Running setup.py (path:/tmp/pip-XYsnBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:33 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:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:33 INFO - Running setup.py (path:/tmp/pip-WeYrJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:33 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:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:33 INFO - Running setup.py (path:/tmp/pip-jPKAeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:33 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:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:33 INFO - Running setup.py (path:/tmp/pip-U_Mu0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:33 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:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:33 INFO - Running setup.py (path:/tmp/pip-b6oHff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:33 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:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:33 INFO - Running setup.py (path:/tmp/pip-uGygxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:33 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:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:33 INFO - Running setup.py (path:/tmp/pip-Jr2uq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:33 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:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:33 INFO - Running setup.py (path:/tmp/pip-eY2duf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:33 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:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:33 INFO - Running setup.py (path:/tmp/pip-kPs0JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:33 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:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:33 INFO - Running setup.py (path:/tmp/pip-7iAMeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:35 INFO - Downloading blessings-1.6.tar.gz 04:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:35 INFO - Installing collected packages: blessings 04:39:35 INFO - Running setup.py install for blessings 04:39:35 INFO - Successfully installed blessings 04:39:35 INFO - Cleaning up... 04:39:35 INFO - Return code: 0 04:39:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:36 INFO - Reading from file tmpfile_stdout 04:39:36 INFO - Current package versions: 04:39:36 INFO - argparse == 1.2.1 04:39:36 INFO - blessings == 1.6 04:39:36 INFO - blobuploader == 1.2.4 04:39:36 INFO - docopt == 0.6.1 04:39:36 INFO - manifestparser == 1.1 04:39:36 INFO - mozInstall == 1.12 04:39:36 INFO - mozcrash == 0.17 04:39:36 INFO - mozdebug == 0.1 04:39:36 INFO - mozdevice == 0.48 04:39:36 INFO - mozfile == 1.2 04:39:36 INFO - mozhttpd == 0.7 04:39:36 INFO - mozinfo == 0.9 04:39:36 INFO - mozleak == 0.1 04:39:36 INFO - mozlog == 3.1 04:39:36 INFO - moznetwork == 0.27 04:39:36 INFO - mozprocess == 0.22 04:39:36 INFO - mozprofile == 0.28 04:39:36 INFO - mozrunner == 6.11 04:39:36 INFO - mozscreenshot == 0.1 04:39:36 INFO - mozsystemmonitor == 0.0 04:39:36 INFO - moztest == 0.7 04:39:36 INFO - mozversion == 1.4 04:39:36 INFO - psutil == 3.1.1 04:39:36 INFO - requests == 1.2.3 04:39:36 INFO - wsgiref == 0.1.2 04:39:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:36 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 0x7fc4006aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2979410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', '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:39:36 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:39:36 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:39:36 INFO - Using env: {'DISPLAY': ':0', 04:39:36 INFO - 'HOME': '/home/cltbld', 04:39:36 INFO - 'LANG': 'en_US.UTF-8', 04:39:36 INFO - 'LANGUAGE': 'en_US:en', 04:39:36 INFO - 'LOGNAME': 'cltbld', 04:39:36 INFO - 'MAIL': '/var/mail/cltbld', 04:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:36 INFO - 'MOZ_NO_REMOTE': '1', 04:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:36 INFO - 'NO_EM_RESTART': '1', 04:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:36 INFO - 'PWD': '/builds/slave/test', 04:39:36 INFO - 'SHELL': '/bin/bash', 04:39:36 INFO - 'SHLVL': '1', 04:39:36 INFO - 'TERM': 'linux', 04:39:36 INFO - 'TMOUT': '86400', 04:39:36 INFO - 'USER': 'cltbld', 04:39:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:36 INFO - '_': '/tools/buildbot/bin/python'} 04:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 INFO - Cleaning up... 04:39:36 INFO - Return code: 0 04:39:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4006aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2979410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', '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:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:39:36 INFO - Using env: {'DISPLAY': ':0', 04:39:36 INFO - 'HOME': '/home/cltbld', 04:39:36 INFO - 'LANG': 'en_US.UTF-8', 04:39:36 INFO - 'LANGUAGE': 'en_US:en', 04:39:36 INFO - 'LOGNAME': 'cltbld', 04:39:36 INFO - 'MAIL': '/var/mail/cltbld', 04:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:36 INFO - 'MOZ_NO_REMOTE': '1', 04:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:36 INFO - 'NO_EM_RESTART': '1', 04:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:36 INFO - 'PWD': '/builds/slave/test', 04:39:36 INFO - 'SHELL': '/bin/bash', 04:39:36 INFO - 'SHLVL': '1', 04:39:36 INFO - 'TERM': 'linux', 04:39:36 INFO - 'TMOUT': '86400', 04:39:36 INFO - 'USER': 'cltbld', 04:39:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:36 INFO - '_': '/tools/buildbot/bin/python'} 04:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:36 INFO - Downloading/unpacking jsonschema 04:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:38 INFO - Downloading/unpacking functools32 (from jsonschema) 04:39: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:39: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:39: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:39: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:39: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:39: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:39:38 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:38 INFO - warning: no files found matching '*.txt' 04:39:38 INFO - no previously-included directories found matching 'build' 04:39:38 INFO - no previously-included directories found matching 'dist' 04:39:38 INFO - no previously-included directories found matching '.git*' 04:39:38 INFO - Installing collected packages: jsonschema, functools32 04:39:38 INFO - Running setup.py install for functools32 04:39:38 INFO - warning: no files found matching '*.txt' 04:39:38 INFO - no previously-included directories found matching 'build' 04:39:38 INFO - no previously-included directories found matching 'dist' 04:39:38 INFO - no previously-included directories found matching '.git*' 04:39:38 INFO - Successfully installed jsonschema functools32 04:39:38 INFO - Cleaning up... 04:39:38 INFO - Return code: 0 04:39:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:39:38 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:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:38 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:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:38 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 0x7fc4006aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2979410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', '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:39:38 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:39:38 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:39:38 INFO - Using env: {'DISPLAY': ':0', 04:39:38 INFO - 'HOME': '/home/cltbld', 04:39:38 INFO - 'LANG': 'en_US.UTF-8', 04:39:38 INFO - 'LANGUAGE': 'en_US:en', 04:39:38 INFO - 'LOGNAME': 'cltbld', 04:39:38 INFO - 'MAIL': '/var/mail/cltbld', 04:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:38 INFO - 'MOZ_NO_REMOTE': '1', 04:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:38 INFO - 'NO_EM_RESTART': '1', 04:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:38 INFO - 'PWD': '/builds/slave/test', 04:39:38 INFO - 'SHELL': '/bin/bash', 04:39:38 INFO - 'SHLVL': '1', 04:39:38 INFO - 'TERM': 'linux', 04:39:38 INFO - 'TMOUT': '86400', 04:39:38 INFO - 'USER': 'cltbld', 04:39:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:38 INFO - '_': '/tools/buildbot/bin/python'} 04:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:39 INFO - Downloading/unpacking flake8 04:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39: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:39: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:39: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:39: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:39: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:39: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:39:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:41 INFO - no previously-included directories found matching 'docs/_build' 04:39:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:41 INFO - Running setup.py install for pep8 04:39:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:41 INFO - no previously-included directories found matching 'docs/_build' 04:39:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:41 INFO - Cleaning up... 04:39:41 INFO - Return code: 0 04:39:41 INFO - Running post-action listener: _resource_record_post_action 04:39:41 INFO - Running post-action listener: _start_resource_monitoring 04:39:41 INFO - Starting resource monitoring. 04:39:41 INFO - ##### 04:39:41 INFO - ##### Running install step. 04:39:41 INFO - ##### 04:39:41 INFO - Running pre-action listener: _resource_record_pre_action 04:39:41 INFO - Running main action method: install 04:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:42 INFO - Reading from file tmpfile_stdout 04:39:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:42 INFO - Reading from file tmpfile_stdout 04:39:42 INFO - Output received: 04:39:42 INFO - Usage: mozinstall [options] installer 04:39:42 INFO - Options: 04:39:42 INFO - -h, --help show this help message and exit 04:39:42 INFO - -d DEST, --destination=DEST 04:39:42 INFO - Directory to install application into. [default: 04:39:42 INFO - "/builds/slave/test"] 04:39:42 INFO - --app=APP Application being installed. [default: firefox] 04:39:42 INFO - mkdir: /builds/slave/test/build/application 04:39:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:39:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:39:58 INFO - Reading from file tmpfile_stdout 04:39:58 INFO - Output received: 04:39:58 INFO - /builds/slave/test/build/application/firefox/firefox 04:39:58 INFO - Running post-action listener: _resource_record_post_action 04:39:58 INFO - ##### 04:39:58 INFO - ##### Running run-tests step. 04:39:58 INFO - ##### 04:39:58 INFO - Running pre-action listener: _resource_record_pre_action 04:39:58 INFO - Running main action method: run_tests 04:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:58 INFO - Python 2.7.3 04:39:58 INFO - Return code: 0 04:39:58 INFO - grabbing minidump binary from tooltool 04:39:58 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:39:58 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 0x2a08160>, '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 0x2a09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a094f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:58 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:39:58 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:39:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:58 INFO - Return code: 0 04:39:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:39:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:39:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:39:59 INFO - Return code: 0 04:39:59 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/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:39:59 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/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:39:59 INFO - Using env: {'DISPLAY': ':0', 04:39:59 INFO - 'HOME': '/home/cltbld', 04:39:59 INFO - 'LANG': 'en_US.UTF-8', 04:39:59 INFO - 'LANGUAGE': 'en_US:en', 04:39:59 INFO - 'LOGNAME': 'cltbld', 04:39:59 INFO - 'MAIL': '/var/mail/cltbld', 04:39:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:59 INFO - 'MOZ_NO_REMOTE': '1', 04:39:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:59 INFO - 'NO_EM_RESTART': '1', 04:39:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:59 INFO - 'PWD': '/builds/slave/test', 04:39:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:59 INFO - 'SHELL': '/bin/bash', 04:39:59 INFO - 'SHLVL': '1', 04:39:59 INFO - 'TERM': 'linux', 04:39:59 INFO - 'TMOUT': '86400', 04:39:59 INFO - 'USER': 'cltbld', 04:39:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822', 04:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:59 INFO - '_': '/tools/buildbot/bin/python'} 04:39:59 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/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:39:59 INFO - mozversion application_buildid: 20160420015738 04:39:59 INFO - mozversion application_changeset: 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 04:39:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:39:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:59 INFO - mozversion application_name: Firefox 04:39:59 INFO - mozversion application_remotingname: firefox-dev 04:39:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:39:59 INFO - mozversion application_vendor: Mozilla 04:39:59 INFO - mozversion application_version: 47.0a2 04:39:59 INFO - mozversion platform_buildid: 20160420015738 04:39:59 INFO - mozversion platform_changeset: 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 04:39:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:39:59 INFO - mozversion platform_version: 47.0a2 04:39:59 INFO - using testdate: 1461152399 04:39:59 INFO - actual date: 1461152399 04:39:59 INFO - starting webserver on 'localhost:60935' 04:39:59 INFO - SUITE-START | Running 2 tests 04:39:59 INFO - TEST-START | dromaeo_css 04:39:59 INFO - operating with platform_type : linux_ 04:39:59 INFO - Initialising browser for dromaeo_css test... 04:39:59 INFO - TEST-INFO | started process 4320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5dD7Q/profile http://localhost:60935/getInfo.html) 04:40:03 INFO - PROCESS | 4320 | 04:40:03 INFO - PROCESS | 4320 | (process:4397): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:40:04 INFO - PROCESS | 4320 | __metrics Screen width/height:1600/1200 04:40:04 INFO - PROCESS | 4320 | colorDepth:24 04:40:04 INFO - PROCESS | 4320 | Browser inner width/height: 1024/697 04:40:04 INFO - PROCESS | 4320 | __metrics 04:40:05 ERROR - PROCESS | 4320 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:40:06 INFO - TEST-INFO | 4320: exit 0 04:40:06 INFO - Browser initialized. 04:40:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:06 INFO - TEST-INFO | started process 4448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5dD7Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:08 INFO - PROCESS | 4448 | 04:40:08 INFO - PROCESS | 4448 | (process:4518): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:40:18 INFO - PROCESS | 4448 | RSS: Main: 151756800 04:40:18 INFO - PROCESS | 4448 | 04:41:07 INFO - PROCESS | 4448 | 1461152467632 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:43:15 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:60935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60935/tests/dromaeo/cssquery-ext.html) 04:43:16 INFO - PROCESS | 4448 | RSS: Main: 154836992 04:43:16 INFO - PROCESS | 4448 | 04:46:18 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:60935/tests/dromaeo/cssquery-ext.html (next: http://localhost:60935/tests/dromaeo/cssquery-jquery.html) 04:46:19 INFO - PROCESS | 4448 | RSS: Main: 153497600 04:46:19 INFO - PROCESS | 4448 | 04:49:20 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:60935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60935/tests/dromaeo/cssquery-mootools.html) 04:49:21 INFO - PROCESS | 4448 | RSS: Main: 153395200 04:49:21 INFO - PROCESS | 4448 | 04:52:23 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:60935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60935/tests/dromaeo/cssquery-prototype.html) 04:52:23 INFO - PROCESS | 4448 | RSS: Main: 152059904 04:52:23 INFO - PROCESS | 4448 | 04:55:26 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:60935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60935/tests/dromaeo/cssquery-yui.html) 04:55:26 INFO - PROCESS | 4448 | RSS: Main: 154161152 04:55:26 INFO - PROCESS | 4448 | 04:58:28 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:60935/tests/dromaeo/cssquery-yui.html (next: http://localhost:60935/tests/dromaeo/cssquery-dojo.html) 04:58:29 INFO - PROCESS | 4448 | RSS: Main: 155394048 04:58:29 INFO - PROCESS | 4448 | 04:58:29 INFO - PROCESS | 4448 | __start_tp_report 04:58:29 INFO - PROCESS | 4448 | _x_x_mozilla_page_load 04:58:29 INFO - PROCESS | 4448 | _x_x_mozilla_page_load_details 04:58:29 INFO - PROCESS | 4448 | |i|pagename|runs| 04:58:29 INFO - PROCESS | 4448 | |0;dojo.html;3345.9163520911975;3373.0724050886;3385.9322813543745;3399.796012239266;3416.5900091988956;5441.673499590027;5490.615656904019;5491.807786727465;5505.724713764316;5506.944930550693;5443.618946673734;5458.4814442627885;5492.313460817398;5496.422875598065;5498.642588231762;5029.673071250375;5060.54455099041;5122.026814905174;5141.203113517392;5158.123119069767;5074.035933172704;5144.048351055048;5157.638965272433;5169.3279873616375;5195.844124676266;5077.3907131144315;5113.105206588851;5181.455947125554;5205.089109405858;5220.738963051851;5176.404713457944;5204.037253108149;5217;5228.372595288552;5259.132243179909;4640.225271104192;4961.255811628249;5025.698458092526;5145.125328694094;5189.844304670866;5298.947010529884;5341.03861304965;5351.197320401932;5359.5712343012465;5371.274877891513;5966.552508561876;5968;5995.580309378345;5996.580239383245;6024.427679370453;6000.669963152025;6013.609115407485;6037.607555508922;6118.20463339763;6119.969400153015;5573.944260557383;5598.720063996784;5607.158926161109;5629.915551266734;5631.549476041948;5990.7903223386975;6126.326104128542;6153.692315384213;6164.229471316085;6173.351798061229;5859.326177489644;5891.145783861316;5903.970480147657;5907.113932910098;5914.940850591439;5987.940120598825;5995.2206213192;5998.580099393001;6002.399760023963;6031.306399764083;5863.296404431496;5942.078977758454;5953.970230148908;5961.28464584244;5962.403759624003;5989.221401217901;6013.548983826143;6022.277326720734;6032.698365081728;6066.878662426815;4468.776561171929;4486.910261794746;4489.6408287336935;4498.280275156025;4512.819487220474;4002.6597739192493;4049.5140583130215;4069.4302797608357;4074.103697186614;4096;5493.560515158778;5563.054280772198;5668.829935101953;5692.117721753135;5696.601237913389;5974.880502389928;5998;6008.158857759917;6010.969945150334;6016.548758843104;5554.50009499147;5578.693171875586;5595.664260144323;5641.069223578145;5726.484616384545;5038.345015148007;5146.073706732749;5147.40804807452;5153.639245252872;5169.095408303532;6171.783987560414;6180.907286390708;6186.690665466709;6212.751489940351;6224.470919971763;5821.679807610622;5994.0409534474275;6007.48936340416;6080.665563394055;6105.687277235238;6182.1345011699295;6199.907001394892;6212.254529456494;6225.501959843292;6247.344028877084;5974.2830860297045;5974.518677839106;5981.132735753378;5985;5991.610545314541;5840.707964601838;5938.910916336172;5992.340842507234;5993.220881285405;6023.728932197974;5833.854153646023;5838.065909454467;5856.267966504187;5874.823755287348;5876.970615146897;5664.405237450009;5841.591088623925;5860.560457965585;5860.589758717019;5868.647881127146;5756.65460072397;5804.65172089676;5805.82582522525;5809.50619197373;5824.5340372770925;5850.414958504286;5851.912221316598;5882.411758824083;5887.381824908494;5894.911576326444;5687.317521897398;5755.424457554211;5782.132680098019;5789.478946894799;5796.304443466811 04:58:29 INFO - PROCESS | 4448 | |1;ext.html;537.9139337705965;560.7420586530196;562.7861412663189;569.8262030080826;594.5689375202978;37856;38654.80672596633;38752;38818.805905970505;38833.22333553331;43296.35055474163;43365.34951975715;43563.346549801776;43925;43941.560584394145;8788.604512796923;9022.278217742565;9047.773805654846;9059.501727405022;9070.501122438263;8894.199522043014;9050.547472626375;9062.275017998578;9104.226140778042;9110.498922559256;9249.722508324761;9271.814563708722;9283.721488355326;9290.396124251902;9300.116488933574;9219;9244.8613270801;9279.582418791104;9295.024022477644;9299.256059515223;9084.727458176265;9203.125703058266;9245.306602004877;9261.536923153815;9270.072992700743;43189.136217275794;43541.56458435438;43684;43797.34303985443;43849.34225986613;3091.4435401627698;3365.1082463147286;3692.390755525335;3695.1870588470492;3718.3678774608384;29937.101886943427;29959.700402996128;30137.246568835737;30182;30188;3478.3043391321835;3506.7194624429985;3510.6313837047255;3598.24436868258;3626.0572251214876;297586;297945;297946;299329;301035.9999999978;41364.37953430701;42147.57852421498;42353.152936941704;65602;67652;44752;44886.77556612261;44956;44976.3253551197;44991.32513012242;13287.468501259842;13435.462581496631;13436.261005644588;13470.595882123553;13513.662158446117;10176.643817466353;10220.591176352862;10222.846657299997;10229.874713781479;10237.43694096817;15790.921045394929;15891.443799466962;15913.124778137082;15931.920340398456;15942.521724348288;6082.878342433127;6120.14317995481;6178.671585609116;6221.471174950089;6225.564210505221;1007.4710776842217;1010.9797804044025;1023.1577691382142;1099.7305660113163;1166.935818529972;29899.701002989692;30025.849870750506;30635.846820765753;31002.844985774926;31218;1052.8736551613856;1064.2071656615872;1081.113486940701;1145.8198056002332;1182.775272698202;14519.78220326696;14674.486392976194;14844.2577871106;14963.551093467213;14993.775093373608;405833;501696;502551;502596;504973;56886.43113568894;56994.7150264246;57380.42619573834;57572;57760.71119644375;1464.8535146485478;1466.8386477487468;1491.112787891203;1498.1834899979538;1503.9849601504063;29721.405571888874;30111.849440752656;30468.542971855884;30522.542161867146;30606;51334.74332628313;51660.22509662433;51772;51849;52043.21935171051;295337;298434;299524;301106;301525;34976.30047398987;35346.82326588454;35533.64466355303;36020;36278.45582316215;47600.523994759606;47627.76186119047;47885;48025.5197448035;48199.51800482091;39687.80156099201;39934.40098398585;40007.59992400039;40302.59697402988;40343.596564033985;38793;40918.79540602278;40979.7951010255;41224;41332.96667583335;39381;39439;39627.60372396355;40258.79870600628;40590.79704601458;35436.82281588575;35908.46137307995;35986.64013359938;36016.27967440689;36124.45813312855;27021.784019718765;27429.277356299986;27830.721692782812;27918.44163116767;28014.159575212776 04:58:29 INFO - PROCESS | 4448 | |2;jquery.html;382.89279001879464;386.68098818474783;391.47346818529076;397.95622481527045;399.303215888275;17075.573110672238;18374.1731622077;18811.247550097996;18938;18957.810421895778;16779.580510487245;16988.49034528963;17097.23062462189;17138.143092845337;17246.56883577911;5637.746301416436;5844.473997340238;5875.059990401536;5887.528997680175;5929.940700593003;4460.8661740147845;6203.968980155116;6458.095866578683;6474.514411419139;6482.7406903723795;5248.580113590903;6394.904076438857;6409.294977552466;6420.486361091125;6446.1297724807255;5414.485623865746;5443.292371991655;5443.727813609344;5468.343798744157;5500.119980803052;5148.459411761786;5226.973865130688;5246.921296180561;5274.894502109974;5278.973605131988;20909.477263068395;21255.787442125536;23296.534069318688;24312.392190195387;24316.756832431627;2462.076721229539;2477.430191056067;2483.75162483752;2490.3649569359877;2748.628935093777;14382.856171438256;14408.351624176832;14422.639434014129;14438.133711977314;15021;2030.116899148875;2077.8129968302774;2085.718428012214;2152.5049238675037;2177.651575747873;69973.3002669977;73300.26699733041;73716.26283737148;74101.62949185219;74669.87995180077;14912.552623421314;15438.45965391206;15613.063216207063;15615.531534053996;15772.526824195293;26946.730532694815;27012.594811077848;27421.588676169875;27422.862885685445;27431.725682743316;8243.752687419386;8381.036180839159;8430.241278284984;8454.027786804474;8535.146485351539;6878.759243426456;6879.552829066095;6894;6939.271376505495;6968.686409111602;7851.097123830833;7900.525968441797;7908.446408751447;7987.520748755093;8029.7189598363775;1875.690511065659;1875.9624807503774;1922.4617107210004;2023.261509549004;2027.0371573502764;964.5755867418454;973.0658567775015;982.4449186209912;1021.3514418344405;1037.3568387599585;16522.75215871763;16726.24731887068;16938.745918811226;16985.23566439513;17479.12604369802;981.082687687015;983.1102851919024;1000.494750151169;1009.3741880034426;1015.4059874973224;9783.461909594898;9870.21038316933;10008.64969726056;10044.146247569039;10067.798644027078;388323;391109;394405;424656;433468;53510.19734703982;73109.63445182846;77826;78946.6052669733;81108;1015.94920253987;1024.5543188712934;1036.4558606731525;1041.031840388431;1045.7542477517777;15415.460458883885;15492.380304788134;15563.766543502083;15658.060516369054;15751.255080085863;34010.82994585011;34195.658043419244;35400;35715.82142089273;36391.09022274464;49886.50113498818;49954;50106.74946625243;50388.244176338114;50687;8117.675292988451;8370.372222083246;8438.578071096543;8491.405601607828;8577.399582029198;12146.514139434677;12949.093563450468;13080.803787942998;13127.737445251232;13138.934305328412;11266.605668801552;11398.544058237578;11532.481038353462;11537.711557211136;11634;10867.456627168767;11000.724981875197;11033.724156895822;11242.437878105899;11435.828462573234;5874.471297583238;8280.792980175303;10068.842083160238;10800.513976870903;12498.375081246084;8744.956275218583;8759.211670949646;8777.078406767452;8903.376763626484;9096.226820720312;8973.28213742912;10795.136389089012;11466.2546934449;11749.706257343634;11789.528418863492 04:58:29 INFO - PROCESS | 4448 | |3;mootools.html;1597.5367143528376;1603.2064128256511;1746.5720898379898;1810.4297146398883;1877.7934427213013;7571.507851989617;8201.958990205041;8333.125021872707;8592.570371481417;8618.698345557907;8353.91646083539;8366.37252206084;8430.452020618655;8441.324694024479;8487.066422693499;2440.816938729598;2482.888270027853;2486.9378265543414;2495.42605200803;2496.9250922472356;2425.7331693513697;2483.466054798218;2490.414752533153;2506.147909710698;2510.3222130024883;2463.864487453189;2482.888270027844;2501.69979602448;2507.3982244261338;2514.233158886539;2431.1734010436357;2458.31167273162;2460.1512478194995;2470.7776300133073;2483.900643974239;2460.729319774823;2469.1481438903547;2473.183849329717;2485.72657007729;2487.825852190347;8585.35609829259;8590.355723320714;8602.913970860336;8643.222110010067;8671.783205419852;5187.325647665817;5272;5285.814996475105;5299.894002119974;5309.33633295838;3117.797343172709;3148.622165340151;3169.35028319194;3207.5349074384085;3209.743220542351;1032.1897310611134;1040.089921318846;1048.2714513413182;1055.2454994678842;1072.126217133034;11995.700107497383;11998.400079995965;12031.63905082849;12079.456424460921;12080.912717855348;4643.117807616542;4672.789724462407;4727.57451829337;4760.880977975509;4769.713817170981;10107.64623238183;10139.949300253451;10182.338148020355;10213.591456341663;10217.795644087077;5230.607704422184;5231.424543300234;5251.842444726664;5267.815626453133;5301.734913254322;4211.410402543646;4554.43069616298;4605.332226827159;4606.355110284563;4788.880277993078;3969.543502497192;3987.601239875989;4050.331695270306;4095.3856921461424;4120.114175452292;1325.0790700463085;1325.7547353739396;1328.5350127455506;1342.4965637885794;1352.6821197018692;1442.935067921946;1449.2174225918097;1474.7198032373815;1478.829934557518;1514.0461509249324;7947.4039447041705;7969.362451003905;7975.84048319042;8009.679612815422;8188.50868947865;1093.7703082352637;1130.0902773267435;1148.5004023249912;1177.1112809828526;1187.7624475105013;6093.482054025369;6124.755009799558;6142;6160.476359509402;6166.075088736636;10043.548040338203;10245.692629221136;10320.43237621923;10339.689809305733;10451.529681164366;9407.90592094084;10137.239707022003;10137.695869123938;10172.593096276214;10234.385936843813;8020.639071241808;8035.879461808077;8067.87898181516;8080.55556944362;8111.472754270953;7742.458027937991;7763.378929685725;7834.294913457816;7897.565633889962;7904.802379940547;9077.818443631222;9264.72205833826;9284.489353085644;9331.486768227813;9353.766155846159;9371.390859594105;9503.002184770776;9529.14237718581;9659.227261818896;9822.116009559173;6802.183737951477;7027.543209691354;7254.637268136677;7476.813079673052;7604.885926710993;7862.056553213422;7862.488938218998;7879.369650427838;7880.960595196987;7890.763277101696;7011;7203.207647158703;7205.495615306878;7250.166230883516;7320.048393708784;7141.714331426892;7188.6046267455795;7210.567365958059;7226.891596625949;7227.349538541556;7420.480566360303;7568.5837278950185;7597.430192735677;7603.429742769204;7625.389968802371;6852.451803855779;6948.409385202112;6956;6958.060661810793;6990.895136573057;6925.861482770417;7034.964825175842;7039.788806335818;7040.542364746275;7069.045678833291 04:58:29 INFO - PROCESS | 4448 | |4;prototype.html;360.90075229311935;372.8713593810135;373.1901773152259;374.47760374277885;382.51229682155247;6377.457916077134;6386.6168029918235;6496.512761542879;6507.804765857032;6522.054302126189;6415.06981487684;6421.7752378666755;6423.261324947633;6426.614403135815;6447;4755.6908800928;4824.686395384307;4859.2225243960975;4875.926861097087;4978.551930326261;4807.567318941295;4848.854534363957;4880.731559764212;4882.609391248691;4889.755512224392;4812.23004319309;4813.518648135176;4843.757812109398;4849.054434385296;4862.927056094144;4885.2427873679635;4893.975530122344;4907.2393778964315;4907.484714105003;4913.336699545569;4266.296061149907;4284.8500302489265;4288.185244803477;4292.377605247221;4298.720583162084;5968.880622387528;6086.7565297388055;6142.416470435302;6163.630182189083;6169.81490555284;5639.15412688096;5639.661620302795;5646.2942132233475;5647.632903861236;5654.688992105433;6743;6751.932480675228;6753.61550882068;6788.524803263774;6792.049113124167;4639.327297541871;4639.6752227344095;4641.883952901171;4648.83729069481;4659.673822832403;7062.081929349203;7107.573545587281;7154.785356439315;7166.104236970431;7191.101112360955;4710.24636058229;4805.831795887128;4826.276058591239;4827.951720482821;4833.879153021132;4818.156822556039;4870.123377791961;4876.439209490883;4879.1461494238365;4893.09477746618;5615.354234263031;5626.746796394172;5630.436956304418;5661.66030038199;5677.74450149736;6825.419839313615;6830.965845170742;6857.622830744357;6868;6873.621950792654;1719.5872990482194;1736.7308067249596;1737.7393390991454;1739.7564340992271;1741.2425594866274;1114.4650567727535;1138.6242539961793;1151.0216316131389;1155.8035134027068;1160.066146751856;6495.6752162391695;6546.70539825709;6546.803595892131;6552.049952756919;6597.406233439014;7032.929670703227;7035.296470352924;7060.611666358297;7068.399186069241;7091.574505529685;6456.677166141674;6523.64119973406;6631.038499417557;6650.567713098633;6656.2345330287635;3838.213166300902;3861.131245469803;3863.6715879150024;3884.8057597120032;3895.0846551060476;7359.411247100219;7407.407407407394;7432.479726419098;7442.479026468095;7455.4408419368765;7326.04761381017;7333.88999165013;7340.596267205355;7368.410527157815;7372.262773722692;7237.63811809418;7393.704251829974;7417.443691723034;7440.404767618577;7483.962580187173;7101.786946391617;7105.396041336544;7152.642367881689;7155.105611798525;7156;7041.964790176016;7044.894326585208;7072.575645461289;7073.328033836778;7084.397826184626;7277.053982982178;7402.1857595665515;7422.1835598085245;7422.703091876265;7426.071741032371;4836.637252206169;4913.606911447004;4930.112579735682;4930.654854160174;4936.851894443029;7053.118360204974;7097.858042839011;7103.964480177566;7131.964340178266;7150.856982860209;6884.208316043519;6930.445564354739;6931.896021559782;6936.583804971718;6953.061336719478;6807.353301436356;6929.445644348541;6934.271901450275;6936.098307220231;6936.965315173392;6767.1879374475375;6789.93210067893;6796.5727197289125;6805.727770889307;6821.556598821259;6941.722331106901;6969.895451568332;6984.301569842975;6999.545029573062;7001.439884809305;6791.660416979033;6797.830054248486;6803.727850885909;6804.21751498584;6806.319368063154 04:58:29 INFO - PROCESS | 4448 | |5;yui.html;757.2427572427572;770.010536460648;774.357283454733;788.9447738658296;798.7483942558093;14730.852691473083;15059.774103388458;15085.622859428506;15091;15093.54719358421;14152.150870947751;14474.348654310556;14517.927410362934;14521.20133392663;14578.12531248126;912.7991841794811;913.2009491694768;945.475261230017;950.2635457520408;950.5057370167509;932.0586207929972;933.0436302789661;933.4119504712022;934.7663084228943;939.1876027236425;970.3062310448029;976.7313988653107;978.8042391521689;981.8429051351785;982.0817535604198;962.1100482054107;963.6723514005237;967.0522887570186;970.2626004236761;970.3983530211243;719.0329007484925;721.0122132678212;723.1286300008477;723.9022731931175;725.1624373848214;13749.106308090042;13801.171929684251;13882.652933676638;13894;13940.58178254654;12732.299723515296;12884.742305153844;12901.419436125398;13071.803922941164;13095.279759613217;9967.950160249226;10629.362238265729;10815.35107893529;10890.61882834097;10922.071623911897;3619.728520360957;3620.9275814483562;3630.818459077062;3639.090227443139;3684.926301473982;52368.73815630936;52398;52399;53292.200616990776;53849.73075134638;9954.402735835873;10064.245181611408;10142.543585538668;10229.846552301722;10337.9483102584;18895.96072216014;18966;18966.146523406478;18979.905100474687;18990.335338263096;6893.276205998398;6950.443964482829;7100;7100.360967512948;7475.0656167979005;3934.3114954883354;4024.7182697210915;4044.5348784889525;4051.9797401012806;4074.3888416737727;3280.5407242986003;3297.422950983568;3297.9010629681147;3328.816915069646;3335.149536868083;603.1164344235716;603.4026313949247;603.6830663901399;609.5123900879279;614.9600275982046;617.5337620096798;652.6214795418646;679.1748026148155;689.7758228575733;690.9378155965987;8514.914850851535;8589.570521473901;8938.642454301755;9007.63969441228;9056.230220431205;556.0214023318988;576.469647923911;683.2859661653584;694.3438450664074;711.5019486359569;3878.7478813877005;3944.9408258876138;4034.677225821927;4125.711200216017;4175.31107367281;59857.70071149617;60033.399666002784;60730.69634651799;61151.38848611546;61199.69400152971;51516;54234.728826356404;55045;55136.72431637816;55220;47442.051158976625;48004.5199548007;48447.515524845;48456.7577162119;49118.50881491211;8701.6954406598;8754.60604272822;8775.385722999328;8849.69026084084;9079.273658107204;35942.640573593926;37062.44406333853;37881.999999998894;38141.4278785824;38846.223075538896;45179.322310164716;45286;45509.31736023896;45590.544094559955;47158.29262561133;10965.61620343284;11121.221514494231;11185.384803835866;11494.137939654393;11542.653720388065;10833.349999000086;11893.940530297294;11998.340091295062;12615.621531354074;12695.80956285675;10645.574177032831;10984.615538456115;11192.832107518556;11219.439028048402;11523.769524609294;11555.768884622428;11626.53493860236;11642.185047046625;11848.70378240551;11925.463354148911;9961.900380996098;10003.29976901639;10238.33450825694;11395.202335836411;11482.942585287354;8618.138186181332;8869.379143460154;8872.201501864864;9606.471644059644;9648.75878103053;9686.273529485175;9834.065763752433;9850.950745246228;9895.50522473859;9969.102780749477 04:58:29 INFO - PROCESS | 4448 | __end_tp_report 04:58:29 INFO - PROCESS | 4448 | __start_cc_report 04:58:29 INFO - PROCESS | 4448 | _x_x_mozilla_cycle_collect,332 04:58:29 INFO - PROCESS | 4448 | __end_cc_report 04:58:29 INFO - PROCESS | 4448 | __startTimestamp1461153509027__endTimestamp 04:58:29 INFO - PROCESS | 4448 | 04:58:29 INFO - PROCESS | 4448 | ------- Summary: start ------- 04:58:29 INFO - PROCESS | 4448 | Number of tests: 6 04:58:29 INFO - PROCESS | 4448 | 04:58:29 INFO - PROCESS | 4448 | [#0] dojo.html Cycles:165 Average:5555.65 Median:5804.65 stddev:624.25 (10.8%) stddev-sans-first:601.62 04:58:29 INFO - PROCESS | 4448 | Values: 3345.9 3373.1 3385.9 3399.8 3416.6 5441.7 5490.6 5491.8 5505.7 5506.9 5443.6 5458.5 5492.3 5496.4 5498.6 5029.7 5060.5 5122.0 5141.2 5158.1 5074.0 5144.0 5157.6 5169.3 5195.8 5077.4 5113.1 5181.5 5205.1 5220.7 5176.4 5204.0 5217.0 5228.4 5259.1 4640.2 4961.3 5025.7 5145.1 5189.8 5298.9 5341.0 5351.2 5359.6 5371.3 5966.6 5968.0 5995.6 5996.6 6024.4 6000.7 6013.6 6037.6 6118.2 6120.0 5573.9 5598.7 5607.2 5629.9 5631.5 5990.8 6126.3 6153.7 6164.2 6173.4 5859.3 5891.1 5904.0 5907.1 5914.9 5987.9 5995.2 5998.6 6002.4 6031.3 5863.3 5942.1 5954.0 5961.3 5962.4 5989.2 6013.5 6022.3 6032.7 6066.9 4468.8 4486.9 4489.6 4498.3 4512.8 4002.7 4049.5 4069.4 4074.1 4096.0 5493.6 5563.1 5668.8 5692.1 5696.6 5974.9 5998.0 6008.2 6011.0 6016.5 5554.5 5578.7 5595.7 5641.1 5726.5 5038.3 5146.1 5147.4 5153.6 5169.1 6171.8 6180.9 6186.7 6212.8 6224.5 5821.7 5994.0 6007.5 6080.7 6105.7 6182.1 6199.9 6212.3 6225.5 6247.3 5974.3 5974.5 5981.1 5985.0 5991.6 5840.7 5938.9 5992.3 5993.2 6023.7 5833.9 5838.1 5856.3 5874.8 5877.0 5664.4 5841.6 5860.6 5860.6 5868.6 5756.7 5804.7 5805.8 5809.5 5824.5 5850.4 5851.9 5882.4 5887.4 5894.9 5687.3 5755.4 5782.1 5789.5 5796.3 04:58:29 INFO - PROCESS | 4448 | 04:58:29 INFO - PROCESS | 4448 | [#1] ext.html Cycles:180 Average:52477.45 Median:39107.11 stddev:98241.25 (251.2%) stddev-sans-first:98439.45 04:58:29 INFO - PROCESS | 4448 | Values: 537.9 560.7 562.8 569.8 594.6 37856.0 38654.8 38752.0 38818.8 38833.2 43296.4 43365.3 43563.3 43925.0 43941.6 8788.6 9022.3 9047.8 9059.5 9070.5 8894.2 9050.5 9062.3 9104.2 9110.5 9249.7 9271.8 9283.7 9290.4 9300.1 9219.0 9244.9 9279.6 9295.0 9299.3 9084.7 9203.1 9245.3 9261.5 9270.1 43189.1 43541.6 43684.0 43797.3 43849.3 3091.4 3365.1 3692.4 3695.2 3718.4 29937.1 29959.7 30137.2 30182.0 30188.0 3478.3 3506.7 3510.6 3598.2 3626.1 297586.0 297945.0 297946.0 299329.0 301036.0 41364.4 42147.6 42353.2 65602.0 67652.0 44752.0 44886.8 44956.0 44976.3 44991.3 13287.5 13435.5 13436.3 13470.6 13513.7 10176.6 10220.6 10222.8 10229.9 10237.4 15790.9 15891.4 15913.1 15931.9 15942.5 6082.9 6120.1 6178.7 6221.5 6225.6 1007.5 1011.0 1023.2 1099.7 1166.9 29899.7 30025.8 30635.8 31002.8 31218.0 1052.9 1064.2 1081.1 1145.8 1182.8 14519.8 14674.5 14844.3 14963.6 14993.8 405833.0 501696.0 502551.0 502596.0 504973.0 56886.4 56994.7 57380.4 57572.0 57760.7 1464.9 1466.8 1491.1 1498.2 1504.0 29721.4 30111.8 30468.5 30522.5 30606.0 51334.7 51660.2 51772.0 51849.0 52043.2 295337.0 298434.0 299524.0 301106.0 301525.0 34976.3 35346.8 35533.6 36020.0 36278.5 47600.5 47627.8 47885.0 48025.5 48199.5 39687.8 39934.4 40007.6 40302.6 40343.6 38793.0 40918.8 40979.8 41224.0 41333.0 39381.0 39439.0 39627.6 40258.8 40590.8 35436.8 35908.5 35986.6 36016.3 36124.5 27021.8 27429.3 27830.7 27918.4 28014.2 04:58:29 INFO - PROCESS | 4448 | 04:58:29 INFO - PROCESS | 4448 | [#2] jquery.html Cycles:180 Average:25860.52 Median:34103.24 stddev:66870.83 (196.1%) stddev-sans-first:67031.06 04:58:29 INFO - PROCESS | 4448 | Values: 382.9 386.7 391.5 398.0 399.3 17075.6 18374.2 18811.2 18938.0 18957.8 16779.6 16988.5 17097.2 17138.1 17246.6 5637.7 5844.5 5875.1 5887.5 5929.9 4460.9 6204.0 6458.1 6474.5 6482.7 5248.6 6394.9 6409.3 6420.5 6446.1 5414.5 5443.3 5443.7 5468.3 5500.1 5148.5 5227.0 5246.9 5274.9 5279.0 20909.5 21255.8 23296.5 24312.4 24316.8 2462.1 2477.4 2483.8 2490.4 2748.6 14382.9 14408.4 14422.6 14438.1 15021.0 2030.1 2077.8 2085.7 2152.5 2177.7 69973.3 73300.3 73716.3 74101.6 74669.9 14912.6 15438.5 15613.1 15615.5 15772.5 26946.7 27012.6 27421.6 27422.9 27431.7 8243.8 8381.0 8430.2 8454.0 8535.1 6878.8 6879.6 6894.0 6939.3 6968.7 7851.1 7900.5 7908.4 7987.5 8029.7 1875.7 1876.0 1922.5 2023.3 2027.0 964.6 973.1 982.4 1021.4 1037.4 16522.8 16726.2 16938.7 16985.2 17479.1 981.1 983.1 1000.5 1009.4 1015.4 9783.5 9870.2 10008.6 10044.1 10067.8 388323.0 391109.0 394405.0 424656.0 433468.0 53510.2 73109.6 77826.0 78946.6 81108.0 1015.9 1024.6 1036.5 1041.0 1045.8 15415.5 15492.4 15563.8 15658.1 15751.3 34010.8 34195.7 35400.0 35715.8 36391.1 49886.5 49954.0 50106.7 50388.2 50687.0 8117.7 8370.4 8438.6 8491.4 8577.4 12146.5 12949.1 13080.8 13127.7 13138.9 11266.6 11398.5 11532.5 11537.7 11634.0 10867.5 11000.7 11033.7 11242.4 11435.8 5874.5 8280.8 10068.8 10800.5 12498.4 8745.0 8759.2 8777.1 8903.4 9096.2 8973.3 10795.1 11466.3 11749.7 11789.5 04:58:29 INFO - PROCESS | 4448 | 04:58:29 INFO - PROCESS | 4448 | [#3] mootools.html Cycles:180 Average:5940.56 Median:5231.02 stddev:3086.89 (59.0%) stddev-sans-first:3078.29 04:58:29 INFO - PROCESS | 4448 | Values: 1597.5 1603.2 1746.6 1810.4 1877.8 7571.5 8202.0 8333.1 8592.6 8618.7 8353.9 8366.4 8430.5 8441.3 8487.1 2440.8 2482.9 2486.9 2495.4 2496.9 2425.7 2483.5 2490.4 2506.1 2510.3 2463.9 2482.9 2501.7 2507.4 2514.2 2431.2 2458.3 2460.2 2470.8 2483.9 2460.7 2469.1 2473.2 2485.7 2487.8 8585.4 8590.4 8602.9 8643.2 8671.8 5187.3 5272.0 5285.8 5299.9 5309.3 3117.8 3148.6 3169.4 3207.5 3209.7 1032.2 1040.1 1048.3 1055.2 1072.1 11995.7 11998.4 12031.6 12079.5 12080.9 4643.1 4672.8 4727.6 4760.9 4769.7 10107.6 10139.9 10182.3 10213.6 10217.8 5230.6 5231.4 5251.8 5267.8 5301.7 4211.4 4554.4 4605.3 4606.4 4788.9 3969.5 3987.6 4050.3 4095.4 4120.1 1325.1 1325.8 1328.5 1342.5 1352.7 1442.9 1449.2 1474.7 1478.8 1514.0 7947.4 7969.4 7975.8 8009.7 8188.5 1093.8 1130.1 1148.5 1177.1 1187.8 6093.5 6124.8 6142.0 6160.5 6166.1 10043.5 10245.7 10320.4 10339.7 10451.5 9407.9 10137.2 10137.7 10172.6 10234.4 8020.6 8035.9 8067.9 8080.6 8111.5 7742.5 7763.4 7834.3 7897.6 7904.8 9077.8 9264.7 9284.5 9331.5 9353.8 9371.4 9503.0 9529.1 9659.2 9822.1 6802.2 7027.5 7254.6 7476.8 7604.9 7862.1 7862.5 7879.4 7881.0 7890.8 7011.0 7203.2 7205.5 7250.2 7320.0 7141.7 7188.6 7210.6 7226.9 7227.3 7420.5 7568.6 7597.4 7603.4 7625.4 6852.5 6948.4 6956.0 6958.1 6990.9 6925.9 7035.0 7039.8 7040.5 7069.0 04:58:29 INFO - PROCESS | 4448 | 04:58:29 INFO - PROCESS | 4448 | [#4] prototype.html Cycles:180 Average:5738.33 Median:6514.93 stddev:1750.47 (26.9%) stddev-sans-first:1708.22 04:58:29 INFO - PROCESS | 4448 | Values: 360.9 372.9 373.2 374.5 382.5 6377.5 6386.6 6496.5 6507.8 6522.1 6415.1 6421.8 6423.3 6426.6 6447.0 4755.7 4824.7 4859.2 4875.9 4978.6 4807.6 4848.9 4880.7 4882.6 4889.8 4812.2 4813.5 4843.8 4849.1 4862.9 4885.2 4894.0 4907.2 4907.5 4913.3 4266.3 4284.9 4288.2 4292.4 4298.7 5968.9 6086.8 6142.4 6163.6 6169.8 5639.2 5639.7 5646.3 5647.6 5654.7 6743.0 6751.9 6753.6 6788.5 6792.0 4639.3 4639.7 4641.9 4648.8 4659.7 7062.1 7107.6 7154.8 7166.1 7191.1 4710.2 4805.8 4826.3 4828.0 4833.9 4818.2 4870.1 4876.4 4879.1 4893.1 5615.4 5626.7 5630.4 5661.7 5677.7 6825.4 6831.0 6857.6 6868.0 6873.6 1719.6 1736.7 1737.7 1739.8 1741.2 1114.5 1138.6 1151.0 1155.8 1160.1 6495.7 6546.7 6546.8 6552.0 6597.4 7032.9 7035.3 7060.6 7068.4 7091.6 6456.7 6523.6 6631.0 6650.6 6656.2 3838.2 3861.1 3863.7 3884.8 3895.1 7359.4 7407.4 7432.5 7442.5 7455.4 7326.0 7333.9 7340.6 7368.4 7372.3 7237.6 7393.7 7417.4 7440.4 7484.0 7101.8 7105.4 7152.6 7155.1 7156.0 7042.0 7044.9 7072.6 7073.3 7084.4 7277.1 7402.2 7422.2 7422.7 7426.1 4836.6 4913.6 4930.1 4930.7 4936.9 7053.1 7097.9 7104.0 7132.0 7150.9 6884.2 6930.4 6931.9 6936.6 6953.1 6807.4 6929.4 6934.3 6936.1 6937.0 6767.2 6789.9 6796.6 6805.7 6821.6 6941.7 6969.9 6984.3 6999.5 7001.4 6791.7 6797.8 6803.7 6804.2 6806.3 04:58:29 INFO - PROCESS | 4448 | 04:58:29 INFO - PROCESS | 4448 | [#5] yui.html Cycles:180 Average:14388.45 Median:48787.63 stddev:16928.74 (34.7%) stddev-sans-first:16945.28 04:58:29 INFO - PROCESS | 4448 | Values: 757.2 770.0 774.4 788.9 798.7 14730.9 15059.8 15085.6 15091.0 15093.5 14152.2 14474.3 14517.9 14521.2 14578.1 912.8 913.2 945.5 950.3 950.5 932.1 933.0 933.4 934.8 939.2 970.3 976.7 978.8 981.8 982.1 962.1 963.7 967.1 970.3 970.4 719.0 721.0 723.1 723.9 725.2 13749.1 13801.2 13882.7 13894.0 13940.6 12732.3 12884.7 12901.4 13071.8 13095.3 9968.0 10629.4 10815.4 10890.6 10922.1 3619.7 3620.9 3630.8 3639.1 3684.9 52368.7 52398.0 52399.0 53292.2 53849.7 9954.4 10064.2 10142.5 10229.8 10337.9 18896.0 18966.0 18966.1 18979.9 18990.3 6893.3 6950.4 7100.0 7100.4 7475.1 3934.3 4024.7 4044.5 4052.0 4074.4 3280.5 3297.4 3297.9 3328.8 3335.1 603.1 603.4 603.7 609.5 615.0 617.5 652.6 679.2 689.8 690.9 8514.9 8589.6 8938.6 9007.6 9056.2 556.0 576.5 683.3 694.3 711.5 3878.7 3944.9 4034.7 4125.7 4175.3 59857.7 60033.4 60730.7 61151.4 61199.7 51516.0 54234.7 55045.0 55136.7 55220.0 47442.1 48004.5 48447.5 48456.8 49118.5 8701.7 8754.6 8775.4 8849.7 9079.3 35942.6 37062.4 37882.0 38141.4 38846.2 45179.3 45286.0 45509.3 45590.5 47158.3 10965.6 11121.2 11185.4 11494.1 11542.7 10833.3 11893.9 11998.3 12615.6 12695.8 10645.6 10984.6 11192.8 11219.4 11523.8 11555.8 11626.5 11642.2 11848.7 11925.5 9961.9 10003.3 10238.3 11395.2 11482.9 8618.1 8869.4 8872.2 9606.5 9648.8 9686.3 9834.1 9851.0 9895.5 9969.1 04:58:29 INFO - PROCESS | 4448 | -------- Summary: end -------- 04:58:29 INFO - PROCESS | 4448 | 04:58:29 INFO - TEST-INFO | 4448: exit 0 04:58:29 INFO - TEST-OK | dromaeo_css | took 1110230ms 04:58:29 INFO - TEST-START | kraken 04:58:29 INFO - operating with platform_type : linux_ 04:58:29 INFO - Initialising browser for kraken test... 04:58:29 INFO - TEST-INFO | started process 4691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvSuFfb/profile http://localhost:60935/getInfo.html) 04:58:33 INFO - PROCESS | 4691 | 04:58:33 INFO - PROCESS | 4691 | (process:4766): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:58:34 INFO - PROCESS | 4691 | __metrics Screen width/height:1600/1200 04:58:34 INFO - PROCESS | 4691 | colorDepth:24 04:58:34 INFO - PROCESS | 4691 | Browser inner width/height: 1024/697 04:58:34 INFO - PROCESS | 4691 | __metrics 04:58:35 ERROR - PROCESS | 4691 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:58:36 INFO - TEST-INFO | 4691: exit 0 04:58:36 INFO - Browser initialized. 04:58:36 INFO - Running cycle 1/1 for kraken test... 04:58:36 INFO - TEST-INFO | started process 4817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvSuFfb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:38 INFO - PROCESS | 4817 | 04:58:38 INFO - PROCESS | 4817 | (process:4883): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:58:48 INFO - PROCESS | 4817 | RSS: Main: 151695360 04:58:48 INFO - PROCESS | 4817 | 04:58:51 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60935/tests/kraken/driver.html?testName=audio-beat-detection) 04:58:51 INFO - PROCESS | 4817 | RSS: Main: 155721728 04:58:51 INFO - PROCESS | 4817 | 04:58:54 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60935/tests/kraken/driver.html?testName=audio-dft) 04:58:54 INFO - PROCESS | 4817 | RSS: Main: 156123136 04:58:54 INFO - PROCESS | 4817 | 04:58:57 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60935/tests/kraken/driver.html?testName=audio-fft) 04:58:58 INFO - PROCESS | 4817 | RSS: Main: 157429760 04:58:58 INFO - PROCESS | 4817 | 04:59:00 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60935/tests/kraken/driver.html?testName=audio-oscillator) 04:59:01 INFO - PROCESS | 4817 | RSS: Main: 156872704 04:59:01 INFO - PROCESS | 4817 | 04:59:03 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:03 INFO - PROCESS | 4817 | RSS: Main: 156762112 04:59:03 INFO - PROCESS | 4817 | 04:59:06 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60935/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:07 INFO - PROCESS | 4817 | RSS: Main: 156860416 04:59:07 INFO - PROCESS | 4817 | 04:59:10 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60935/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:11 INFO - PROCESS | 4817 | RSS: Main: 157073408 04:59:11 INFO - PROCESS | 4817 | 04:59:14 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60935/tests/kraken/driver.html?testName=json-parse-financial) 04:59:14 INFO - PROCESS | 4817 | RSS: Main: 157249536 04:59:14 INFO - PROCESS | 4817 | 04:59:16 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:17 INFO - PROCESS | 4817 | RSS: Main: 157044736 04:59:17 INFO - PROCESS | 4817 | 04:59:18 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60935/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:19 INFO - PROCESS | 4817 | RSS: Main: 157429760 04:59:19 INFO - PROCESS | 4817 | 04:59:21 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:22 INFO - PROCESS | 4817 | RSS: Main: 157421568 04:59:22 INFO - PROCESS | 4817 | 04:59:24 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:25 INFO - PROCESS | 4817 | RSS: Main: 157540352 04:59:25 INFO - PROCESS | 4817 | 04:59:27 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:28 INFO - PROCESS | 4817 | RSS: Main: 157437952 04:59:28 INFO - PROCESS | 4817 | 04:59:29 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:60935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60935/tests/kraken/driver.html?testName=ai-astar) 04:59:30 INFO - PROCESS | 4817 | RSS: Main: 159162368 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | __start_tp_report 04:59:30 INFO - PROCESS | 4817 | _x_x_mozilla_page_load 04:59:30 INFO - PROCESS | 4817 | _x_x_mozilla_page_load_details 04:59:30 INFO - PROCESS | 4817 | |i|pagename|runs| 04:59:30 INFO - PROCESS | 4817 | |0;ai-astar;111;103;110;109;115;121;111;111;109;109 04:59:30 INFO - PROCESS | 4817 | |1;audio-beat-detection;153;128;158;167;130;157;152;129;168;129 04:59:30 INFO - PROCESS | 4817 | |2;audio-dft;166;164;163;166;163;164;164;164;165;162 04:59:30 INFO - PROCESS | 4817 | |3;audio-fft;76;78;76;163;76;76;74;76;161;77 04:59:30 INFO - PROCESS | 4817 | |4;audio-oscillator;94;93;146;93;93;93;143;93;93;143 04:59:30 INFO - PROCESS | 4817 | |5;imaging-gaussian-blur;118;117;117;117;125;117;117;117;117;118 04:59:30 INFO - PROCESS | 4817 | |6;imaging-darkroom;146;147;147;147;147;147;147;146;148;147 04:59:30 INFO - PROCESS | 4817 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;95 04:59:30 INFO - PROCESS | 4817 | |8;json-parse-financial;55;61;57;59;57;57;58;64;55;57 04:59:30 INFO - PROCESS | 4817 | |9;json-stringify-tinderbox;65;64;64;67;65;66;66;64;65;66 04:59:30 INFO - PROCESS | 4817 | |10;stanford-crypto-aes;78;77;79;79;79;80;78;79;78;79 04:59:30 INFO - PROCESS | 4817 | |11;stanford-crypto-ccm;113;112;115;112;112;123;120;112;113;111 04:59:30 INFO - PROCESS | 4817 | |12;stanford-crypto-pbkdf2;139;146;139;157;150;146;144;152;139;135 04:59:30 INFO - PROCESS | 4817 | |13;stanford-crypto-sha256-iterative;67;74;68;66;69;68;66;67;67;65 04:59:30 INFO - PROCESS | 4817 | __end_tp_report 04:59:30 INFO - PROCESS | 4817 | __start_cc_report 04:59:30 INFO - PROCESS | 4817 | _x_x_mozilla_cycle_collect,820 04:59:30 INFO - PROCESS | 4817 | __end_cc_report 04:59:30 INFO - PROCESS | 4817 | __startTimestamp1461153570177__endTimestamp 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | ------- Summary: start ------- 04:59:30 INFO - PROCESS | 4817 | Number of tests: 14 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:4.63 (4.2%) stddev-sans-first:4.91 04:59:30 INFO - PROCESS | 4817 | Values: 111.0 103.0 110.0 109.0 115.0 121.0 111.0 111.0 109.0 109.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:155.00 stddev:16.40 (10.6%) stddev-sans-first:17.26 04:59:30 INFO - PROCESS | 4817 | Values: 153.0 128.0 158.0 167.0 130.0 157.0 152.0 129.0 168.0 129.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.29 (0.8%) stddev-sans-first:1.17 04:59:30 INFO - PROCESS | 4817 | Values: 166.0 164.0 163.0 166.0 163.0 164.0 164.0 164.0 165.0 162.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:36.22 (47.7%) stddev-sans-first:37.88 04:59:30 INFO - PROCESS | 4817 | Values: 76.0 78.0 76.0 163.0 76.0 76.0 74.0 76.0 161.0 77.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.58 (26.4%) stddev-sans-first:25.51 04:59:30 INFO - PROCESS | 4817 | Values: 94.0 93.0 146.0 93.0 93.0 93.0 143.0 93.0 93.0 143.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:117.00 stddev:2.49 (2.1%) stddev-sans-first:2.65 04:59:30 INFO - PROCESS | 4817 | Values: 118.0 117.0 117.0 117.0 125.0 117.0 117.0 117.0 117.0 118.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 04:59:30 INFO - PROCESS | 4817 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 148.0 147.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:59:30 INFO - PROCESS | 4817 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.50 stddev:2.75 (4.8%) stddev-sans-first:2.69 04:59:30 INFO - PROCESS | 4817 | Values: 55.0 61.0 57.0 59.0 57.0 57.0 58.0 64.0 55.0 57.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.09 04:59:30 INFO - PROCESS | 4817 | Values: 65.0 64.0 64.0 67.0 65.0 66.0 66.0 64.0 65.0 66.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:0.84 (1.1%) stddev-sans-first:0.87 04:59:30 INFO - PROCESS | 4817 | Values: 78.0 77.0 79.0 79.0 79.0 80.0 78.0 79.0 78.0 79.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:113.00 stddev:4.00 (3.5%) stddev-sans-first:4.22 04:59:30 INFO - PROCESS | 4817 | Values: 113.0 112.0 115.0 112.0 112.0 123.0 120.0 112.0 113.0 111.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.70 Median:146.00 stddev:6.90 (4.7%) stddev-sans-first:7.00 04:59:30 INFO - PROCESS | 4817 | Values: 139.0 146.0 139.0 157.0 150.0 146.0 144.0 152.0 139.0 135.0 04:59:30 INFO - PROCESS | 4817 | 04:59:30 INFO - PROCESS | 4817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:2.50 (3.7%) stddev-sans-first:2.64 04:59:30 INFO - PROCESS | 4817 | Values: 67.0 74.0 68.0 66.0 69.0 68.0 66.0 67.0 67.0 65.0 04:59:30 INFO - PROCESS | 4817 | -------- Summary: end -------- 04:59:30 INFO - PROCESS | 4817 | 04:59:31 INFO - TEST-INFO | 4817: exit 0 04:59:31 INFO - TEST-OK | kraken | took 61355ms 04:59:31 INFO - SUITE-END | took 1171s 04:59:31 INFO - Completed test suite (00:19:31) 04:59:31 INFO - javascript benchmark 04:59:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3345.9163520911975, 3373.0724050886, 3385.9322813543745, 3399.796012239266, 3416.5900091988956, 5441.673499590027, 5490.615656904019, 5491.807786727465, 5505.724713764316, 5506.944930550693, 5443.618946673734, 5458.4814442627885, 5492.313460817398, 5496.422875598065, 5498.642588231762, 5029.673071250375, 5060.54455099041, 5122.026814905174, 5141.203113517392, 5158.123119069767, 5074.035933172704, 5144.048351055048, 5157.638965272433, 5169.3279873616375, 5195.844124676266, 5077.3907131144315, 5113.105206588851, 5181.455947125554, 5205.089109405858, 5220.738963051851, 5176.404713457944, 5204.037253108149, 5217.0, 5228.372595288552, 5259.132243179909, 4640.225271104192, 4961.255811628249, 5025.698458092526, 5145.125328694094, 5189.844304670866, 5298.947010529884, 5341.03861304965, 5351.197320401932, 5359.5712343012465, 5371.274877891513, 5966.552508561876, 5968.0, 5995.580309378345, 5996.580239383245, 6024.427679370453, 6000.669963152025, 6013.609115407485, 6037.607555508922, 6118.20463339763, 6119.969400153015, 5573.944260557383, 5598.720063996784, 5607.158926161109, 5629.915551266734, 5631.549476041948, 5990.7903223386975, 6126.326104128542, 6153.692315384213, 6164.229471316085, 6173.351798061229, 5859.326177489644, 5891.145783861316, 5903.970480147657, 5907.113932910098, 5914.940850591439, 5987.940120598825, 5995.2206213192, 5998.580099393001, 6002.399760023963, 6031.306399764083, 5863.296404431496, 5942.078977758454, 5953.970230148908, 5961.28464584244, 5962.403759624003, 5989.221401217901, 6013.548983826143, 6022.277326720734, 6032.698365081728, 6066.878662426815, 4468.776561171929, 4486.910261794746, 4489.6408287336935, 4498.280275156025, 4512.819487220474, 4002.6597739192493, 4049.5140583130215, 4069.4302797608357, 4074.103697186614, 4096.0, 5493.560515158778, 5563.054280772198, 5668.829935101953, 5692.117721753135, 5696.601237913389, 5974.880502389928, 5998.0, 6008.158857759917, 6010.969945150334, 6016.548758843104, 5554.50009499147, 5578.693171875586, 5595.664260144323, 5641.069223578145, 5726.484616384545, 5038.345015148007, 5146.073706732749, 5147.40804807452, 5153.639245252872, 5169.095408303532, 6171.783987560414, 6180.907286390708, 6186.690665466709, 6212.751489940351, 6224.470919971763, 5821.679807610622, 5994.0409534474275, 6007.48936340416, 6080.665563394055, 6105.687277235238, 6182.1345011699295, 6199.907001394892, 6212.254529456494, 6225.501959843292, 6247.344028877084, 5974.2830860297045, 5974.518677839106, 5981.132735753378, 5985.0, 5991.610545314541, 5840.707964601838, 5938.910916336172, 5992.340842507234, 5993.220881285405, 6023.728932197974, 5833.854153646023, 5838.065909454467, 5856.267966504187, 5874.823755287348, 5876.970615146897, 5664.405237450009, 5841.591088623925, 5860.560457965585, 5860.589758717019, 5868.647881127146, 5756.65460072397, 5804.65172089676, 5805.82582522525, 5809.50619197373, 5824.5340372770925, 5850.414958504286, 5851.912221316598, 5882.411758824083, 5887.381824908494, 5894.911576326444, 5687.317521897398, 5755.424457554211, 5782.132680098019, 5789.478946894799, 5796.304443466811], "unit": "score", "name": "dojo.html", "value": 5514.899594703339}, {"lowerIsBetter": false, "replicates": [537.9139337705965, 560.7420586530196, 562.7861412663189, 569.8262030080826, 594.5689375202978, 37856.0, 38654.80672596633, 38752.0, 38818.805905970505, 38833.22333553331, 43296.35055474163, 43365.34951975715, 43563.346549801776, 43925.0, 43941.560584394145, 8788.604512796923, 9022.278217742565, 9047.773805654846, 9059.501727405022, 9070.501122438263, 8894.199522043014, 9050.547472626375, 9062.275017998578, 9104.226140778042, 9110.498922559256, 9249.722508324761, 9271.814563708722, 9283.721488355326, 9290.396124251902, 9300.116488933574, 9219.0, 9244.8613270801, 9279.582418791104, 9295.024022477644, 9299.256059515223, 9084.727458176265, 9203.125703058266, 9245.306602004877, 9261.536923153815, 9270.072992700743, 43189.136217275794, 43541.56458435438, 43684.0, 43797.34303985443, 43849.34225986613, 3091.4435401627698, 3365.1082463147286, 3692.390755525335, 3695.1870588470492, 3718.3678774608384, 29937.101886943427, 29959.700402996128, 30137.246568835737, 30182.0, 30188.0, 3478.3043391321835, 3506.7194624429985, 3510.6313837047255, 3598.24436868258, 3626.0572251214876, 297586.0, 297945.0, 297946.0, 299329.0, 301035.9999999978, 41364.37953430701, 42147.57852421498, 42353.152936941704, 65602.0, 67652.0, 44752.0, 44886.77556612261, 44956.0, 44976.3253551197, 44991.32513012242, 13287.468501259842, 13435.462581496631, 13436.261005644588, 13470.595882123553, 13513.662158446117, 10176.643817466353, 10220.591176352862, 10222.846657299997, 10229.874713781479, 10237.43694096817, 15790.921045394929, 15891.443799466962, 15913.124778137082, 15931.920340398456, 15942.521724348288, 6082.878342433127, 6120.14317995481, 6178.671585609116, 6221.471174950089, 6225.564210505221, 1007.4710776842217, 1010.9797804044025, 1023.1577691382142, 1099.7305660113163, 1166.935818529972, 29899.701002989692, 30025.849870750506, 30635.846820765753, 31002.844985774926, 31218.0, 1052.8736551613856, 1064.2071656615872, 1081.113486940701, 1145.8198056002332, 1182.775272698202, 14519.78220326696, 14674.486392976194, 14844.2577871106, 14963.551093467213, 14993.775093373608, 405833.0, 501696.0, 502551.0, 502596.0, 504973.0, 56886.43113568894, 56994.7150264246, 57380.42619573834, 57572.0, 57760.71119644375, 1464.8535146485478, 1466.8386477487468, 1491.112787891203, 1498.1834899979538, 1503.9849601504063, 29721.405571888874, 30111.849440752656, 30468.542971855884, 30522.542161867146, 30606.0, 51334.74332628313, 51660.22509662433, 51772.0, 51849.0, 52043.21935171051, 295337.0, 298434.0, 299524.0, 301106.0, 301525.0, 34976.30047398987, 35346.82326588454, 35533.64466355303, 36020.0, 36278.45582316215, 47600.523994759606, 47627.76186119047, 47885.0, 48025.5197448035, 48199.51800482091, 39687.80156099201, 39934.40098398585, 40007.59992400039, 40302.59697402988, 40343.596564033985, 38793.0, 40918.79540602278, 40979.7951010255, 41224.0, 41332.96667583335, 39381.0, 39439.0, 39627.60372396355, 40258.79870600628, 40590.79704601458, 35436.82281588575, 35908.46137307995, 35986.64013359938, 36016.27967440689, 36124.45813312855, 27021.784019718765, 27429.277356299986, 27830.721692782812, 27918.44163116767, 28014.159575212776], "unit": "score", "name": "ext.html", "value": 18986.866018951114}, {"lowerIsBetter": false, "replicates": [382.89279001879464, 386.68098818474783, 391.47346818529076, 397.95622481527045, 399.303215888275, 17075.573110672238, 18374.1731622077, 18811.247550097996, 18938.0, 18957.810421895778, 16779.580510487245, 16988.49034528963, 17097.23062462189, 17138.143092845337, 17246.56883577911, 5637.746301416436, 5844.473997340238, 5875.059990401536, 5887.528997680175, 5929.940700593003, 4460.8661740147845, 6203.968980155116, 6458.095866578683, 6474.514411419139, 6482.7406903723795, 5248.580113590903, 6394.904076438857, 6409.294977552466, 6420.486361091125, 6446.1297724807255, 5414.485623865746, 5443.292371991655, 5443.727813609344, 5468.343798744157, 5500.119980803052, 5148.459411761786, 5226.973865130688, 5246.921296180561, 5274.894502109974, 5278.973605131988, 20909.477263068395, 21255.787442125536, 23296.534069318688, 24312.392190195387, 24316.756832431627, 2462.076721229539, 2477.430191056067, 2483.75162483752, 2490.3649569359877, 2748.628935093777, 14382.856171438256, 14408.351624176832, 14422.639434014129, 14438.133711977314, 15021.0, 2030.116899148875, 2077.8129968302774, 2085.718428012214, 2152.5049238675037, 2177.651575747873, 69973.3002669977, 73300.26699733041, 73716.26283737148, 74101.62949185219, 74669.87995180077, 14912.552623421314, 15438.45965391206, 15613.063216207063, 15615.531534053996, 15772.526824195293, 26946.730532694815, 27012.594811077848, 27421.588676169875, 27422.862885685445, 27431.725682743316, 8243.752687419386, 8381.036180839159, 8430.241278284984, 8454.027786804474, 8535.146485351539, 6878.759243426456, 6879.552829066095, 6894.0, 6939.271376505495, 6968.686409111602, 7851.097123830833, 7900.525968441797, 7908.446408751447, 7987.520748755093, 8029.7189598363775, 1875.690511065659, 1875.9624807503774, 1922.4617107210004, 2023.261509549004, 2027.0371573502764, 964.5755867418454, 973.0658567775015, 982.4449186209912, 1021.3514418344405, 1037.3568387599585, 16522.75215871763, 16726.24731887068, 16938.745918811226, 16985.23566439513, 17479.12604369802, 981.082687687015, 983.1102851919024, 1000.494750151169, 1009.3741880034426, 1015.4059874973224, 9783.461909594898, 9870.21038316933, 10008.64969726056, 10044.146247569039, 10067.798644027078, 388323.0, 391109.0, 394405.0, 424656.0, 433468.0, 53510.19734703982, 73109.63445182846, 77826.0, 78946.6052669733, 81108.0, 1015.94920253987, 1024.5543188712934, 1036.4558606731525, 1041.031840388431, 1045.7542477517777, 15415.460458883885, 15492.380304788134, 15563.766543502083, 15658.060516369054, 15751.255080085863, 34010.82994585011, 34195.658043419244, 35400.0, 35715.82142089273, 36391.09022274464, 49886.50113498818, 49954.0, 50106.74946625243, 50388.244176338114, 50687.0, 8117.675292988451, 8370.372222083246, 8438.578071096543, 8491.405601607828, 8577.399582029198, 12146.514139434677, 12949.093563450468, 13080.803787942998, 13127.737445251232, 13138.934305328412, 11266.605668801552, 11398.544058237578, 11532.481038353462, 11537.711557211136, 11634.0, 10867.456627168767, 11000.724981875197, 11033.724156895822, 11242.437878105899, 11435.828462573234, 5874.471297583238, 8280.792980175303, 10068.842083160238, 10800.513976870903, 12498.375081246084, 8744.956275218583, 8759.211670949646, 8777.078406767452, 8903.376763626484, 9096.226820720312, 8973.28213742912, 10795.136389089012, 11466.2546934449, 11749.706257343634, 11789.528418863492], "unit": "score", "name": "jquery.html", "value": 9277.611379366279}, {"lowerIsBetter": false, "replicates": [1597.5367143528376, 1603.2064128256511, 1746.5720898379898, 1810.4297146398883, 1877.7934427213013, 7571.507851989617, 8201.958990205041, 8333.125021872707, 8592.570371481417, 8618.698345557907, 8353.91646083539, 8366.37252206084, 8430.452020618655, 8441.324694024479, 8487.066422693499, 2440.816938729598, 2482.888270027853, 2486.9378265543414, 2495.42605200803, 2496.9250922472356, 2425.7331693513697, 2483.466054798218, 2490.414752533153, 2506.147909710698, 2510.3222130024883, 2463.864487453189, 2482.888270027844, 2501.69979602448, 2507.3982244261338, 2514.233158886539, 2431.1734010436357, 2458.31167273162, 2460.1512478194995, 2470.7776300133073, 2483.900643974239, 2460.729319774823, 2469.1481438903547, 2473.183849329717, 2485.72657007729, 2487.825852190347, 8585.35609829259, 8590.355723320714, 8602.913970860336, 8643.222110010067, 8671.783205419852, 5187.325647665817, 5272.0, 5285.814996475105, 5299.894002119974, 5309.33633295838, 3117.797343172709, 3148.622165340151, 3169.35028319194, 3207.5349074384085, 3209.743220542351, 1032.1897310611134, 1040.089921318846, 1048.2714513413182, 1055.2454994678842, 1072.126217133034, 11995.700107497383, 11998.400079995965, 12031.63905082849, 12079.456424460921, 12080.912717855348, 4643.117807616542, 4672.789724462407, 4727.57451829337, 4760.880977975509, 4769.713817170981, 10107.64623238183, 10139.949300253451, 10182.338148020355, 10213.591456341663, 10217.795644087077, 5230.607704422184, 5231.424543300234, 5251.842444726664, 5267.815626453133, 5301.734913254322, 4211.410402543646, 4554.43069616298, 4605.332226827159, 4606.355110284563, 4788.880277993078, 3969.543502497192, 3987.601239875989, 4050.331695270306, 4095.3856921461424, 4120.114175452292, 1325.0790700463085, 1325.7547353739396, 1328.5350127455506, 1342.4965637885794, 1352.6821197018692, 1442.935067921946, 1449.2174225918097, 1474.7198032373815, 1478.829934557518, 1514.0461509249324, 7947.4039447041705, 7969.362451003905, 7975.84048319042, 8009.679612815422, 8188.50868947865, 1093.7703082352637, 1130.0902773267435, 1148.5004023249912, 1177.1112809828526, 1187.7624475105013, 6093.482054025369, 6124.755009799558, 6142.0, 6160.476359509402, 6166.075088736636, 10043.548040338203, 10245.692629221136, 10320.43237621923, 10339.689809305733, 10451.529681164366, 9407.90592094084, 10137.239707022003, 10137.695869123938, 10172.593096276214, 10234.385936843813, 8020.639071241808, 8035.879461808077, 8067.87898181516, 8080.55556944362, 8111.472754270953, 7742.458027937991, 7763.378929685725, 7834.294913457816, 7897.565633889962, 7904.802379940547, 9077.818443631222, 9264.72205833826, 9284.489353085644, 9331.486768227813, 9353.766155846159, 9371.390859594105, 9503.002184770776, 9529.14237718581, 9659.227261818896, 9822.116009559173, 6802.183737951477, 7027.543209691354, 7254.637268136677, 7476.813079673052, 7604.885926710993, 7862.056553213422, 7862.488938218998, 7879.369650427838, 7880.960595196987, 7890.763277101696, 7011.0, 7203.207647158703, 7205.495615306878, 7250.166230883516, 7320.048393708784, 7141.714331426892, 7188.6046267455795, 7210.567365958059, 7226.891596625949, 7227.349538541556, 7420.480566360303, 7568.5837278950185, 7597.430192735677, 7603.429742769204, 7625.389968802371, 6852.451803855779, 6948.409385202112, 6956.0, 6958.060661810793, 6990.895136573057, 6925.861482770417, 7034.964825175842, 7039.788806335818, 7040.542364746275, 7069.045678833291], "unit": "score", "name": "mootools.html", "value": 4891.9363880888195}, {"lowerIsBetter": false, "replicates": [360.90075229311935, 372.8713593810135, 373.1901773152259, 374.47760374277885, 382.51229682155247, 6377.457916077134, 6386.6168029918235, 6496.512761542879, 6507.804765857032, 6522.054302126189, 6415.06981487684, 6421.7752378666755, 6423.261324947633, 6426.614403135815, 6447.0, 4755.6908800928, 4824.686395384307, 4859.2225243960975, 4875.926861097087, 4978.551930326261, 4807.567318941295, 4848.854534363957, 4880.731559764212, 4882.609391248691, 4889.755512224392, 4812.23004319309, 4813.518648135176, 4843.757812109398, 4849.054434385296, 4862.927056094144, 4885.2427873679635, 4893.975530122344, 4907.2393778964315, 4907.484714105003, 4913.336699545569, 4266.296061149907, 4284.8500302489265, 4288.185244803477, 4292.377605247221, 4298.720583162084, 5968.880622387528, 6086.7565297388055, 6142.416470435302, 6163.630182189083, 6169.81490555284, 5639.15412688096, 5639.661620302795, 5646.2942132233475, 5647.632903861236, 5654.688992105433, 6743.0, 6751.932480675228, 6753.61550882068, 6788.524803263774, 6792.049113124167, 4639.327297541871, 4639.6752227344095, 4641.883952901171, 4648.83729069481, 4659.673822832403, 7062.081929349203, 7107.573545587281, 7154.785356439315, 7166.104236970431, 7191.101112360955, 4710.24636058229, 4805.831795887128, 4826.276058591239, 4827.951720482821, 4833.879153021132, 4818.156822556039, 4870.123377791961, 4876.439209490883, 4879.1461494238365, 4893.09477746618, 5615.354234263031, 5626.746796394172, 5630.436956304418, 5661.66030038199, 5677.74450149736, 6825.419839313615, 6830.965845170742, 6857.622830744357, 6868.0, 6873.621950792654, 1719.5872990482194, 1736.7308067249596, 1737.7393390991454, 1739.7564340992271, 1741.2425594866274, 1114.4650567727535, 1138.6242539961793, 1151.0216316131389, 1155.8035134027068, 1160.066146751856, 6495.6752162391695, 6546.70539825709, 6546.803595892131, 6552.049952756919, 6597.406233439014, 7032.929670703227, 7035.296470352924, 7060.611666358297, 7068.399186069241, 7091.574505529685, 6456.677166141674, 6523.64119973406, 6631.038499417557, 6650.567713098633, 6656.2345330287635, 3838.213166300902, 3861.131245469803, 3863.6715879150024, 3884.8057597120032, 3895.0846551060476, 7359.411247100219, 7407.407407407394, 7432.479726419098, 7442.479026468095, 7455.4408419368765, 7326.04761381017, 7333.88999165013, 7340.596267205355, 7368.410527157815, 7372.262773722692, 7237.63811809418, 7393.704251829974, 7417.443691723034, 7440.404767618577, 7483.962580187173, 7101.786946391617, 7105.396041336544, 7152.642367881689, 7155.105611798525, 7156.0, 7041.964790176016, 7044.894326585208, 7072.575645461289, 7073.328033836778, 7084.397826184626, 7277.053982982178, 7402.1857595665515, 7422.1835598085245, 7422.703091876265, 7426.071741032371, 4836.637252206169, 4913.606911447004, 4930.112579735682, 4930.654854160174, 4936.851894443029, 7053.118360204974, 7097.858042839011, 7103.964480177566, 7131.964340178266, 7150.856982860209, 6884.208316043519, 6930.445564354739, 6931.896021559782, 6936.583804971718, 6953.061336719478, 6807.353301436356, 6929.445644348541, 6934.271901450275, 6936.098307220231, 6936.965315173392, 6767.1879374475375, 6789.93210067893, 6796.5727197289125, 6805.727770889307, 6821.556598821259, 6941.722331106901, 6969.895451568332, 6984.301569842975, 6999.545029573062, 7001.439884809305, 6791.660416979033, 6797.830054248486, 6803.727850885909, 6804.21751498584, 6806.319368063154], "unit": "score", "name": "prototype.html", "value": 5171.932838051695}, {"lowerIsBetter": false, "replicates": [757.2427572427572, 770.010536460648, 774.357283454733, 788.9447738658296, 798.7483942558093, 14730.852691473083, 15059.774103388458, 15085.622859428506, 15091.0, 15093.54719358421, 14152.150870947751, 14474.348654310556, 14517.927410362934, 14521.20133392663, 14578.12531248126, 912.7991841794811, 913.2009491694768, 945.475261230017, 950.2635457520408, 950.5057370167509, 932.0586207929972, 933.0436302789661, 933.4119504712022, 934.7663084228943, 939.1876027236425, 970.3062310448029, 976.7313988653107, 978.8042391521689, 981.8429051351785, 982.0817535604198, 962.1100482054107, 963.6723514005237, 967.0522887570186, 970.2626004236761, 970.3983530211243, 719.0329007484925, 721.0122132678212, 723.1286300008477, 723.9022731931175, 725.1624373848214, 13749.106308090042, 13801.171929684251, 13882.652933676638, 13894.0, 13940.58178254654, 12732.299723515296, 12884.742305153844, 12901.419436125398, 13071.803922941164, 13095.279759613217, 9967.950160249226, 10629.362238265729, 10815.35107893529, 10890.61882834097, 10922.071623911897, 3619.728520360957, 3620.9275814483562, 3630.818459077062, 3639.090227443139, 3684.926301473982, 52368.73815630936, 52398.0, 52399.0, 53292.200616990776, 53849.73075134638, 9954.402735835873, 10064.245181611408, 10142.543585538668, 10229.846552301722, 10337.9483102584, 18895.96072216014, 18966.0, 18966.146523406478, 18979.905100474687, 18990.335338263096, 6893.276205998398, 6950.443964482829, 7100.0, 7100.360967512948, 7475.0656167979005, 3934.3114954883354, 4024.7182697210915, 4044.5348784889525, 4051.9797401012806, 4074.3888416737727, 3280.5407242986003, 3297.422950983568, 3297.9010629681147, 3328.816915069646, 3335.149536868083, 603.1164344235716, 603.4026313949247, 603.6830663901399, 609.5123900879279, 614.9600275982046, 617.5337620096798, 652.6214795418646, 679.1748026148155, 689.7758228575733, 690.9378155965987, 8514.914850851535, 8589.570521473901, 8938.642454301755, 9007.63969441228, 9056.230220431205, 556.0214023318988, 576.469647923911, 683.2859661653584, 694.3438450664074, 711.5019486359569, 3878.7478813877005, 3944.9408258876138, 4034.677225821927, 4125.711200216017, 4175.31107367281, 59857.70071149617, 60033.399666002784, 60730.69634651799, 61151.38848611546, 61199.69400152971, 51516.0, 54234.728826356404, 55045.0, 55136.72431637816, 55220.0, 47442.051158976625, 48004.5199548007, 48447.515524845, 48456.7577162119, 49118.50881491211, 8701.6954406598, 8754.60604272822, 8775.385722999328, 8849.69026084084, 9079.273658107204, 35942.640573593926, 37062.44406333853, 37881.999999998894, 38141.4278785824, 38846.223075538896, 45179.322310164716, 45286.0, 45509.31736023896, 45590.544094559955, 47158.29262561133, 10965.61620343284, 11121.221514494231, 11185.384803835866, 11494.137939654393, 11542.653720388065, 10833.349999000086, 11893.940530297294, 11998.340091295062, 12615.621531354074, 12695.80956285675, 10645.574177032831, 10984.615538456115, 11192.832107518556, 11219.439028048402, 11523.769524609294, 11555.768884622428, 11626.53493860236, 11642.185047046625, 11848.70378240551, 11925.463354148911, 9961.900380996098, 10003.29976901639, 10238.33450825694, 11395.202335836411, 11482.942585287354, 8618.138186181332, 8869.379143460154, 8872.201501864864, 9606.471644059644, 9648.75878103053, 9686.273529485175, 9834.065763752433, 9850.950745246228, 9895.50522473859, 9969.102780749477], "unit": "score", "name": "yui.html", "value": 6558.582682778461}], "name": "dromaeo_css", "value": 7377.35736379227}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 103.0, 110.0, 109.0, 115.0, 121.0, 111.0, 111.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 158.0, 167.0, 130.0, 157.0, 152.0, 129.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [166.0, 164.0, 163.0, 166.0, 163.0, 164.0, 164.0, 164.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 76.0, 163.0, 76.0, 76.0, 74.0, 76.0, 161.0, 77.0], "unit": "score", "name": "audio-fft", "value": 93.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 146.0, 93.0, 93.0, 93.0, 143.0, 93.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 125.0, 117.0, 117.0, 117.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [55.0, 61.0, 57.0, 59.0, 57.0, 57.0, 58.0, 64.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 67.0, 65.0, 66.0, 66.0, 64.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 79.0, 79.0, 79.0, 80.0, 78.0, 79.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.6}, {"lowerIsBetter": true, "replicates": [113.0, 112.0, 115.0, 112.0, 112.0, 123.0, 120.0, 112.0, 113.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.3}, {"lowerIsBetter": true, "replicates": [139.0, 146.0, 139.0, 157.0, 150.0, 146.0, 144.0, 152.0, 139.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.7}, {"lowerIsBetter": true, "replicates": [67.0, 74.0, 68.0, 66.0, 69.0, 68.0, 66.0, 67.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1513.0}]} 04:59:31 INFO - Return code: 0 04:59:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:59:31 ERROR - # TBPL SUCCESS # 04:59:31 INFO - Running post-action listener: _resource_record_post_action 04:59:31 INFO - Running post-run listener: _resource_record_post_run 04:59:32 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 278528; Write bytes: 495685632; Read time: 32; Write time: 939684 04:59:32 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 221597696; Read time: 0; Write time: 511140 04:59:32 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 278528; Write bytes: 244285440; Read time: 32; Write time: 420752 04:59:32 INFO - Running post-run listener: _upload_blobber_files 04:59:32 INFO - Blob upload gear active. 04:59:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:32 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:59:32 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:59:32 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:59:32 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:59:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:59:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:33 INFO - (blobuploader) - INFO - Done attempting. 04:59:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:59:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:59:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:35 INFO - (blobuploader) - INFO - Done attempting. 04:59:35 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:35 INFO - Return code: 0 04:59:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5407a8ef3a12238c6ea3094ab9faeb9ad1e1b79fd36c6e75ce2288962259da3cc9cd9dc8a0e404879a1ce77792c0cfaeae04a4a02007bbb9198beabc01d7b286", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a1cde384edcce03cf7bfe7a76fad925d2da0cc21e065da497281fd19d182309b4753d351bdeeb26126b541dee2c4d95ef5b254fdbeaab53208d121e0af41366"} 04:59:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:35 INFO - Contents: 04:59:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5407a8ef3a12238c6ea3094ab9faeb9ad1e1b79fd36c6e75ce2288962259da3cc9cd9dc8a0e404879a1ce77792c0cfaeae04a4a02007bbb9198beabc01d7b286", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a1cde384edcce03cf7bfe7a76fad925d2da0cc21e065da497281fd19d182309b4753d351bdeeb26126b541dee2c4d95ef5b254fdbeaab53208d121e0af41366"} 04:59:35 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:35 INFO - Copying logs to upload dir... 04:59:35 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.770126 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-20 04:59:34.999178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:59:35.002592) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822 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/5407a8ef3a12238c6ea3094ab9faeb9ad1e1b79fd36c6e75ce2288962259da3cc9cd9dc8a0e404879a1ce77792c0cfaeae04a4a02007bbb9198beabc01d7b286", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a1cde384edcce03cf7bfe7a76fad925d2da0cc21e065da497281fd19d182309b4753d351bdeeb26126b541dee2c4d95ef5b254fdbeaab53208d121e0af41366"} build_url:https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/Jww7DKZAQAKUsFg_p2E2jQ/artifacts/public/build/firefox-47.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/5407a8ef3a12238c6ea3094ab9faeb9ad1e1b79fd36c6e75ce2288962259da3cc9cd9dc8a0e404879a1ce77792c0cfaeae04a4a02007bbb9198beabc01d7b286", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a1cde384edcce03cf7bfe7a76fad925d2da0cc21e065da497281fd19d182309b4753d351bdeeb26126b541dee2c4d95ef5b254fdbeaab53208d121e0af41366"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:59:35.027441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:59:35.027770) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1461152333.616834-1656124822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:59:35.113002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:59:35.113341) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:59:35.113647) ========= ========= Total master_lag: 0.17 =========