builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1462529705.08 results: success (0) buildid: 20160505123841 builduid: 1457772db7ef4c1982b4796b67a4914d revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.077690) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.078083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.078361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.105755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.106010) ========= 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=574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 03:15:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-05-06 03:15:07 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147368 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.268460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.268761) ========= 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=574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022777 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:05.339148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 03:15:05.339446) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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=574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 03:15:07,523 truncating revision to first 12 chars 2016-05-06 03:15:07,523 Setting DEBUG logging. 2016-05-06 03:15:07,523 attempt 1/10 2016-05-06 03:15:07,523 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0123e9f41ced?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 03:15:07,923 unpacking tar archive at: mozilla-aurora-0123e9f41ced/testing/mozharness/ program finished with exit code 0 elapsedTime=1.074291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 03:15:06.438175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:06.438475) ========= script_repo_revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:06.438902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:06.439174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:15:06.450861) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-06 03:15:06.451114) ========= /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=574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:15:08 INFO - MultiFileLogger online at 20160506 03:15:08 in /builds/slave/test 03:15:08 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 03:15:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:08 INFO - {'append_to_log': False, 03:15:08 INFO - 'base_work_dir': '/builds/slave/test', 03:15:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:15:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:08 INFO - 'branch': 'Mozilla-Aurora', 03:15:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:08 INFO - 'config_files': ('talos/linux_config.py',), 03:15:08 INFO - 'default_actions': ('clobber', 03:15:08 INFO - 'read-buildbot-config', 03:15:08 INFO - 'download-and-extract', 03:15:08 INFO - 'populate-webroot', 03:15:08 INFO - 'create-virtualenv', 03:15:08 INFO - 'install', 03:15:08 INFO - 'run-tests'), 03:15:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:08 INFO - 'download_minidump_stackwalk': True, 03:15:08 INFO - 'download_symbols': 'ondemand', 03:15:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:08 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:08 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:08 INFO - 'installer_path': 'installer.exe', 03:15:08 INFO - 'log_level': 'info', 03:15:08 INFO - 'log_name': 'talos', 03:15:08 INFO - 'log_to_console': True, 03:15:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:15:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:15:08 INFO - 'opt_config_files': (), 03:15:08 INFO - 'pip_index': False, 03:15:08 INFO - 'sps_profile': False, 03:15:08 INFO - 'sps_profile_interval': 0, 03:15:08 INFO - 'suite': 'dromaeojs-e10s', 03:15:08 INFO - 'system_bits': '32', 03:15:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:08 INFO - 'title': 'talos-linux64-ix-044', 03:15:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:08 INFO - 'use_talos_json': True, 03:15:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:08 INFO - 'work_dir': 'build'} 03:15:08 INFO - ##### 03:15:08 INFO - ##### Running clobber step. 03:15:08 INFO - ##### 03:15:08 INFO - Running pre-action listener: _resource_record_pre_action 03:15:08 INFO - Running main action method: clobber 03:15:08 INFO - rmtree: /builds/slave/test/build 03:15:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:09 INFO - Running post-action listener: _resource_record_post_action 03:15:09 INFO - ##### 03:15:09 INFO - ##### Running read-buildbot-config step. 03:15:09 INFO - ##### 03:15:09 INFO - Running pre-action listener: _resource_record_pre_action 03:15:09 INFO - Running main action method: read_buildbot_config 03:15:09 INFO - Using buildbot properties: 03:15:09 INFO - { 03:15:09 INFO - "project": "", 03:15:09 INFO - "product": "firefox", 03:15:09 INFO - "script_repo_revision": "production", 03:15:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:15:09 INFO - "repository": "", 03:15:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:15:09 INFO - "buildid": "20160505123841", 03:15:09 INFO - "pgo_build": "True", 03:15:09 INFO - "basedir": "/builds/slave/test", 03:15:09 INFO - "buildnumber": 251, 03:15:09 INFO - "slavename": "talos-linux64-ix-044", 03:15:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:15:09 INFO - "platform": "ubuntu64_hw", 03:15:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:15:09 INFO - "branch": "mozilla-aurora", 03:15:09 INFO - "repo_path": "releases/mozilla-aurora", 03:15:09 INFO - "revision": "0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b", 03:15:09 INFO - "stage_platform": "linux64-pgo", 03:15:09 INFO - "builduid": "1457772db7ef4c1982b4796b67a4914d", 03:15:09 INFO - "slavebuilddir": "test" 03:15:09 INFO - } 03:15:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:15:09 INFO - Running post-action listener: _resource_record_post_action 03:15:09 INFO - ##### 03:15:09 INFO - ##### Running download-and-extract step. 03:15:09 INFO - ##### 03:15:09 INFO - Running pre-action listener: _resource_record_pre_action 03:15:09 INFO - Running main action method: download_and_extract 03:15:09 INFO - mkdir: /builds/slave/test/build/tests 03:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:09 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:15:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:15:11 INFO - Downloaded 1361 bytes. 03:15:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:15:11 INFO - Using the following test package requirements: 03:15:11 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:11 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:15:11 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:15:11 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:11 INFO - u'jsshell-linux-x86_64.zip'], 03:15:11 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:15:11 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:11 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:15:11 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:15:11 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:15:11 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:15:11 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:15:11 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')]} 03:15:11 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:15:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:15:13 INFO - Downloaded 23824026 bytes. 03:15:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:15:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:15:14 INFO - Return code: 0 03:15:14 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:15: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')]} 03:15:14 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:15:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:15:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:15:15 INFO - Downloaded 23824026 bytes. 03:15:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:15:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:15:16 INFO - Return code: 0 03:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:16 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:15:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:15:17 INFO - Downloaded 10840145 bytes. 03:15:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:15:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:15:17 INFO - Return code: 0 03:15:17 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')]} 03:15:17 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:15:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:15:22 INFO - Downloaded 62687148 bytes. 03:15:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:22 INFO - mkdir: /builds/slave/test/properties 03:15:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:22 INFO - Contents: 03:15:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:15:23 INFO - Running post-action listener: _resource_record_post_action 03:15:23 INFO - Running post-action listener: set_extra_try_arguments 03:15:23 INFO - ##### 03:15:23 INFO - ##### Running populate-webroot step. 03:15:23 INFO - ##### 03:15:23 INFO - Running pre-action listener: _resource_record_pre_action 03:15:23 INFO - Running main action method: populate_webroot 03:15:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:23 INFO - '--tppagecycles', 03:15:23 INFO - '7'], 03:15:23 INFO - 'tests': ['tsvgm']}}, 03:15:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:23 INFO - 'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:23 INFO - 'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['damp', 'tps']}, 03:15:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:23 INFO - 'tests': ['damp', 'tps']}, 03:15:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['dromaeo_dom']}, 03:15:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['a11yr', 03:15:23 INFO - 'ts_paint', 03:15:23 INFO - 'tpaint', 03:15:23 INFO - 'sessionrestore', 03:15:23 INFO - 'sessionrestore_no_auto_restore', 03:15:23 INFO - 'tabpaint']}, 03:15:23 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:23 INFO - 'ts_paint', 03:15:23 INFO - 'tpaint', 03:15:23 INFO - 'sessionrestore', 03:15:23 INFO - 'sessionrestore_no_auto_restore', 03:15:23 INFO - 'tabpaint']}, 03:15:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:15:23 INFO - 'ts_paint', 03:15:23 INFO - 'tpaint', 03:15:23 INFO - 'sessionrestore', 03:15:23 INFO - 'sessionrestore_no_auto_restore', 03:15:23 INFO - 'tabpaint']}, 03:15:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:15:23 INFO - 'ts_paint', 03:15:23 INFO - 'tpaint', 03:15:23 INFO - 'sessionrestore', 03:15:23 INFO - 'sessionrestore_no_auto_restore', 03:15:23 INFO - 'tabpaint']}, 03:15:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['a11yr', 03:15:23 INFO - 'ts_paint', 03:15:23 INFO - 'tpaint', 03:15:23 INFO - 'sessionrestore', 03:15:23 INFO - 'sessionrestore_no_auto_restore', 03:15:23 INFO - 'tabpaint']}, 03:15:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['a11yr', 03:15:23 INFO - 'ts_paint', 03:15:23 INFO - 'tpaint', 03:15:23 INFO - 'sessionrestore', 03:15:23 INFO - 'sessionrestore_no_auto_restore', 03:15:23 INFO - 'tabpaint']}, 03:15:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['tsvgx', 03:15:23 INFO - 'tsvgr_opacity', 03:15:23 INFO - 'tart', 03:15:23 INFO - 'tscrollx', 03:15:23 INFO - 'cart']}, 03:15:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:23 INFO - 'tsvgr_opacity', 03:15:23 INFO - 'tart', 03:15:23 INFO - 'tscrollx', 03:15:23 INFO - 'cart']}, 03:15:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:23 INFO - 'talos_options': ['--disable-e10s'], 03:15:23 INFO - 'tests': ['tp5o']}, 03:15:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:23 INFO - 'tests': ['tp5o']}, 03:15:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:23 INFO - 'talos_options': ['--disable-e10s', 03:15:23 INFO - '--xperf_path', 03:15:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:23 INFO - 'tests': ['tp5n']}, 03:15:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:23 INFO - 'talos_options': ['--xperf_path', 03:15:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:23 INFO - 'tests': ['tp5n']}}, 03:15:23 INFO - 'talos.zip': {'path': '', 03:15:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:23 INFO - Running post-action listener: _resource_record_post_action 03:15:23 INFO - ##### 03:15:23 INFO - ##### Running create-virtualenv step. 03:15:23 INFO - ##### 03:15:23 INFO - Running pre-action listener: _resource_record_pre_action 03:15:23 INFO - Running main action method: create_virtualenv 03:15:23 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:23 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 03:15:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:23 INFO - Using real prefix '/usr' 03:15:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:26 INFO - Installing pip.................done. 03:15:26 INFO - Return code: 0 03:15:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68fec5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, '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': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', '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 03:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:15:26 INFO - Using env: {'DISPLAY': ':0', 03:15:26 INFO - 'HOME': '/home/cltbld', 03:15:26 INFO - 'LANG': 'en_US.UTF-8', 03:15:26 INFO - 'LANGUAGE': 'en_US:en', 03:15:26 INFO - 'LOGNAME': 'cltbld', 03:15:26 INFO - 'MAIL': '/var/mail/cltbld', 03:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:26 INFO - 'MOZ_NO_REMOTE': '1', 03:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:26 INFO - 'NO_EM_RESTART': '1', 03:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:26 INFO - 'PWD': '/builds/slave/test', 03:15:26 INFO - 'SHELL': '/bin/bash', 03:15:26 INFO - 'SHLVL': '1', 03:15:26 INFO - 'TERM': 'linux', 03:15:26 INFO - 'TMOUT': '86400', 03:15:26 INFO - 'USER': 'cltbld', 03:15:26 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:26 INFO - '_': '/tools/buildbot/bin/python'} 03:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:26 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 03:15:26 INFO - Cleaning up... 03:15:26 INFO - Return code: 0 03:15:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f68fec5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, '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': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', '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 03:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:15:26 INFO - Using env: {'DISPLAY': ':0', 03:15:26 INFO - 'HOME': '/home/cltbld', 03:15:26 INFO - 'LANG': 'en_US.UTF-8', 03:15:26 INFO - 'LANGUAGE': 'en_US:en', 03:15:26 INFO - 'LOGNAME': 'cltbld', 03:15:26 INFO - 'MAIL': '/var/mail/cltbld', 03:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:26 INFO - 'MOZ_NO_REMOTE': '1', 03:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:26 INFO - 'NO_EM_RESTART': '1', 03:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:26 INFO - 'PWD': '/builds/slave/test', 03:15:26 INFO - 'SHELL': '/bin/bash', 03:15:26 INFO - 'SHLVL': '1', 03:15:26 INFO - 'TERM': 'linux', 03:15:26 INFO - 'TMOUT': '86400', 03:15:26 INFO - 'USER': 'cltbld', 03:15:26 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:26 INFO - '_': '/tools/buildbot/bin/python'} 03:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:26 INFO - Downloading/unpacking psutil>=0.7.1 03:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:28 INFO - Installing collected packages: psutil 03:15:28 INFO - Running setup.py install for psutil 03:15:28 INFO - building 'psutil._psutil_linux' extension 03:15:28 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 03:15:28 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 03:15:28 INFO - building 'psutil._psutil_posix' extension 03:15:28 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 03:15:28 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 03:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:29 INFO - Successfully installed psutil 03:15:29 INFO - Cleaning up... 03:15:29 INFO - Return code: 0 03:15:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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')]} 03:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:29 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 0x7f68fec5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, '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': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', '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 03:15:29 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 03:15:29 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 03:15:29 INFO - Using env: {'DISPLAY': ':0', 03:15:29 INFO - 'HOME': '/home/cltbld', 03:15:29 INFO - 'LANG': 'en_US.UTF-8', 03:15:29 INFO - 'LANGUAGE': 'en_US:en', 03:15:29 INFO - 'LOGNAME': 'cltbld', 03:15:29 INFO - 'MAIL': '/var/mail/cltbld', 03:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:29 INFO - 'MOZ_NO_REMOTE': '1', 03:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:29 INFO - 'NO_EM_RESTART': '1', 03:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:29 INFO - 'PWD': '/builds/slave/test', 03:15:29 INFO - 'SHELL': '/bin/bash', 03:15:29 INFO - 'SHLVL': '1', 03:15:29 INFO - 'TERM': 'linux', 03:15:29 INFO - 'TMOUT': '86400', 03:15:29 INFO - 'USER': 'cltbld', 03:15:29 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:29 INFO - '_': '/tools/buildbot/bin/python'} 03:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:15:29 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 03:15:29 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 03:15:29 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 03:15:29 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 03:15:29 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 03:15:29 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 03:15:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:15:31 INFO - Installing collected packages: mozsystemmonitor 03:15:31 INFO - Running setup.py install for mozsystemmonitor 03:15:31 INFO - Successfully installed mozsystemmonitor 03:15:31 INFO - Cleaning up... 03:15:31 INFO - Return code: 0 03:15:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:15:31 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')]} 03:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:31 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')]} 03:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:31 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 0x7f68fec5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, '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': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', '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 03:15:31 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 03:15:31 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 03:15:31 INFO - Using env: {'DISPLAY': ':0', 03:15:31 INFO - 'HOME': '/home/cltbld', 03:15:31 INFO - 'LANG': 'en_US.UTF-8', 03:15:31 INFO - 'LANGUAGE': 'en_US:en', 03:15:31 INFO - 'LOGNAME': 'cltbld', 03:15:31 INFO - 'MAIL': '/var/mail/cltbld', 03:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:31 INFO - 'MOZ_NO_REMOTE': '1', 03:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:31 INFO - 'NO_EM_RESTART': '1', 03:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:31 INFO - 'PWD': '/builds/slave/test', 03:15:31 INFO - 'SHELL': '/bin/bash', 03:15:31 INFO - 'SHLVL': '1', 03:15:31 INFO - 'TERM': 'linux', 03:15:31 INFO - 'TMOUT': '86400', 03:15:31 INFO - 'USER': 'cltbld', 03:15:31 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:31 INFO - '_': '/tools/buildbot/bin/python'} 03:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:15:31 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 03:15:31 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 03:15:31 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 03:15:31 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 03:15:31 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 03:15:31 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 03:15:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:15:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:15:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15:34 INFO - Downloading docopt-0.6.1.tar.gz 03:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:15:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:15:34 INFO - Running setup.py install for blobuploader 03:15:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:15:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:15:34 INFO - Running setup.py install for requests 03:15:34 INFO - Running setup.py install for docopt 03:15:34 INFO - Successfully installed blobuploader requests docopt 03:15:34 INFO - Cleaning up... 03:15:34 INFO - Return code: 0 03:15:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:34 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 0x7f68fec5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, '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': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', '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 03:15:34 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 03:15:34 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 03:15:34 INFO - Using env: {'DISPLAY': ':0', 03:15:34 INFO - 'HOME': '/home/cltbld', 03:15:34 INFO - 'LANG': 'en_US.UTF-8', 03:15:34 INFO - 'LANGUAGE': 'en_US:en', 03:15:34 INFO - 'LOGNAME': 'cltbld', 03:15:34 INFO - 'MAIL': '/var/mail/cltbld', 03:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:34 INFO - 'MOZ_NO_REMOTE': '1', 03:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:34 INFO - 'NO_EM_RESTART': '1', 03:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:34 INFO - 'PWD': '/builds/slave/test', 03:15:34 INFO - 'SHELL': '/bin/bash', 03:15:34 INFO - 'SHLVL': '1', 03:15:34 INFO - 'TERM': 'linux', 03:15:34 INFO - 'TMOUT': '86400', 03:15:34 INFO - 'USER': 'cltbld', 03:15:34 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:34 INFO - '_': '/tools/buildbot/bin/python'} 03:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:35 INFO - Running setup.py (path:/tmp/pip-k3f8sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:35 INFO - Running setup.py (path:/tmp/pip-Zfx5At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:35 INFO - Running setup.py (path:/tmp/pip-WyQh_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:35 INFO - Running setup.py (path:/tmp/pip-eCSAEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:35 INFO - Running setup.py (path:/tmp/pip-DkV13b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:35 INFO - Running setup.py (path:/tmp/pip-T2Lyi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:35 INFO - Running setup.py (path:/tmp/pip-zDhvhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:35 INFO - Running setup.py (path:/tmp/pip-GKeTF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:35 INFO - Running setup.py (path:/tmp/pip-7LTekN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:35 INFO - Running setup.py (path:/tmp/pip-mNRMgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:35 INFO - Running setup.py (path:/tmp/pip-DAi4zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:35 INFO - Running setup.py (path:/tmp/pip-gEjSfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:35 INFO - Running setup.py (path:/tmp/pip-bWU3v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:36 INFO - Running setup.py (path:/tmp/pip-gUDgrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:36 INFO - Running setup.py (path:/tmp/pip-20Cg0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:36 INFO - Running setup.py (path:/tmp/pip-MflIlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:36 INFO - Running setup.py (path:/tmp/pip-a3kRCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:15:36 INFO - Running setup.py install for manifestparser 03:15:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Running setup.py install for mozcrash 03:15:36 INFO - Running setup.py install for mozdebug 03:15:36 INFO - Running setup.py install for mozdevice 03:15:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Running setup.py install for mozfile 03:15:36 INFO - Running setup.py install for mozhttpd 03:15:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Running setup.py install for mozinfo 03:15:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Running setup.py install for mozInstall 03:15:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Running setup.py install for mozleak 03:15:37 INFO - Running setup.py install for mozlog 03:15:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Running setup.py install for moznetwork 03:15:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Running setup.py install for mozprocess 03:15:37 INFO - Running setup.py install for mozprofile 03:15:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Running setup.py install for mozrunner 03:15:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Running setup.py install for mozscreenshot 03:15:37 INFO - Running setup.py install for moztest 03:15:37 INFO - Running setup.py install for mozversion 03:15:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:15:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:15:38 INFO - Cleaning up... 03:15:38 INFO - Return code: 0 03:15:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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')]} 03:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:38 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 0x7f68fec5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, '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': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', '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 03:15:38 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 03:15:38 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 03:15:38 INFO - Using env: {'DISPLAY': ':0', 03:15:38 INFO - 'HOME': '/home/cltbld', 03:15:38 INFO - 'LANG': 'en_US.UTF-8', 03:15:38 INFO - 'LANGUAGE': 'en_US:en', 03:15:38 INFO - 'LOGNAME': 'cltbld', 03:15:38 INFO - 'MAIL': '/var/mail/cltbld', 03:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:38 INFO - 'MOZ_NO_REMOTE': '1', 03:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:38 INFO - 'NO_EM_RESTART': '1', 03:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:38 INFO - 'PWD': '/builds/slave/test', 03:15:38 INFO - 'SHELL': '/bin/bash', 03:15:38 INFO - 'SHLVL': '1', 03:15:38 INFO - 'TERM': 'linux', 03:15:38 INFO - 'TMOUT': '86400', 03:15:38 INFO - 'USER': 'cltbld', 03:15:38 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:38 INFO - '_': '/tools/buildbot/bin/python'} 03:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:38 INFO - Running setup.py (path:/tmp/pip-j1qTD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:38 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)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:38 INFO - Running setup.py (path:/tmp/pip-h_mP2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:38 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)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:38 INFO - Running setup.py (path:/tmp/pip-sWlkim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:38 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)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:38 INFO - Running setup.py (path:/tmp/pip-XX5rrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:38 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)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:38 INFO - Running setup.py (path:/tmp/pip-8kelVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:38 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)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:38 INFO - Running setup.py (path:/tmp/pip-zRbCv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:38 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)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:38 INFO - Running setup.py (path:/tmp/pip-M2zB3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:38 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)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:38 INFO - Running setup.py (path:/tmp/pip-6V0RJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:38 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)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:38 INFO - Running setup.py (path:/tmp/pip-ykB9V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:38 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)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:38 INFO - Running setup.py (path:/tmp/pip-moFY4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:39 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)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:39 INFO - Running setup.py (path:/tmp/pip-KL5D3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:39 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)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:39 INFO - Running setup.py (path:/tmp/pip-jYFn7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:39 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)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:39 INFO - Running setup.py (path:/tmp/pip-OiQOtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:39 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)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:39 INFO - Running setup.py (path:/tmp/pip-eZBZpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:39 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)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:39 INFO - Running setup.py (path:/tmp/pip-ncWivI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:39 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)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:39 INFO - Running setup.py (path:/tmp/pip-4nJu4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:39 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)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:39 INFO - Running setup.py (path:/tmp/pip-k1ioLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:39 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)) 03:15:39 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)) 03:15:39 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)) 03:15:39 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)) 03:15:39 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)) 03:15:39 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)) 03:15:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15: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 03:15:41 INFO - Downloading blessings-1.6.tar.gz 03:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:15:41 INFO - Installing collected packages: blessings 03:15:41 INFO - Running setup.py install for blessings 03:15:41 INFO - Successfully installed blessings 03:15:41 INFO - Cleaning up... 03:15:41 INFO - Return code: 0 03:15:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:41 INFO - Reading from file tmpfile_stdout 03:15:41 INFO - Current package versions: 03:15:41 INFO - argparse == 1.2.1 03:15:41 INFO - blessings == 1.6 03:15:41 INFO - blobuploader == 1.2.4 03:15:41 INFO - docopt == 0.6.1 03:15:41 INFO - manifestparser == 1.1 03:15:41 INFO - mozInstall == 1.12 03:15:41 INFO - mozcrash == 0.17 03:15:41 INFO - mozdebug == 0.1 03:15:41 INFO - mozdevice == 0.48 03:15:41 INFO - mozfile == 1.2 03:15:41 INFO - mozhttpd == 0.7 03:15:41 INFO - mozinfo == 0.9 03:15:41 INFO - mozleak == 0.1 03:15:41 INFO - mozlog == 3.1 03:15:41 INFO - moznetwork == 0.27 03:15:41 INFO - mozprocess == 0.22 03:15:41 INFO - mozprofile == 0.28 03:15:41 INFO - mozrunner == 6.11 03:15:41 INFO - mozscreenshot == 0.1 03:15:41 INFO - mozsystemmonitor == 0.0 03:15:41 INFO - moztest == 0.7 03:15:41 INFO - mozversion == 1.4 03:15:41 INFO - psutil == 3.1.1 03:15:41 INFO - requests == 1.2.3 03:15:41 INFO - wsgiref == 0.1.2 03:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:41 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 0x7f68fec5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, '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': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', '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 03:15:41 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 03:15:41 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 03:15:41 INFO - Using env: {'DISPLAY': ':0', 03:15:41 INFO - 'HOME': '/home/cltbld', 03:15:41 INFO - 'LANG': 'en_US.UTF-8', 03:15:41 INFO - 'LANGUAGE': 'en_US:en', 03:15:41 INFO - 'LOGNAME': 'cltbld', 03:15:41 INFO - 'MAIL': '/var/mail/cltbld', 03:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:41 INFO - 'MOZ_NO_REMOTE': '1', 03:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:41 INFO - 'NO_EM_RESTART': '1', 03:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:41 INFO - 'PWD': '/builds/slave/test', 03:15:41 INFO - 'SHELL': '/bin/bash', 03:15:41 INFO - 'SHLVL': '1', 03:15:41 INFO - 'TERM': 'linux', 03:15:41 INFO - 'TMOUT': '86400', 03:15:41 INFO - 'USER': 'cltbld', 03:15:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:41 INFO - '_': '/tools/buildbot/bin/python'} 03:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:42 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)) 03:15:42 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)) 03:15:42 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)) 03:15:42 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)) 03:15:42 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)) 03:15:42 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)) 03:15:42 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)) 03:15:42 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)) 03:15:42 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)) 03:15:42 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)) 03:15:42 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)) 03:15:42 INFO - Cleaning up... 03:15:42 INFO - Return code: 0 03:15:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:15:42 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')]} 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:42 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')]} 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:42 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 0x7f68fec5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, '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': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', '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 03:15:42 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 03:15:42 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 03:15:42 INFO - Using env: {'DISPLAY': ':0', 03:15:42 INFO - 'HOME': '/home/cltbld', 03:15:42 INFO - 'LANG': 'en_US.UTF-8', 03:15:42 INFO - 'LANGUAGE': 'en_US:en', 03:15:42 INFO - 'LOGNAME': 'cltbld', 03:15:42 INFO - 'MAIL': '/var/mail/cltbld', 03:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:42 INFO - 'MOZ_NO_REMOTE': '1', 03:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:42 INFO - 'NO_EM_RESTART': '1', 03:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:42 INFO - 'PWD': '/builds/slave/test', 03:15:42 INFO - 'SHELL': '/bin/bash', 03:15:42 INFO - 'SHLVL': '1', 03:15:42 INFO - 'TERM': 'linux', 03:15:42 INFO - 'TMOUT': '86400', 03:15:42 INFO - 'USER': 'cltbld', 03:15:42 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:42 INFO - '_': '/tools/buildbot/bin/python'} 03:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:42 INFO - Downloading/unpacking jsonschema 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:15:44 INFO - Downloading/unpacking functools32 (from jsonschema) 03:15:44 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 03:15:44 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 03:15:44 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 03:15:44 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 03:15:44 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 03:15:44 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 03:15:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:15:44 INFO - warning: no files found matching '*.txt' 03:15:44 INFO - no previously-included directories found matching 'build' 03:15:44 INFO - no previously-included directories found matching 'dist' 03:15:44 INFO - no previously-included directories found matching '.git*' 03:15:44 INFO - Installing collected packages: jsonschema, functools32 03:15:44 INFO - Running setup.py install for functools32 03:15:44 INFO - warning: no files found matching '*.txt' 03:15:44 INFO - no previously-included directories found matching 'build' 03:15:44 INFO - no previously-included directories found matching 'dist' 03:15:44 INFO - no previously-included directories found matching '.git*' 03:15:44 INFO - Successfully installed jsonschema functools32 03:15:44 INFO - Cleaning up... 03:15:44 INFO - Return code: 0 03:15:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:44 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 0x7f68fec5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e955a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, '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': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', '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 03:15:44 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 03:15:44 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 03:15:44 INFO - Using env: {'DISPLAY': ':0', 03:15:44 INFO - 'HOME': '/home/cltbld', 03:15:44 INFO - 'LANG': 'en_US.UTF-8', 03:15:44 INFO - 'LANGUAGE': 'en_US:en', 03:15:44 INFO - 'LOGNAME': 'cltbld', 03:15:44 INFO - 'MAIL': '/var/mail/cltbld', 03:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:44 INFO - 'MOZ_NO_REMOTE': '1', 03:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:44 INFO - 'NO_EM_RESTART': '1', 03:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:44 INFO - 'PWD': '/builds/slave/test', 03:15:44 INFO - 'SHELL': '/bin/bash', 03:15:44 INFO - 'SHLVL': '1', 03:15:44 INFO - 'TERM': 'linux', 03:15:44 INFO - 'TMOUT': '86400', 03:15:44 INFO - 'USER': 'cltbld', 03:15:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:44 INFO - '_': '/tools/buildbot/bin/python'} 03:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:44 INFO - Downloading/unpacking flake8 03:15:44 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 03:15:44 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 03:15:44 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 03:15:44 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 03:15:44 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 03:15:44 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 03:15:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:15:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:15:46 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 03:15:46 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 03:15:46 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 03:15:46 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 03:15:46 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 03:15:46 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 03:15:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:15:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:15:47 INFO - no previously-included directories found matching 'docs/_build' 03:15:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:15:47 INFO - Running setup.py install for pep8 03:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:15:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:15:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:15:47 INFO - no previously-included directories found matching 'docs/_build' 03:15:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:15:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:15:47 INFO - Cleaning up... 03:15:48 INFO - Return code: 0 03:15:48 INFO - Running post-action listener: _resource_record_post_action 03:15:48 INFO - Running post-action listener: _start_resource_monitoring 03:15:49 INFO - Starting resource monitoring. 03:15:49 INFO - ##### 03:15:49 INFO - ##### Running install step. 03:15:49 INFO - ##### 03:15:49 INFO - Running pre-action listener: _resource_record_pre_action 03:15:49 INFO - Running main action method: install 03:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:49 INFO - Reading from file tmpfile_stdout 03:15:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:15:49 INFO - Reading from file tmpfile_stdout 03:15:49 INFO - Output received: 03:15:49 INFO - Usage: mozinstall [options] installer 03:15:49 INFO - Options: 03:15:49 INFO - -h, --help show this help message and exit 03:15:49 INFO - -d DEST, --destination=DEST 03:15:49 INFO - Directory to install application into. [default: 03:15:49 INFO - "/builds/slave/test"] 03:15:49 INFO - --app=APP Application being installed. [default: firefox] 03:15:49 INFO - mkdir: /builds/slave/test/build/application 03:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:16:05 INFO - Reading from file tmpfile_stdout 03:16:05 INFO - Output received: 03:16:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:16:05 INFO - Running post-action listener: _resource_record_post_action 03:16:05 INFO - ##### 03:16:05 INFO - ##### Running run-tests step. 03:16:05 INFO - ##### 03:16:05 INFO - Running pre-action listener: _resource_record_pre_action 03:16:05 INFO - Running main action method: run_tests 03:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:05 INFO - Python 2.7.3 03:16:05 INFO - Return code: 0 03:16:05 INFO - grabbing minidump binary from tooltool 03:16:05 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')]} 03:16:05 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 0x1f24410>, '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 0x1f25310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f257a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:05 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 03:16:05 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 03:16:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:05 INFO - Return code: 0 03:16:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:16:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:16:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:16:06 INFO - Return code: 0 03:16:06 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/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 03:16:06 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/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 03:16:06 INFO - Using env: {'DISPLAY': ':0', 03:16:06 INFO - 'HOME': '/home/cltbld', 03:16:06 INFO - 'LANG': 'en_US.UTF-8', 03:16:06 INFO - 'LANGUAGE': 'en_US:en', 03:16:06 INFO - 'LOGNAME': 'cltbld', 03:16:06 INFO - 'MAIL': '/var/mail/cltbld', 03:16:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:06 INFO - 'MOZ_NO_REMOTE': '1', 03:16:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:06 INFO - 'NO_EM_RESTART': '1', 03:16:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:06 INFO - 'PWD': '/builds/slave/test', 03:16:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:06 INFO - 'SHELL': '/bin/bash', 03:16:06 INFO - 'SHLVL': '1', 03:16:06 INFO - 'TERM': 'linux', 03:16:06 INFO - 'TMOUT': '86400', 03:16:06 INFO - 'USER': 'cltbld', 03:16:06 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468', 03:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:06 INFO - '_': '/tools/buildbot/bin/python'} 03:16:06 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/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 03:16:06 INFO - mozversion application_buildid: 20160505123841 03:16:06 INFO - mozversion application_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:16:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:16:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:06 INFO - mozversion application_name: Firefox 03:16:06 INFO - mozversion application_remotingname: firefox-dev 03:16:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:06 INFO - mozversion application_vendor: Mozilla 03:16:06 INFO - mozversion application_version: 48.0a2 03:16:06 INFO - mozversion platform_buildid: 20160505123841 03:16:06 INFO - mozversion platform_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:16:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:06 INFO - mozversion platform_version: 48.0a2 03:16:06 INFO - using testdate: 1462529766 03:16:06 INFO - actual date: 1462529766 03:16:06 INFO - starting webserver on 'localhost:55361' 03:16:06 INFO - SUITE-START | Running 2 tests 03:16:06 INFO - TEST-START | dromaeo_css 03:16:06 INFO - operating with platform_type : linux_ 03:16:06 INFO - Initialising browser for dromaeo_css test... 03:16:06 INFO - TEST-INFO | started process 27083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfORu50/profile http://localhost:55361/getInfo.html) 03:16:10 INFO - PROCESS | 27083 | 03:16:10 INFO - PROCESS | 27083 | (process:27164): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:16:10 INFO - PROCESS | 27083 | __metrics Screen width/height:1600/1200 03:16:10 INFO - PROCESS | 27083 | colorDepth:24 03:16:10 INFO - PROCESS | 27083 | Browser inner width/height: 1024/697 03:16:10 INFO - PROCESS | 27083 | __metrics 03:16:11 ERROR - PROCESS | 27083 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:16:12 INFO - TEST-INFO | 27083: exit 0 03:16:12 INFO - Browser initialized. 03:16:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:12 INFO - TEST-INFO | started process 27215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfORu50/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:14 INFO - PROCESS | 27215 | 03:16:14 INFO - PROCESS | 27215 | (process:27285): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:16:24 INFO - PROCESS | 27215 | RSS: Main: 152666112 03:16:24 INFO - PROCESS | 27215 | 03:17:13 INFO - PROCESS | 27215 | 1462529833763 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] 03:19:21 INFO - PROCESS | 27215 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55361/tests/dromaeo/cssquery-ext.html) 03:19:22 INFO - PROCESS | 27215 | RSS: Main: 155394048 03:19:22 INFO - PROCESS | 27215 | 03:22:24 INFO - PROCESS | 27215 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-ext.html (next: http://localhost:55361/tests/dromaeo/cssquery-jquery.html) 03:22:24 INFO - PROCESS | 27215 | RSS: Main: 155004928 03:22:24 INFO - PROCESS | 27215 | 03:25:26 INFO - PROCESS | 27215 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55361/tests/dromaeo/cssquery-mootools.html) 03:25:27 INFO - PROCESS | 27215 | RSS: Main: 153669632 03:25:27 INFO - PROCESS | 27215 | 03:28:28 INFO - PROCESS | 27215 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55361/tests/dromaeo/cssquery-prototype.html) 03:28:29 INFO - PROCESS | 27215 | RSS: Main: 153321472 03:28:29 INFO - PROCESS | 27215 | 03:31:31 INFO - PROCESS | 27215 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55361/tests/dromaeo/cssquery-yui.html) 03:31:32 INFO - PROCESS | 27215 | RSS: Main: 154824704 03:31:32 INFO - PROCESS | 27215 | 03:34:34 INFO - PROCESS | 27215 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-yui.html (next: http://localhost:55361/tests/dromaeo/cssquery-dojo.html) 03:34:34 INFO - PROCESS | 27215 | RSS: Main: 155676672 03:34:34 INFO - PROCESS | 27215 | 03:34:34 INFO - PROCESS | 27215 | __start_tp_report 03:34:34 INFO - PROCESS | 27215 | _x_x_mozilla_page_load 03:34:34 INFO - PROCESS | 27215 | _x_x_mozilla_page_load_details 03:34:34 INFO - PROCESS | 27215 | |i|pagename|runs| 03:34:34 INFO - PROCESS | 27215 | |0;dojo.html;3345.297487527619;3389.8983030509094;3405.421078416668;3411.982940085299;3423.9657603423957;5546.528545073674;5560.555155587548;5591.30108736408;5602.383737788845;5605.663660180387;5537.750801213945;5574.275344205258;5576.442355764421;5589.692566908819;5594.188842617818;5040.3951525816865;5079.974600127012;5122.078025955345;5131.743412829363;5157.123289040872;5061;5120.92318615221;5211.1922651989;5218.817341393052;5251.186066159751;5086.262491938666;5123.5388815006645;5137.897242055156;5171.637985341028;5232.502912223333;5182.507661772144;5184.481551844823;5194.35070616173;5196.168613021899;5203.1414816555225;5026.371703537058;5073.619478539087;5149.716765577892;5151.304573882516;5179.352580927384;5356.839294821123;5429.239906413105;5502.367227768817;5511.862203444946;5519.972400138014;5991.281046274431;5994.130851026577;6037.577369584131;6038.788642397495;6043.305019922721;5866.943950088982;6020.939790602081;6030;6039.9396006039815;6045.848853778647;5566.916496252559;5609.0184217761725;5609.747561359708;5610.579206559524;5645.971770141123;6125.540584456184;6132.908006379907;6157.507399408037;6172.259328880563;6178.135061091451;5796.159556864315;5887.35239123696;5921.7631294747725;5924;5933.821985340447;5998.34018258;6080.695965201722;6084.269887613515;6094.085887116968;6129.662868542273;5991.940080599138;6011.5190784737115;6017.729202185825;6022.819315420545;6033.185519954838;5883.794067207713;5995;6055.091736239599;6061.636301821904;6073.939260607426;4549.749763763025;4554.977225113919;4557.043020965568;4567.474740404896;4568.748718820497;4072.3687828386646;4074.6536544394057;4074.959250407517;4089.652379547772;4123.773192474443;5682.886342273131;5815.73829177688;5820.912686309709;5825.650460972355;5869.06095024794;5905.527557795366;5982.611130276518;6069.787557435468;6071.058985857199;6104.38956104386;5757.251557297524;5763.0202865512965;5772.9711351442975;5777.335606405233;5781.103928891029;4986.102501549683;5123.462036486189;5136.383633963948;5159.25190847325;5166.483351664879;6214.906776398358;6217.818614463237;6219.284782250009;6222.751089956351;6225.035119556385;5988.251468566429;6031.306399764083;6037.969810150921;6040.577159598962;6042.909356359746;6014.699265036643;6121.234845644294;6165.321814600301;6176.629402235881;6195.349488303663;5816.854578635568;5876.970615146897;5885.176075349369;5885.676287804212;5918.911216331672;5977.9402205977385;6006.279246490449;6006.579539432198;6011.549133814894;6015.187949626745;5785.190073389645;5860.208871802252;5939.346671866005;5941.524678025834;5978;5844.386339434298;5857.414258574108;5881.94118058831;5888.087346461305;5897.056470964625;5605.943940560543;5830.562707797017;5836.358000619844;5837.09525023622;5838.357780644211;5934.258217722785;5981.641101533922;5994.55040871945;5999.130126131774;6008.969955150196;5790.507806836297;5835.7373918174635;5853.03424934881;5855.707214639166;5855.765769369177 03:34:34 INFO - PROCESS | 27215 | |1;ext.html;655.6525041727884;665.5939876675229;683.3951952522019;721.6355740351122;757.9464544283444;39472.210555788864;40870.59129408705;40884.79557602208;41015.58984410155;41165.17669646605;40039.19921601573;40990.79504602473;41073.38389924153;41125.58874411255;41130.58869411305;8563.100874408176;8781.077986811388;8789.736307910773;8827.426217295888;8840.115988401172;8560.48637081777;8734.475931444134;8740.125987401272;8775.824483510358;8781.64873405063;8724.912750872505;8828.24959878408;8832.64669413226;8851.60167792451;8868.068852770462;8632.050474447806;8706.1729135732;8724.607392667345;8769.605367758466;8778.2099611035;8695.08701586337;8802.691905783331;8811.603477843513;8817.118288171196;8819.853419055546;31641.841790791128;40074.59925400738;40295.7985210075;40300.19399612021;40744.18511629751;3321.485169798685;3790.9620903790883;3846.865359712425;3884.5726970033274;4494.73031618104;31214.68785312163;31275.84362078198;31642.367152657047;31777.8411107943;32244.35511289761;4166.437530933315;4176.4570605821355;4284.271673815459;4304.935425968613;4342.891427714301;278894;280821;282819;283348;284716;64775.67612161909;64852.02721959174;64968;64976.675116624116;65061.349386506474;63045.369546304864;64189;64212.67893660595;64489;68753.65623171852;17397.65204695899;17428.912855435643;17486.825131748774;17494.562635934202;17505.649887002444;13731.519396821062;13842.238676872868;13852;13855.930720346334;13934.16395016282;21027;21354.252601159194;21379.78620213778;21421.78578214198;21521.246756363766;7420.5176663516695;7532.209118042527;7601.543907365576;7811.1489306402755;7931.167227441036;1117.776444711061;1185.04603793945;1188.6255829413708;1209.056935590241;1236.4806781151938;31581.526277105862;31669.52495712566;31864.68135318617;31901.840490797396;32542.511862322084;1215.7568486302775;1217.6424180175381;1221.9511219551296;1258.804885242789;1307.82344383507;17692.469225923243;17747.556311092325;17825.286988520314;17859.374921877672;18099.366522171662;327662;331483;331642;437084;528487;57501;58195.418045819;58612.7069364659;58735;58866;1548.5741421109285;1552.061003093135;1557.6183834960282;1574.590741286565;1575.039226072095;33930.982070537924;35310.646893530735;35554.28891422209;35684.821575891954;35901.281974359845;55801;56036.43963560312;56655;56947.14579281397;57031.99999999834;472436;472661;475931;476044;477069;31622.367552649277;32024.839875800473;32239.838800805846;32381;32874.342513150084;51108.233376500124;51367;52041.21938171006;53052.73473632607;53488.46511534835;42900.141997159255;43364.566354337316;43905.12189756251;44627.77686111549;44867.77566112279;44058;44471;44595.55404445914;44746;45055.54944450514;44850.551494484636;45238;45738;45754.31368529541;45791.77104114458;37314.25371492609;38129.618703813714;38151;38180.23639527249;39200.41199381954;29794.255143621584;30081.699183008765;30200.84899575488;30483.237919051313;30677.386452271276 03:34:34 INFO - PROCESS | 27215 | |2;jquery.html;399.16375193968634;402.95768944260846;418.08856692410535;419.1156659448563;423.2318342208891;14608.853911460908;18192.727109093357;19151.808481915195;19180.712289315656;19409.93245371504;18253;18523;19029.333973310935;20387.490312742153;20391.28630497933;4268.231718290706;4297.613214810666;4321.870343889673;5798.62308949919;5894.764209431618;5843.094320380348;5852.092925596539;5861.618994765348;5863.5927377429325;5909.320428150753;5626.831195064155;5827.854303642422;5835.708214589275;5843.211166492511;5850.912236316459;5798.739056742456;5799.681017544054;5807.88384232313;5816.360200377955;5822.7481091565305;5229.660072095302;5467.234587157801;5469.890602187974;5471.2887324647545;5484.232207490954;12477.50089996399;12779;13621.114627549177;13681.521146759816;13682;2326.941826454335;2344.308429013445;2405.3024622859525;2561.692010008009;2588.417606038645;9573.473458959754;9757.365771224848;9995.300328976975;10060;10458.163346932228;1947.6299503094367;2057.40335302762;2076.501639606499;2089.7805730398395;2104.3476522278143;84244;85384.57307713483;87575;87872;89189.55405222997;10766;10989.395583242838;11289.661310160709;11676.06591472697;11870.584529541424;15218.467353642569;15382.3077961492;15390.384384624489;15427.46003889881;15443.84556154424;7971.481853679492;8143.226393492727;8302.584870756438;8340;8357.707480238285;8020.919790802134;8090.757277281691;8113.188681131957;8114.107448180695;8190.549519776469;4566.20091483989;4586.656000799887;4602.171609110393;4689.835855745033;4736.384270044872;1995.740553728006;2017.5662232619763;2054.945054945055;2070.254708305009;2075.2217918280644;1058.767071244325;1077.8437126616598;1112.6105862947904;1138.4706111658118;1182.4147047211513;19171.520711982314;19237.519062023563;19541.316053938044;19672.114754836068;19882.005899704956;1068.4657671164418;1095.9835602465969;1111.5331560744346;1128.8701799293021;1162.7209469727204;10997.450127493594;11132.554697812158;11168.106551475863;11210.383428911487;11426.828597571042;537620;544387;556657;565384;567395;74626;82329;85585;93302;95502.52248738712;1047.8952104789612;1074.537948682074;1088.9782204355868;1088.9945550272198;1103.8013157631704;17163.31346746116;17586.38447654326;17717.025563594125;18093.547661308574;18112.637747244717;38791;39401.60598393979;39996.40005399863;40313.1937361257;40567;55461.1680824796;56958;58152;58356;58426;8678.652853885775;8687.956560217412;8688.652453901774;8793.340499462438;8877.467351958903;12982.935085324512;13006.869931300944;13727.313634318443;13738.519151829638;13825.377857996615;12020.75958480808;12179;12188.451519681814;12395.318257495925;12612.432440540015;5912.615679980788;11228.719282018015;11873.406329683654;12128.211666241667;12140.878591213976;6656.83357916056;11057.11543076568;11739.589114380955;12476.313802740937;12571.245725256515;8489.363297752816;8608.201137383867;8697.6086076128;8886.289096872364;8899.777505562153;10948.726281842699;11697.23967942081;11738.647840564796;11751;11817.113716471127 03:34:34 INFO - PROCESS | 27215 | |3;mootools.html;1580.9288582013812;1591.49072296865;1772.5834428909204;1882.9079134102215;1924.6439408709382;7648.694052237904;8158.959205203973;8309.83380332393;8522.318214542836;8527.658893644248;8254.752357429286;8315.750527484186;8331.125231850645;8379.622916968736;8420.663173473069;2240.764719704432;2288.794008539231;2292.277932451281;2303.2399308228246;2305.5849947009533;2147.602693501707;2151.9455466821223;2151.9569608607817;2153.4616345913523;2220.4226901005773;2257.1874125314876;2266.3994041578994;2292.919747808827;2297;2326.9534609307802;2239.4177513846435;2248.977510224893;2250.6736523204127;2252.7296724393013;2267.308470916378;2267.977320226793;2288.6681431192383;2292.32376448948;2301.1485750272504;2308.4805918668167;8503.702370417006;8574.69988550404;8594.140585941419;8594.914050859536;8617.267532259766;5067.239914012891;5262.500062494057;5283.313169288006;5293.311869456985;5300.363956325227;3037.1344166912545;3063.494523403658;3211.7912335698106;3224.0972527692284;3224.500202468621;985.6747273399761;1041.6146025970363;1058.8358804385332;1075.5536452372255;2175.1082056356977;10758.031777140095;10945.781084378268;11098.44507774616;11161.944190279079;11198.888011119867;4529.8641040768825;4592.816287348535;4619.514950930171;4626.352310676508;4638.698484598491;9789.070038346488;9814.165795907427;9828.803423931624;9833.606655733834;9858.162056225157;5294.655847369909;5294.788208471618;5311.442298558596;5339.492748188916;5358.5981051421295;4266.509351424564;4673.439187297478;4770.117528257283;4855.465898751135;4962.950370496321;3961.2473630010204;3962.385830196324;4052.696047796427;4086.6730661547003;4092.8567500137947;1266.4047897488165;1298.9090763646454;1308.2673702726504;1323.4176962136628;1329.0430889759357;1005.0954141272913;1014.8071866345371;1019.7399663086014;1032.26193271811;1034.9741256468499;5583.218349431083;5640.858978525488;5717.542596592262;5748.540116790647;5779.24869766936;435.48395151745285;436.0428858655285;441.05613986069835;443.08502941425854;447.3044415933255;3940.6059394060367;4013.3979903014783;4014.3777714454304;4027.7583344999393;4072.226277007359;10139.949300253451;10368.481575921325;10372.948135259427;10382.844257336146;10502.369857808557;10062.295639305179;10224.28430009907;10308.32995855267;10357;10394.792104157874;8035.638396272065;8086.110527841933;8091.635876385577;8139.75580732579;8221.260086592116;5596.916046259228;5644.604877658525;5699.572532060195;5701.344345400332;5778.653280802997;9606.903930960601;9610.327277090537;9630.036996300594;9634.518274086407;9720.173785228335;9267.629294828132;9554.665586704432;9610.471424071744;9612.134907858326;9652.034796520291;6921.653917304014;7393;7480.326770590673;7540.773776786705;7691;8189.385796065199;8269.503829770232;8275.83448331042;8341.83316333682;8350.540720260444;7368;7432.591207483641;7440.107187137578;7502.887456688263;7746.535207887545;7298.087739032621;7386.741464048732;7422.777316680508;7475.476716629783;7536.623168841646;7184.640767961477;7244.4566657499845;7253;7257.854842903218;7264.23725508814;4991.251312303184;5066.164082926423;5141.922871156861;5162.303089082926;5165.690058596496;5027.371578552681;5102.285680004877;5143.588512919032;5183.196604526304;5235.921461178162 03:34:34 INFO - PROCESS | 27215 | |4;prototype.html;321.2066196494657;327.93605246976836;331.5077110490922;332.34693826630667;334.4014214555945;5602.635828671134;5702.372738998712;5734.713264336777;5862.2965244170655;5886.793962211324;5728.341240757314;5771.2497375341145;5820.854478638036;5823.06830907055;5823.126531020349;4406.427164468614;4437.866863994085;4463.571657069739;4466.910661786762;4490;4384.320430333288;4463.509014008457;4470.994026344079;4474.172278128541;4479.820807167709;4413.227685155101;4420.911581768362;4428.778561071949;4436.645068394537;4484.618807401359;4394.802233899466;4413.4041904342985;4423.004823914625;4459.955400445986;4462.4645042594775;3631.382664946965;3809.276237514863;3874.244522318149;3908.921821563553;3924.7056470764524;5528.640638358494;5558.44415558445;5588.245586845765;5598.300212473441;5601.159826026088;4958.20668693011;4989.750512474362;4994.325766021613;5005.9737753760755;5013.147764879943;5767.307923049261;5985.25184351956;5992.730327135289;6016.879662406771;6088.11722300264;4162.7502349858805;4199.538050814408;4210.91578168438;4216.494020717503;4223.556526564728;6327.430531252164;6329.3354197809485;6359.332270111664;6388.680565971683;6405.903911441332;4182.309918863414;4268.146370725867;4271.508776490681;4274.850380236677;4275.764832934156;4292.678049146327;4313.094250207491;4315.870523884289;4348.173846969065;4357.215701173755;5028.673136246132;5033.848984530397;5049.116404629249;5066.442691303953;5078.4413714491375;5862.736176871966;5925.644461332334;6146.95725615823;6152.661603611844;6167.660778657217;1533.0954736705398;1546.1418912503443;1553.836847131035;1558.649303906612;1563.0074902437034;998.9850152247722;1025.7128004158699;1028.0644613401769;1029.6215741636843;1041.802057609067;6295.653739044396;6317.3366796486625;6328.145700330397;6347.111404403295;6377.617342959437;6581.868362632817;6667.233268174125;6674.632895190811;6712.83217919556;6731.259561448237;6127.877442451215;6300.873982520324;6304.275008374096;6333.714982825784;6401.3278605746655;3585.46218067292;3607.603163651996;3611.2777444511203;3620.8913732588067;3626.111602657313;6260.499160067184;6566;6576.967115164489;6586.341365863471;6860.142482189726;6497.090407342976;6516.380943810331;6522.902156467657;6537.287025884205;6544.54188206821;6292.653904035322;6525.086487891699;6532.412082912466;6542.901856472062;6545.639989800607;6270.278917924497;6306.369363063657;6319.115323854572;6335.303116657256;6343.207099112611;6125.448709616156;6227.377262273736;6231.096491008688;6260.686965651608;6295.905561416674;6457.6448295342325;6521.804345869631;6534.901976470452;6538.411542961157;6579.605223686594;4251.171021650748;4273.9358909617;4309.827606895689;4323.78381080951;4328.502222244482;6181.609137943927;6216.160818289473;6271.717772700148;6336.556441049082;6380.138681277968;6227.532935029982;6229.1935338751255;6236.688165591793;6240.5319601031015;6269.749210031548;5962.970185149046;6232.501399888089;6237.282712488122;6254.468370188585;6260.342664020394;6015.12780646795;6038.637681738934;6109.908351374822;6111.908321375272;6138.969305153446;6208.410201030895;6224.719887604978;6234.189555357774;6238.469730072995;6254.405831446005;5861.912071319019;6052.394760523913;6057.454829065406;6063.302720187235;6087.634741915499 03:34:34 INFO - PROCESS | 27215 | |5;yui.html;869.1959937058219;872.2411501993263;894.6019021535417;919.2048877720772;931.250343473504;15046.322915468803;15758.763618545716;16014.59963500913;16598.58503537409;16672.416465423714;15443.305051272691;15470.071795692267;15563.221838908066;15593.454229101984;15629.609259768511;890.541371193834;893.4192774696435;903.6701603914556;905.384338649718;917.5504003038529;915.1900567997304;924.5885580916495;926.7822061815468;927.8979312275644;930.3022732950287;960.4957397366369;963.9084286992725;970.1268858027796;970.9029097090305;972.2076507646245;956.53129966316;958.9568469418892;963.5952899782109;964.3105179796444;967.4195482710388;702.8418605813703;708.3306275569589;710.0166269716428;711.7686751805684;714.4605822603953;15202.315895784715;15250.923745381313;15260.542183734506;15271.694566108616;15340.693186136215;13699.315034248348;13967.301634918213;13995.230262335568;14017.789733154012;14168.220747858864;11580.826287605692;11690.123240756977;11720.355380454072;11786.292822430596;12014.279143251346;3851.171998020411;3893.76637401754;3911.902202444933;3964;4023.0746928206677;59539.404605953816;59687;59778.99999999956;59803.70098149525;60030;10955.780884382268;10969.616063437901;11082.113430925507;11175.776484470265;11417.858214178515;18899.81100189008;19039.143238554298;19263.133159007877;19280.710789338173;19293.324733634254;8482.618282177193;8537.231649151607;8643.35174861888;8645.913540864636;8679.088695686862;4859.465458799529;4878.56092951636;4937.11131996237;5001.949980500149;5041.571466425322;3485.912852178665;3520.6303338149637;3552.147484603728;3560.430331147004;3563.590187128513;651.3226244705548;654.6170490263154;658.7990662847782;659.4790115808457;676.0670275020539;720.9819754506179;730.8940203670438;733.1495465260273;734.6547122852357;764.3273918951287;9456.054394560626;10149.746256343651;10196.796064078826;10260.640877569249;10359.32664376813;694.4826104552141;758.1773775453585;785.395245660838;787.7597332813547;811.8498077855616;4354.6951713380395;4448.932256258475;4454.487733910577;4456.688031837805;4499.550044995474;63716.362836371045;64838;65560.67219663871;65858.34141658522;67046.32953670499;55385;55975;57162;57592;57766;51224;52044.73977630088;52208;52604;53631.46368536343;8876.334274929277;9067.954660226656;9158.221551168226;9192.95403522978;9242.584083716114;34498.82750586231;34643.82678086594;35022.649773502955;36288.63711362852;36869.63130368662;46734;46763;47488.52511474841;47875.28187077127;48297.75851120722;12496.375181240719;12537.310447925453;12861.860508869704;12995.870041299466;13150.60548183556;13887;14029;14190.432382704988;14411.207383594003;14640.341184646504;13669.931650341685;13672.931635342158;13942.790858136934;14052.297385130907;14370.209638469985;13017.674558136123;13530.052896297164;13652;13720.108192967426;13845.100068495516;13540.729185416434;13589.52436664712;13664.248466334448;13818.86181138216;13933.4426622938;10978.396188209725;11211.66365009051;11492;11509.597164099216;11535.077193824642;11665.066794656237;11740.122897448764;11799.233049851731;11881.643550693492;11935.403229838299 03:34:34 INFO - PROCESS | 27215 | __end_tp_report 03:34:34 INFO - PROCESS | 27215 | __start_cc_report 03:34:34 INFO - PROCESS | 27215 | _x_x_mozilla_cycle_collect,347 03:34:34 INFO - PROCESS | 27215 | __end_cc_report 03:34:34 INFO - PROCESS | 27215 | __startTimestamp1462530874764__endTimestamp 03:34:34 INFO - PROCESS | 27215 | 03:34:34 INFO - PROCESS | 27215 | ------- Summary: start ------- 03:34:34 INFO - PROCESS | 27215 | Number of tests: 6 03:34:34 INFO - PROCESS | 27215 | 03:34:34 INFO - PROCESS | 27215 | [#0] dojo.html Cycles:165 Average:5592.29 Median:5837.10 stddev:620.66 (10.6%) stddev-sans-first:597.01 03:34:34 INFO - PROCESS | 27215 | Values: 3345.3 3389.9 3405.4 3412.0 3424.0 5546.5 5560.6 5591.3 5602.4 5605.7 5537.8 5574.3 5576.4 5589.7 5594.2 5040.4 5080.0 5122.1 5131.7 5157.1 5061.0 5120.9 5211.2 5218.8 5251.2 5086.3 5123.5 5137.9 5171.6 5232.5 5182.5 5184.5 5194.4 5196.2 5203.1 5026.4 5073.6 5149.7 5151.3 5179.4 5356.8 5429.2 5502.4 5511.9 5520.0 5991.3 5994.1 6037.6 6038.8 6043.3 5866.9 6020.9 6030.0 6039.9 6045.8 5566.9 5609.0 5609.7 5610.6 5646.0 6125.5 6132.9 6157.5 6172.3 6178.1 5796.2 5887.4 5921.8 5924.0 5933.8 5998.3 6080.7 6084.3 6094.1 6129.7 5991.9 6011.5 6017.7 6022.8 6033.2 5883.8 5995.0 6055.1 6061.6 6073.9 4549.7 4555.0 4557.0 4567.5 4568.7 4072.4 4074.7 4075.0 4089.7 4123.8 5682.9 5815.7 5820.9 5825.7 5869.1 5905.5 5982.6 6069.8 6071.1 6104.4 5757.3 5763.0 5773.0 5777.3 5781.1 4986.1 5123.5 5136.4 5159.3 5166.5 6214.9 6217.8 6219.3 6222.8 6225.0 5988.3 6031.3 6038.0 6040.6 6042.9 6014.7 6121.2 6165.3 6176.6 6195.3 5816.9 5877.0 5885.2 5885.7 5918.9 5977.9 6006.3 6006.6 6011.5 6015.2 5785.2 5860.2 5939.3 5941.5 5978.0 5844.4 5857.4 5881.9 5888.1 5897.1 5605.9 5830.6 5836.4 5837.1 5838.4 5934.3 5981.6 5994.6 5999.1 6009.0 5790.5 5835.7 5853.0 5855.7 5855.8 03:34:34 INFO - PROCESS | 27215 | 03:34:34 INFO - PROCESS | 27215 | [#1] ext.html Cycles:180 Average:56488.76 Median:41147.88 stddev:103932.30 (252.6%) stddev-sans-first:104139.32 03:34:34 INFO - PROCESS | 27215 | Values: 655.7 665.6 683.4 721.6 757.9 39472.2 40870.6 40884.8 41015.6 41165.2 40039.2 40990.8 41073.4 41125.6 41130.6 8563.1 8781.1 8789.7 8827.4 8840.1 8560.5 8734.5 8740.1 8775.8 8781.6 8724.9 8828.2 8832.6 8851.6 8868.1 8632.1 8706.2 8724.6 8769.6 8778.2 8695.1 8802.7 8811.6 8817.1 8819.9 31641.8 40074.6 40295.8 40300.2 40744.2 3321.5 3791.0 3846.9 3884.6 4494.7 31214.7 31275.8 31642.4 31777.8 32244.4 4166.4 4176.5 4284.3 4304.9 4342.9 278894.0 280821.0 282819.0 283348.0 284716.0 64775.7 64852.0 64968.0 64976.7 65061.3 63045.4 64189.0 64212.7 64489.0 68753.7 17397.7 17428.9 17486.8 17494.6 17505.6 13731.5 13842.2 13852.0 13855.9 13934.2 21027.0 21354.3 21379.8 21421.8 21521.2 7420.5 7532.2 7601.5 7811.1 7931.2 1117.8 1185.0 1188.6 1209.1 1236.5 31581.5 31669.5 31864.7 31901.8 32542.5 1215.8 1217.6 1222.0 1258.8 1307.8 17692.5 17747.6 17825.3 17859.4 18099.4 327662.0 331483.0 331642.0 437084.0 528487.0 57501.0 58195.4 58612.7 58735.0 58866.0 1548.6 1552.1 1557.6 1574.6 1575.0 33931.0 35310.6 35554.3 35684.8 35901.3 55801.0 56036.4 56655.0 56947.1 57032.0 472436.0 472661.0 475931.0 476044.0 477069.0 31622.4 32024.8 32239.8 32381.0 32874.3 51108.2 51367.0 52041.2 53052.7 53488.5 42900.1 43364.6 43905.1 44627.8 44867.8 44058.0 44471.0 44595.6 44746.0 45055.5 44850.6 45238.0 45738.0 45754.3 45791.8 37314.3 38129.6 38151.0 38180.2 39200.4 29794.3 30081.7 30200.8 30483.2 30677.4 03:34:34 INFO - PROCESS | 27215 | 03:34:34 INFO - PROCESS | 27215 | [#2] jquery.html Cycles:180 Average:30439.93 Median:2335.63 stddev:91129.76 (3901.7%) stddev-sans-first:91357.49 03:34:34 INFO - PROCESS | 27215 | Values: 399.2 403.0 418.1 419.1 423.2 14608.9 18192.7 19151.8 19180.7 19409.9 18253.0 18523.0 19029.3 20387.5 20391.3 4268.2 4297.6 4321.9 5798.6 5894.8 5843.1 5852.1 5861.6 5863.6 5909.3 5626.8 5827.9 5835.7 5843.2 5850.9 5798.7 5799.7 5807.9 5816.4 5822.7 5229.7 5467.2 5469.9 5471.3 5484.2 12477.5 12779.0 13621.1 13681.5 13682.0 2326.9 2344.3 2405.3 2561.7 2588.4 9573.5 9757.4 9995.3 10060.0 10458.2 1947.6 2057.4 2076.5 2089.8 2104.3 84244.0 85384.6 87575.0 87872.0 89189.6 10766.0 10989.4 11289.7 11676.1 11870.6 15218.5 15382.3 15390.4 15427.5 15443.8 7971.5 8143.2 8302.6 8340.0 8357.7 8020.9 8090.8 8113.2 8114.1 8190.5 4566.2 4586.7 4602.2 4689.8 4736.4 1995.7 2017.6 2054.9 2070.3 2075.2 1058.8 1077.8 1112.6 1138.5 1182.4 19171.5 19237.5 19541.3 19672.1 19882.0 1068.5 1096.0 1111.5 1128.9 1162.7 10997.5 11132.6 11168.1 11210.4 11426.8 537620.0 544387.0 556657.0 565384.0 567395.0 74626.0 82329.0 85585.0 93302.0 95502.5 1047.9 1074.5 1089.0 1089.0 1103.8 17163.3 17586.4 17717.0 18093.5 18112.6 38791.0 39401.6 39996.4 40313.2 40567.0 55461.2 56958.0 58152.0 58356.0 58426.0 8678.7 8688.0 8688.7 8793.3 8877.5 12982.9 13006.9 13727.3 13738.5 13825.4 12020.8 12179.0 12188.5 12395.3 12612.4 5912.6 11228.7 11873.4 12128.2 12140.9 6656.8 11057.1 11739.6 12476.3 12571.2 8489.4 8608.2 8697.6 8886.3 8899.8 10948.7 11697.2 11738.6 11751.0 11817.1 03:34:34 INFO - PROCESS | 27215 | 03:34:34 INFO - PROCESS | 27215 | [#3] mootools.html Cycles:180 Average:5598.18 Median:5046.77 stddev:3094.91 (61.3%) stddev-sans-first:3088.87 03:34:34 INFO - PROCESS | 27215 | Values: 1580.9 1591.5 1772.6 1882.9 1924.6 7648.7 8159.0 8309.8 8522.3 8527.7 8254.8 8315.8 8331.1 8379.6 8420.7 2240.8 2288.8 2292.3 2303.2 2305.6 2147.6 2151.9 2152.0 2153.5 2220.4 2257.2 2266.4 2292.9 2297.0 2327.0 2239.4 2249.0 2250.7 2252.7 2267.3 2268.0 2288.7 2292.3 2301.1 2308.5 8503.7 8574.7 8594.1 8594.9 8617.3 5067.2 5262.5 5283.3 5293.3 5300.4 3037.1 3063.5 3211.8 3224.1 3224.5 985.7 1041.6 1058.8 1075.6 2175.1 10758.0 10945.8 11098.4 11161.9 11198.9 4529.9 4592.8 4619.5 4626.4 4638.7 9789.1 9814.2 9828.8 9833.6 9858.2 5294.7 5294.8 5311.4 5339.5 5358.6 4266.5 4673.4 4770.1 4855.5 4963.0 3961.2 3962.4 4052.7 4086.7 4092.9 1266.4 1298.9 1308.3 1323.4 1329.0 1005.1 1014.8 1019.7 1032.3 1035.0 5583.2 5640.9 5717.5 5748.5 5779.2 435.5 436.0 441.1 443.1 447.3 3940.6 4013.4 4014.4 4027.8 4072.2 10139.9 10368.5 10372.9 10382.8 10502.4 10062.3 10224.3 10308.3 10357.0 10394.8 8035.6 8086.1 8091.6 8139.8 8221.3 5596.9 5644.6 5699.6 5701.3 5778.7 9606.9 9610.3 9630.0 9634.5 9720.2 9267.6 9554.7 9610.5 9612.1 9652.0 6921.7 7393.0 7480.3 7540.8 7691.0 8189.4 8269.5 8275.8 8341.8 8350.5 7368.0 7432.6 7440.1 7502.9 7746.5 7298.1 7386.7 7422.8 7475.5 7536.6 7184.6 7244.5 7253.0 7257.9 7264.2 4991.3 5066.2 5141.9 5162.3 5165.7 5027.4 5102.3 5143.6 5183.2 5235.9 03:34:34 INFO - PROCESS | 27215 | 03:34:34 INFO - PROCESS | 27215 | [#4] prototype.html Cycles:180 Average:5159.76 Median:5874.77 stddev:1567.90 (26.7%) stddev-sans-first:1529.66 03:34:34 INFO - PROCESS | 27215 | Values: 321.2 327.9 331.5 332.3 334.4 5602.6 5702.4 5734.7 5862.3 5886.8 5728.3 5771.2 5820.9 5823.1 5823.1 4406.4 4437.9 4463.6 4466.9 4490.0 4384.3 4463.5 4471.0 4474.2 4479.8 4413.2 4420.9 4428.8 4436.6 4484.6 4394.8 4413.4 4423.0 4460.0 4462.5 3631.4 3809.3 3874.2 3908.9 3924.7 5528.6 5558.4 5588.2 5598.3 5601.2 4958.2 4989.8 4994.3 5006.0 5013.1 5767.3 5985.3 5992.7 6016.9 6088.1 4162.8 4199.5 4210.9 4216.5 4223.6 6327.4 6329.3 6359.3 6388.7 6405.9 4182.3 4268.1 4271.5 4274.9 4275.8 4292.7 4313.1 4315.9 4348.2 4357.2 5028.7 5033.8 5049.1 5066.4 5078.4 5862.7 5925.6 6147.0 6152.7 6167.7 1533.1 1546.1 1553.8 1558.6 1563.0 999.0 1025.7 1028.1 1029.6 1041.8 6295.7 6317.3 6328.1 6347.1 6377.6 6581.9 6667.2 6674.6 6712.8 6731.3 6127.9 6300.9 6304.3 6333.7 6401.3 3585.5 3607.6 3611.3 3620.9 3626.1 6260.5 6566.0 6577.0 6586.3 6860.1 6497.1 6516.4 6522.9 6537.3 6544.5 6292.7 6525.1 6532.4 6542.9 6545.6 6270.3 6306.4 6319.1 6335.3 6343.2 6125.4 6227.4 6231.1 6260.7 6295.9 6457.6 6521.8 6534.9 6538.4 6579.6 4251.2 4273.9 4309.8 4323.8 4328.5 6181.6 6216.2 6271.7 6336.6 6380.1 6227.5 6229.2 6236.7 6240.5 6269.7 5963.0 6232.5 6237.3 6254.5 6260.3 6015.1 6038.6 6109.9 6111.9 6139.0 6208.4 6224.7 6234.2 6238.5 6254.4 5861.9 6052.4 6057.5 6063.3 6087.6 03:34:34 INFO - PROCESS | 27215 | 03:34:34 INFO - PROCESS | 27215 | [#5] yui.html Cycles:180 Average:15654.90 Median:4451.71 stddev:17997.28 (404.3%) stddev-sans-first:18013.51 03:34:34 INFO - PROCESS | 27215 | Values: 869.2 872.2 894.6 919.2 931.3 15046.3 15758.8 16014.6 16598.6 16672.4 15443.3 15470.1 15563.2 15593.5 15629.6 890.5 893.4 903.7 905.4 917.6 915.2 924.6 926.8 927.9 930.3 960.5 963.9 970.1 970.9 972.2 956.5 959.0 963.6 964.3 967.4 702.8 708.3 710.0 711.8 714.5 15202.3 15250.9 15260.5 15271.7 15340.7 13699.3 13967.3 13995.2 14017.8 14168.2 11580.8 11690.1 11720.4 11786.3 12014.3 3851.2 3893.8 3911.9 3964.0 4023.1 59539.4 59687.0 59779.0 59803.7 60030.0 10955.8 10969.6 11082.1 11175.8 11417.9 18899.8 19039.1 19263.1 19280.7 19293.3 8482.6 8537.2 8643.4 8645.9 8679.1 4859.5 4878.6 4937.1 5001.9 5041.6 3485.9 3520.6 3552.1 3560.4 3563.6 651.3 654.6 658.8 659.5 676.1 721.0 730.9 733.1 734.7 764.3 9456.1 10149.7 10196.8 10260.6 10359.3 694.5 758.2 785.4 787.8 811.8 4354.7 4448.9 4454.5 4456.7 4499.6 63716.4 64838.0 65560.7 65858.3 67046.3 55385.0 55975.0 57162.0 57592.0 57766.0 51224.0 52044.7 52208.0 52604.0 53631.5 8876.3 9068.0 9158.2 9193.0 9242.6 34498.8 34643.8 35022.6 36288.6 36869.6 46734.0 46763.0 47488.5 47875.3 48297.8 12496.4 12537.3 12861.9 12995.9 13150.6 13887.0 14029.0 14190.4 14411.2 14640.3 13669.9 13672.9 13942.8 14052.3 14370.2 13017.7 13530.1 13652.0 13720.1 13845.1 13540.7 13589.5 13664.2 13818.9 13933.4 10978.4 11211.7 11492.0 11509.6 11535.1 11665.1 11740.1 11799.2 11881.6 11935.4 03:34:34 INFO - PROCESS | 27215 | -------- Summary: end -------- 03:34:34 INFO - PROCESS | 27215 | 03:34:35 INFO - TEST-INFO | 27215: exit 0 03:34:35 INFO - TEST-OK | dromaeo_css | took 1109133ms 03:34:35 INFO - TEST-START | kraken 03:34:35 INFO - operating with platform_type : linux_ 03:34:35 INFO - Initialising browser for kraken test... 03:34:35 INFO - TEST-INFO | started process 27463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdhokj5/profile http://localhost:55361/getInfo.html) 03:34:39 INFO - PROCESS | 27463 | 03:34:39 INFO - PROCESS | 27463 | (process:27538): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:34:39 INFO - PROCESS | 27463 | __metrics Screen width/height:1600/1200 03:34:39 INFO - PROCESS | 27463 | colorDepth:24 03:34:39 INFO - PROCESS | 27463 | Browser inner width/height: 1024/697 03:34:39 INFO - PROCESS | 27463 | __metrics 03:34:40 ERROR - PROCESS | 27463 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:34:41 INFO - TEST-INFO | 27463: exit 0 03:34:41 INFO - Browser initialized. 03:34:41 INFO - Running cycle 1/1 for kraken test... 03:34:41 INFO - TEST-INFO | started process 27589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdhokj5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:43 INFO - PROCESS | 27589 | 03:34:43 INFO - PROCESS | 27589 | (process:27657): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:34:53 INFO - PROCESS | 27589 | RSS: Main: 152498176 03:34:53 INFO - PROCESS | 27589 | 03:34:55 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55361/tests/kraken/driver.html?testName=audio-beat-detection) 03:34:56 INFO - PROCESS | 27589 | RSS: Main: 156897280 03:34:56 INFO - PROCESS | 27589 | 03:34:59 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55361/tests/kraken/driver.html?testName=audio-dft) 03:34:59 INFO - PROCESS | 27589 | RSS: Main: 157569024 03:34:59 INFO - PROCESS | 27589 | 03:35:02 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55361/tests/kraken/driver.html?testName=audio-fft) 03:35:03 INFO - PROCESS | 27589 | RSS: Main: 157659136 03:35:03 INFO - PROCESS | 27589 | 03:35:05 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55361/tests/kraken/driver.html?testName=audio-oscillator) 03:35:05 INFO - PROCESS | 27589 | RSS: Main: 157528064 03:35:05 INFO - PROCESS | 27589 | 03:35:08 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:08 INFO - PROCESS | 27589 | RSS: Main: 157753344 03:35:08 INFO - PROCESS | 27589 | 03:35:11 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55361/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:12 INFO - PROCESS | 27589 | RSS: Main: 157937664 03:35:12 INFO - PROCESS | 27589 | 03:35:15 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55361/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:16 INFO - PROCESS | 27589 | RSS: Main: 158027776 03:35:16 INFO - PROCESS | 27589 | 03:35:19 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55361/tests/kraken/driver.html?testName=json-parse-financial) 03:35:19 INFO - PROCESS | 27589 | RSS: Main: 158044160 03:35:19 INFO - PROCESS | 27589 | 03:35:21 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:22 INFO - PROCESS | 27589 | RSS: Main: 158064640 03:35:22 INFO - PROCESS | 27589 | 03:35:23 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:24 INFO - PROCESS | 27589 | RSS: Main: 158044160 03:35:24 INFO - PROCESS | 27589 | 03:35:26 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:27 INFO - PROCESS | 27589 | RSS: Main: 158429184 03:35:27 INFO - PROCESS | 27589 | 03:35:29 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:35:30 INFO - PROCESS | 27589 | RSS: Main: 158466048 03:35:30 INFO - PROCESS | 27589 | 03:35:33 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:35:33 INFO - PROCESS | 27589 | RSS: Main: 158601216 03:35:33 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55361/tests/kraken/driver.html?testName=ai-astar) 03:35:35 INFO - PROCESS | 27589 | RSS: Main: 159834112 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | __start_tp_report 03:35:35 INFO - PROCESS | 27589 | _x_x_mozilla_page_load 03:35:35 INFO - PROCESS | 27589 | _x_x_mozilla_page_load_details 03:35:35 INFO - PROCESS | 27589 | |i|pagename|runs| 03:35:35 INFO - PROCESS | 27589 | |0;ai-astar;111;105;113;109;111;122;111;111;110;111 03:35:35 INFO - PROCESS | 27589 | |1;audio-beat-detection;150;126;149;176;128;154;156;133;187;128 03:35:35 INFO - PROCESS | 27589 | |2;audio-dft;163;163;161;164;164;163;161;164;165;162 03:35:35 INFO - PROCESS | 27589 | |3;audio-fft;74;77;77;173;76;77;77;77;176;76 03:35:35 INFO - PROCESS | 27589 | |4;audio-oscillator;92;92;155;92;91;92;145;92;93;149 03:35:35 INFO - PROCESS | 27589 | |5;imaging-gaussian-blur;117;118;117;117;118;117;117;117;117;117 03:35:35 INFO - PROCESS | 27589 | |6;imaging-darkroom;146;147;147;148;145;147;146;148;146;146 03:35:35 INFO - PROCESS | 27589 | |7;imaging-desaturate;95;95;96;96;94;95;95;94;95;96 03:35:35 INFO - PROCESS | 27589 | |8;json-parse-financial;59;59;59;63;63;59;59;87;59;57 03:35:35 INFO - PROCESS | 27589 | |9;json-stringify-tinderbox;59;59;59;59;59;59;60;58;59;58 03:35:35 INFO - PROCESS | 27589 | |10;stanford-crypto-aes;73;74;74;74;74;74;74;82;75;75 03:35:35 INFO - PROCESS | 27589 | |11;stanford-crypto-ccm;121;119;129;118;127;130;124;122;155;119 03:35:35 INFO - PROCESS | 27589 | |12;stanford-crypto-pbkdf2;163;163;175;162;163;160;158;168;159;157 03:35:35 INFO - PROCESS | 27589 | |13;stanford-crypto-sha256-iterative;68;68;70;69;69;66;65;68;65;66 03:35:35 INFO - PROCESS | 27589 | __end_tp_report 03:35:35 INFO - PROCESS | 27589 | __start_cc_report 03:35:35 INFO - PROCESS | 27589 | _x_x_mozilla_cycle_collect,839 03:35:35 INFO - PROCESS | 27589 | __end_cc_report 03:35:35 INFO - PROCESS | 27589 | __startTimestamp1462530935584__endTimestamp 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | ------- Summary: start ------- 03:35:35 INFO - PROCESS | 27589 | Number of tests: 14 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.27 (3.9%) stddev-sans-first:4.53 03:35:35 INFO - PROCESS | 27589 | Values: 111.0 105.0 113.0 109.0 111.0 122.0 111.0 111.0 110.0 111.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:152.00 stddev:20.85 (13.7%) stddev-sans-first:22.11 03:35:35 INFO - PROCESS | 27589 | Values: 150.0 126.0 149.0 176.0 128.0 154.0 156.0 133.0 187.0 128.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:1.33 (0.8%) stddev-sans-first:1.41 03:35:35 INFO - PROCESS | 27589 | Values: 163.0 163.0 161.0 164.0 164.0 163.0 161.0 164.0 165.0 162.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#3] audio-fft Cycles:10 Average:96.00 Median:77.00 stddev:41.39 (53.8%) stddev-sans-first:43.13 03:35:35 INFO - PROCESS | 27589 | Values: 74.0 77.0 77.0 173.0 76.0 77.0 77.0 77.0 176.0 76.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:92.00 stddev:27.96 (30.4%) stddev-sans-first:28.95 03:35:35 INFO - PROCESS | 27589 | Values: 92.0 92.0 155.0 92.0 91.0 92.0 145.0 92.0 93.0 149.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:35:35 INFO - PROCESS | 27589 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 03:35:35 INFO - PROCESS | 27589 | Values: 146.0 147.0 147.0 148.0 145.0 147.0 146.0 148.0 146.0 146.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 03:35:35 INFO - PROCESS | 27589 | Values: 95.0 95.0 96.0 96.0 94.0 95.0 95.0 94.0 95.0 96.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:59.00 stddev:8.85 (15.0%) stddev-sans-first:9.30 03:35:35 INFO - PROCESS | 27589 | Values: 59.0 59.0 59.0 63.0 63.0 59.0 59.0 87.0 59.0 57.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 03:35:35 INFO - PROCESS | 27589 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 60.0 58.0 59.0 58.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:2.56 (3.5%) stddev-sans-first:2.62 03:35:35 INFO - PROCESS | 27589 | Values: 73.0 74.0 74.0 74.0 74.0 74.0 74.0 82.0 75.0 75.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:125.50 stddev:10.92 (8.7%) stddev-sans-first:11.40 03:35:35 INFO - PROCESS | 27589 | Values: 121.0 119.0 129.0 118.0 127.0 130.0 124.0 122.0 155.0 119.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.00 stddev:5.33 (3.3%) stddev-sans-first:5.65 03:35:35 INFO - PROCESS | 27589 | Values: 163.0 163.0 175.0 162.0 163.0 160.0 158.0 168.0 159.0 157.0 03:35:35 INFO - PROCESS | 27589 | 03:35:35 INFO - PROCESS | 27589 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.78 (2.6%) stddev-sans-first:1.87 03:35:35 INFO - PROCESS | 27589 | Values: 68.0 68.0 70.0 69.0 69.0 66.0 65.0 68.0 65.0 66.0 03:35:35 INFO - PROCESS | 27589 | -------- Summary: end -------- 03:35:35 INFO - PROCESS | 27589 | 03:35:36 INFO - TEST-INFO | 27589: exit 0 03:35:36 INFO - TEST-OK | kraken | took 61085ms 03:35:36 INFO - SUITE-END | took 1170s 03:35:36 INFO - Completed test suite (00:19:30) 03:35:36 INFO - javascript benchmark 03:35:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.297487527619, 3389.8983030509094, 3405.421078416668, 3411.982940085299, 3423.9657603423957, 5546.528545073674, 5560.555155587548, 5591.30108736408, 5602.383737788845, 5605.663660180387, 5537.750801213945, 5574.275344205258, 5576.442355764421, 5589.692566908819, 5594.188842617818, 5040.3951525816865, 5079.974600127012, 5122.078025955345, 5131.743412829363, 5157.123289040872, 5061.0, 5120.92318615221, 5211.1922651989, 5218.817341393052, 5251.186066159751, 5086.262491938666, 5123.5388815006645, 5137.897242055156, 5171.637985341028, 5232.502912223333, 5182.507661772144, 5184.481551844823, 5194.35070616173, 5196.168613021899, 5203.1414816555225, 5026.371703537058, 5073.619478539087, 5149.716765577892, 5151.304573882516, 5179.352580927384, 5356.839294821123, 5429.239906413105, 5502.367227768817, 5511.862203444946, 5519.972400138014, 5991.281046274431, 5994.130851026577, 6037.577369584131, 6038.788642397495, 6043.305019922721, 5866.943950088982, 6020.939790602081, 6030.0, 6039.9396006039815, 6045.848853778647, 5566.916496252559, 5609.0184217761725, 5609.747561359708, 5610.579206559524, 5645.971770141123, 6125.540584456184, 6132.908006379907, 6157.507399408037, 6172.259328880563, 6178.135061091451, 5796.159556864315, 5887.35239123696, 5921.7631294747725, 5924.0, 5933.821985340447, 5998.34018258, 6080.695965201722, 6084.269887613515, 6094.085887116968, 6129.662868542273, 5991.940080599138, 6011.5190784737115, 6017.729202185825, 6022.819315420545, 6033.185519954838, 5883.794067207713, 5995.0, 6055.091736239599, 6061.636301821904, 6073.939260607426, 4549.749763763025, 4554.977225113919, 4557.043020965568, 4567.474740404896, 4568.748718820497, 4072.3687828386646, 4074.6536544394057, 4074.959250407517, 4089.652379547772, 4123.773192474443, 5682.886342273131, 5815.73829177688, 5820.912686309709, 5825.650460972355, 5869.06095024794, 5905.527557795366, 5982.611130276518, 6069.787557435468, 6071.058985857199, 6104.38956104386, 5757.251557297524, 5763.0202865512965, 5772.9711351442975, 5777.335606405233, 5781.103928891029, 4986.102501549683, 5123.462036486189, 5136.383633963948, 5159.25190847325, 5166.483351664879, 6214.906776398358, 6217.818614463237, 6219.284782250009, 6222.751089956351, 6225.035119556385, 5988.251468566429, 6031.306399764083, 6037.969810150921, 6040.577159598962, 6042.909356359746, 6014.699265036643, 6121.234845644294, 6165.321814600301, 6176.629402235881, 6195.349488303663, 5816.854578635568, 5876.970615146897, 5885.176075349369, 5885.676287804212, 5918.911216331672, 5977.9402205977385, 6006.279246490449, 6006.579539432198, 6011.549133814894, 6015.187949626745, 5785.190073389645, 5860.208871802252, 5939.346671866005, 5941.524678025834, 5978.0, 5844.386339434298, 5857.414258574108, 5881.94118058831, 5888.087346461305, 5897.056470964625, 5605.943940560543, 5830.562707797017, 5836.358000619844, 5837.09525023622, 5838.357780644211, 5934.258217722785, 5981.641101533922, 5994.55040871945, 5999.130126131774, 6008.969955150196, 5790.507806836297, 5835.7373918174635, 5853.03424934881, 5855.707214639166, 5855.765769369177], "value": 5551.928956116751, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.6525041727884, 665.5939876675229, 683.3951952522019, 721.6355740351122, 757.9464544283444, 39472.210555788864, 40870.59129408705, 40884.79557602208, 41015.58984410155, 41165.17669646605, 40039.19921601573, 40990.79504602473, 41073.38389924153, 41125.58874411255, 41130.58869411305, 8563.100874408176, 8781.077986811388, 8789.736307910773, 8827.426217295888, 8840.115988401172, 8560.48637081777, 8734.475931444134, 8740.125987401272, 8775.824483510358, 8781.64873405063, 8724.912750872505, 8828.24959878408, 8832.64669413226, 8851.60167792451, 8868.068852770462, 8632.050474447806, 8706.1729135732, 8724.607392667345, 8769.605367758466, 8778.2099611035, 8695.08701586337, 8802.691905783331, 8811.603477843513, 8817.118288171196, 8819.853419055546, 31641.841790791128, 40074.59925400738, 40295.7985210075, 40300.19399612021, 40744.18511629751, 3321.485169798685, 3790.9620903790883, 3846.865359712425, 3884.5726970033274, 4494.73031618104, 31214.68785312163, 31275.84362078198, 31642.367152657047, 31777.8411107943, 32244.35511289761, 4166.437530933315, 4176.4570605821355, 4284.271673815459, 4304.935425968613, 4342.891427714301, 278894.0, 280821.0, 282819.0, 283348.0, 284716.0, 64775.67612161909, 64852.02721959174, 64968.0, 64976.675116624116, 65061.349386506474, 63045.369546304864, 64189.0, 64212.67893660595, 64489.0, 68753.65623171852, 17397.65204695899, 17428.912855435643, 17486.825131748774, 17494.562635934202, 17505.649887002444, 13731.519396821062, 13842.238676872868, 13852.0, 13855.930720346334, 13934.16395016282, 21027.0, 21354.252601159194, 21379.78620213778, 21421.78578214198, 21521.246756363766, 7420.5176663516695, 7532.209118042527, 7601.543907365576, 7811.1489306402755, 7931.167227441036, 1117.776444711061, 1185.04603793945, 1188.6255829413708, 1209.056935590241, 1236.4806781151938, 31581.526277105862, 31669.52495712566, 31864.68135318617, 31901.840490797396, 32542.511862322084, 1215.7568486302775, 1217.6424180175381, 1221.9511219551296, 1258.804885242789, 1307.82344383507, 17692.469225923243, 17747.556311092325, 17825.286988520314, 17859.374921877672, 18099.366522171662, 327662.0, 331483.0, 331642.0, 437084.0, 528487.0, 57501.0, 58195.418045819, 58612.7069364659, 58735.0, 58866.0, 1548.5741421109285, 1552.061003093135, 1557.6183834960282, 1574.590741286565, 1575.039226072095, 33930.982070537924, 35310.646893530735, 35554.28891422209, 35684.821575891954, 35901.281974359845, 55801.0, 56036.43963560312, 56655.0, 56947.14579281397, 57031.99999999834, 472436.0, 472661.0, 475931.0, 476044.0, 477069.0, 31622.367552649277, 32024.839875800473, 32239.838800805846, 32381.0, 32874.342513150084, 51108.233376500124, 51367.0, 52041.21938171006, 53052.73473632607, 53488.46511534835, 42900.141997159255, 43364.566354337316, 43905.12189756251, 44627.77686111549, 44867.77566112279, 44058.0, 44471.0, 44595.55404445914, 44746.0, 45055.54944450514, 44850.551494484636, 45238.0, 45738.0, 45754.31368529541, 45791.77104114458, 37314.25371492609, 38129.618703813714, 38151.0, 38180.23639527249, 39200.41199381954, 29794.255143621584, 30081.699183008765, 30200.84899575488, 30483.237919051313, 30677.386452271276], "value": 20794.027870456735, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.16375193968634, 402.95768944260846, 418.08856692410535, 419.1156659448563, 423.2318342208891, 14608.853911460908, 18192.727109093357, 19151.808481915195, 19180.712289315656, 19409.93245371504, 18253.0, 18523.0, 19029.333973310935, 20387.490312742153, 20391.28630497933, 4268.231718290706, 4297.613214810666, 4321.870343889673, 5798.62308949919, 5894.764209431618, 5843.094320380348, 5852.092925596539, 5861.618994765348, 5863.5927377429325, 5909.320428150753, 5626.831195064155, 5827.854303642422, 5835.708214589275, 5843.211166492511, 5850.912236316459, 5798.739056742456, 5799.681017544054, 5807.88384232313, 5816.360200377955, 5822.7481091565305, 5229.660072095302, 5467.234587157801, 5469.890602187974, 5471.2887324647545, 5484.232207490954, 12477.50089996399, 12779.0, 13621.114627549177, 13681.521146759816, 13682.0, 2326.941826454335, 2344.308429013445, 2405.3024622859525, 2561.692010008009, 2588.417606038645, 9573.473458959754, 9757.365771224848, 9995.300328976975, 10060.0, 10458.163346932228, 1947.6299503094367, 2057.40335302762, 2076.501639606499, 2089.7805730398395, 2104.3476522278143, 84244.0, 85384.57307713483, 87575.0, 87872.0, 89189.55405222997, 10766.0, 10989.395583242838, 11289.661310160709, 11676.06591472697, 11870.584529541424, 15218.467353642569, 15382.3077961492, 15390.384384624489, 15427.46003889881, 15443.84556154424, 7971.481853679492, 8143.226393492727, 8302.584870756438, 8340.0, 8357.707480238285, 8020.919790802134, 8090.757277281691, 8113.188681131957, 8114.107448180695, 8190.549519776469, 4566.20091483989, 4586.656000799887, 4602.171609110393, 4689.835855745033, 4736.384270044872, 1995.740553728006, 2017.5662232619763, 2054.945054945055, 2070.254708305009, 2075.2217918280644, 1058.767071244325, 1077.8437126616598, 1112.6105862947904, 1138.4706111658118, 1182.4147047211513, 19171.520711982314, 19237.519062023563, 19541.316053938044, 19672.114754836068, 19882.005899704956, 1068.4657671164418, 1095.9835602465969, 1111.5331560744346, 1128.8701799293021, 1162.7209469727204, 10997.450127493594, 11132.554697812158, 11168.106551475863, 11210.383428911487, 11426.828597571042, 537620.0, 544387.0, 556657.0, 565384.0, 567395.0, 74626.0, 82329.0, 85585.0, 93302.0, 95502.52248738712, 1047.8952104789612, 1074.537948682074, 1088.9782204355868, 1088.9945550272198, 1103.8013157631704, 17163.31346746116, 17586.38447654326, 17717.025563594125, 18093.547661308574, 18112.637747244717, 38791.0, 39401.60598393979, 39996.40005399863, 40313.1937361257, 40567.0, 55461.1680824796, 56958.0, 58152.0, 58356.0, 58426.0, 8678.652853885775, 8687.956560217412, 8688.652453901774, 8793.340499462438, 8877.467351958903, 12982.935085324512, 13006.869931300944, 13727.313634318443, 13738.519151829638, 13825.377857996615, 12020.75958480808, 12179.0, 12188.451519681814, 12395.318257495925, 12612.432440540015, 5912.615679980788, 11228.719282018015, 11873.406329683654, 12128.211666241667, 12140.878591213976, 6656.83357916056, 11057.11543076568, 11739.589114380955, 12476.313802740937, 12571.245725256515, 8489.363297752816, 8608.201137383867, 8697.6086076128, 8886.289096872364, 8899.777505562153, 10948.726281842699, 11697.23967942081, 11738.647840564796, 11751.0, 11817.113716471127], "value": 9183.373329270546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1580.9288582013812, 1591.49072296865, 1772.5834428909204, 1882.9079134102215, 1924.6439408709382, 7648.694052237904, 8158.959205203973, 8309.83380332393, 8522.318214542836, 8527.658893644248, 8254.752357429286, 8315.750527484186, 8331.125231850645, 8379.622916968736, 8420.663173473069, 2240.764719704432, 2288.794008539231, 2292.277932451281, 2303.2399308228246, 2305.5849947009533, 2147.602693501707, 2151.9455466821223, 2151.9569608607817, 2153.4616345913523, 2220.4226901005773, 2257.1874125314876, 2266.3994041578994, 2292.919747808827, 2297.0, 2326.9534609307802, 2239.4177513846435, 2248.977510224893, 2250.6736523204127, 2252.7296724393013, 2267.308470916378, 2267.977320226793, 2288.6681431192383, 2292.32376448948, 2301.1485750272504, 2308.4805918668167, 8503.702370417006, 8574.69988550404, 8594.140585941419, 8594.914050859536, 8617.267532259766, 5067.239914012891, 5262.500062494057, 5283.313169288006, 5293.311869456985, 5300.363956325227, 3037.1344166912545, 3063.494523403658, 3211.7912335698106, 3224.0972527692284, 3224.500202468621, 985.6747273399761, 1041.6146025970363, 1058.8358804385332, 1075.5536452372255, 2175.1082056356977, 10758.031777140095, 10945.781084378268, 11098.44507774616, 11161.944190279079, 11198.888011119867, 4529.8641040768825, 4592.816287348535, 4619.514950930171, 4626.352310676508, 4638.698484598491, 9789.070038346488, 9814.165795907427, 9828.803423931624, 9833.606655733834, 9858.162056225157, 5294.655847369909, 5294.788208471618, 5311.442298558596, 5339.492748188916, 5358.5981051421295, 4266.509351424564, 4673.439187297478, 4770.117528257283, 4855.465898751135, 4962.950370496321, 3961.2473630010204, 3962.385830196324, 4052.696047796427, 4086.6730661547003, 4092.8567500137947, 1266.4047897488165, 1298.9090763646454, 1308.2673702726504, 1323.4176962136628, 1329.0430889759357, 1005.0954141272913, 1014.8071866345371, 1019.7399663086014, 1032.26193271811, 1034.9741256468499, 5583.218349431083, 5640.858978525488, 5717.542596592262, 5748.540116790647, 5779.24869766936, 435.48395151745285, 436.0428858655285, 441.05613986069835, 443.08502941425854, 447.3044415933255, 3940.6059394060367, 4013.3979903014783, 4014.3777714454304, 4027.7583344999393, 4072.226277007359, 10139.949300253451, 10368.481575921325, 10372.948135259427, 10382.844257336146, 10502.369857808557, 10062.295639305179, 10224.28430009907, 10308.32995855267, 10357.0, 10394.792104157874, 8035.638396272065, 8086.110527841933, 8091.635876385577, 8139.75580732579, 8221.260086592116, 5596.916046259228, 5644.604877658525, 5699.572532060195, 5701.344345400332, 5778.653280802997, 9606.903930960601, 9610.327277090537, 9630.036996300594, 9634.518274086407, 9720.173785228335, 9267.629294828132, 9554.665586704432, 9610.471424071744, 9612.134907858326, 9652.034796520291, 6921.653917304014, 7393.0, 7480.326770590673, 7540.773776786705, 7691.0, 8189.385796065199, 8269.503829770232, 8275.83448331042, 8341.83316333682, 8350.540720260444, 7368.0, 7432.591207483641, 7440.107187137578, 7502.887456688263, 7746.535207887545, 7298.087739032621, 7386.741464048732, 7422.777316680508, 7475.476716629783, 7536.623168841646, 7184.640767961477, 7244.4566657499845, 7253.0, 7257.854842903218, 7264.23725508814, 4991.251312303184, 5066.164082926423, 5141.922871156861, 5162.303089082926, 5165.690058596496, 5027.371578552681, 5102.285680004877, 5143.588512919032, 5183.196604526304, 5235.921461178162], "value": 4466.417332464999, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.2066196494657, 327.93605246976836, 331.5077110490922, 332.34693826630667, 334.4014214555945, 5602.635828671134, 5702.372738998712, 5734.713264336777, 5862.2965244170655, 5886.793962211324, 5728.341240757314, 5771.2497375341145, 5820.854478638036, 5823.06830907055, 5823.126531020349, 4406.427164468614, 4437.866863994085, 4463.571657069739, 4466.910661786762, 4490.0, 4384.320430333288, 4463.509014008457, 4470.994026344079, 4474.172278128541, 4479.820807167709, 4413.227685155101, 4420.911581768362, 4428.778561071949, 4436.645068394537, 4484.618807401359, 4394.802233899466, 4413.4041904342985, 4423.004823914625, 4459.955400445986, 4462.4645042594775, 3631.382664946965, 3809.276237514863, 3874.244522318149, 3908.921821563553, 3924.7056470764524, 5528.640638358494, 5558.44415558445, 5588.245586845765, 5598.300212473441, 5601.159826026088, 4958.20668693011, 4989.750512474362, 4994.325766021613, 5005.9737753760755, 5013.147764879943, 5767.307923049261, 5985.25184351956, 5992.730327135289, 6016.879662406771, 6088.11722300264, 4162.7502349858805, 4199.538050814408, 4210.91578168438, 4216.494020717503, 4223.556526564728, 6327.430531252164, 6329.3354197809485, 6359.332270111664, 6388.680565971683, 6405.903911441332, 4182.309918863414, 4268.146370725867, 4271.508776490681, 4274.850380236677, 4275.764832934156, 4292.678049146327, 4313.094250207491, 4315.870523884289, 4348.173846969065, 4357.215701173755, 5028.673136246132, 5033.848984530397, 5049.116404629249, 5066.442691303953, 5078.4413714491375, 5862.736176871966, 5925.644461332334, 6146.95725615823, 6152.661603611844, 6167.660778657217, 1533.0954736705398, 1546.1418912503443, 1553.836847131035, 1558.649303906612, 1563.0074902437034, 998.9850152247722, 1025.7128004158699, 1028.0644613401769, 1029.6215741636843, 1041.802057609067, 6295.653739044396, 6317.3366796486625, 6328.145700330397, 6347.111404403295, 6377.617342959437, 6581.868362632817, 6667.233268174125, 6674.632895190811, 6712.83217919556, 6731.259561448237, 6127.877442451215, 6300.873982520324, 6304.275008374096, 6333.714982825784, 6401.3278605746655, 3585.46218067292, 3607.603163651996, 3611.2777444511203, 3620.8913732588067, 3626.111602657313, 6260.499160067184, 6566.0, 6576.967115164489, 6586.341365863471, 6860.142482189726, 6497.090407342976, 6516.380943810331, 6522.902156467657, 6537.287025884205, 6544.54188206821, 6292.653904035322, 6525.086487891699, 6532.412082912466, 6542.901856472062, 6545.639989800607, 6270.278917924497, 6306.369363063657, 6319.115323854572, 6335.303116657256, 6343.207099112611, 6125.448709616156, 6227.377262273736, 6231.096491008688, 6260.686965651608, 6295.905561416674, 6457.6448295342325, 6521.804345869631, 6534.901976470452, 6538.411542961157, 6579.605223686594, 4251.171021650748, 4273.9358909617, 4309.827606895689, 4323.78381080951, 4328.502222244482, 6181.609137943927, 6216.160818289473, 6271.717772700148, 6336.556441049082, 6380.138681277968, 6227.532935029982, 6229.1935338751255, 6236.688165591793, 6240.5319601031015, 6269.749210031548, 5962.970185149046, 6232.501399888089, 6237.282712488122, 6254.468370188585, 6260.342664020394, 6015.12780646795, 6038.637681738934, 6109.908351374822, 6111.908321375272, 6138.969305153446, 6208.410201030895, 6224.719887604978, 6234.189555357774, 6238.469730072995, 6254.405831446005, 5861.912071319019, 6052.394760523913, 6057.454829065406, 6063.302720187235, 6087.634741915499], "value": 4649.916629615991, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.1959937058219, 872.2411501993263, 894.6019021535417, 919.2048877720772, 931.250343473504, 15046.322915468803, 15758.763618545716, 16014.59963500913, 16598.58503537409, 16672.416465423714, 15443.305051272691, 15470.071795692267, 15563.221838908066, 15593.454229101984, 15629.609259768511, 890.541371193834, 893.4192774696435, 903.6701603914556, 905.384338649718, 917.5504003038529, 915.1900567997304, 924.5885580916495, 926.7822061815468, 927.8979312275644, 930.3022732950287, 960.4957397366369, 963.9084286992725, 970.1268858027796, 970.9029097090305, 972.2076507646245, 956.53129966316, 958.9568469418892, 963.5952899782109, 964.3105179796444, 967.4195482710388, 702.8418605813703, 708.3306275569589, 710.0166269716428, 711.7686751805684, 714.4605822603953, 15202.315895784715, 15250.923745381313, 15260.542183734506, 15271.694566108616, 15340.693186136215, 13699.315034248348, 13967.301634918213, 13995.230262335568, 14017.789733154012, 14168.220747858864, 11580.826287605692, 11690.123240756977, 11720.355380454072, 11786.292822430596, 12014.279143251346, 3851.171998020411, 3893.76637401754, 3911.902202444933, 3964.0, 4023.0746928206677, 59539.404605953816, 59687.0, 59778.99999999956, 59803.70098149525, 60030.0, 10955.780884382268, 10969.616063437901, 11082.113430925507, 11175.776484470265, 11417.858214178515, 18899.81100189008, 19039.143238554298, 19263.133159007877, 19280.710789338173, 19293.324733634254, 8482.618282177193, 8537.231649151607, 8643.35174861888, 8645.913540864636, 8679.088695686862, 4859.465458799529, 4878.56092951636, 4937.11131996237, 5001.949980500149, 5041.571466425322, 3485.912852178665, 3520.6303338149637, 3552.147484603728, 3560.430331147004, 3563.590187128513, 651.3226244705548, 654.6170490263154, 658.7990662847782, 659.4790115808457, 676.0670275020539, 720.9819754506179, 730.8940203670438, 733.1495465260273, 734.6547122852357, 764.3273918951287, 9456.054394560626, 10149.746256343651, 10196.796064078826, 10260.640877569249, 10359.32664376813, 694.4826104552141, 758.1773775453585, 785.395245660838, 787.7597332813547, 811.8498077855616, 4354.6951713380395, 4448.932256258475, 4454.487733910577, 4456.688031837805, 4499.550044995474, 63716.362836371045, 64838.0, 65560.67219663871, 65858.34141658522, 67046.32953670499, 55385.0, 55975.0, 57162.0, 57592.0, 57766.0, 51224.0, 52044.73977630088, 52208.0, 52604.0, 53631.46368536343, 8876.334274929277, 9067.954660226656, 9158.221551168226, 9192.95403522978, 9242.584083716114, 34498.82750586231, 34643.82678086594, 35022.649773502955, 36288.63711362852, 36869.63130368662, 46734.0, 46763.0, 47488.52511474841, 47875.28187077127, 48297.75851120722, 12496.375181240719, 12537.310447925453, 12861.860508869704, 12995.870041299466, 13150.60548183556, 13887.0, 14029.0, 14190.432382704988, 14411.207383594003, 14640.341184646504, 13669.931650341685, 13672.931635342158, 13942.790858136934, 14052.297385130907, 14370.209638469985, 13017.674558136123, 13530.052896297164, 13652.0, 13720.108192967426, 13845.100068495516, 13540.729185416434, 13589.52436664712, 13664.248466334448, 13818.86181138216, 13933.4426622938, 10978.396188209725, 11211.66365009051, 11492.0, 11509.597164099216, 11535.077193824642, 11665.066794656237, 11740.122897448764, 11799.233049851731, 11881.643550693492, 11935.403229838299], "value": 7201.609529583378, "unit": "score"}], "name": "dromaeo_css", "value": 7357.1620911363025, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 113.0, 109.0, 111.0, 122.0, 111.0, 111.0, 110.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 149.0, 176.0, 128.0, 154.0, 156.0, 133.0, 187.0, 128.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 164.0, 164.0, 163.0, 161.0, 164.0, 165.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 173.0, 76.0, 77.0, 77.0, 77.0, 176.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 155.0, 92.0, 91.0, 92.0, 145.0, 92.0, 93.0, 149.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 145.0, 147.0, 146.0, 148.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 63.0, 63.0, 59.0, 59.0, 87.0, 59.0, 57.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 58.0, 59.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 74.0, 74.0, 74.0, 74.0, 82.0, 75.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 129.0, 118.0, 127.0, 130.0, 124.0, 122.0, 155.0, 119.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 175.0, 162.0, 163.0, 160.0, 158.0, 168.0, 159.0, 157.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 69.0, 69.0, 66.0, 65.0, 68.0, 65.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1540.1000000000004, "alertThreshold": 2.0}]} 03:35:36 INFO - Return code: 0 03:35:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:35:36 ERROR - # TBPL SUCCESS # 03:35:36 INFO - Running post-action listener: _resource_record_post_action 03:35:36 INFO - Running post-run listener: _resource_record_post_run 03:35:37 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 338186240; Read time: 0; Write time: 192660 03:35:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 76353536; Read time: 0; Write time: 37156 03:35:37 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 249327616; Read time: 0; Write time: 126284 03:35:37 INFO - Running post-run listener: _upload_blobber_files 03:35:37 INFO - Blob upload gear active. 03:35:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:35:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:35:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:35:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:35:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:35:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:39 INFO - (blobuploader) - INFO - Done attempting. 03:35:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:35:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:35:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:40 INFO - (blobuploader) - INFO - Done attempting. 03:35:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:35:40 INFO - Return code: 0 03:35:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:35:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:35:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6f671434feae15cf96d4c112978be53080b6c66ff998384f2dcc9367d81b57fe1884bc663d639af4058889e706d1902d5b378be3f33550f10115ecff74d91cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba7c0376a076eb94d15b37201da7093475b05999b48a046d735ca198dd53eafeddf35d62a84497ebc1bb180aab5a9ec2e92b23b166af2dddef0e8733c39fc5ba"} 03:35:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:35:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:35:40 INFO - Contents: 03:35:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6f671434feae15cf96d4c112978be53080b6c66ff998384f2dcc9367d81b57fe1884bc663d639af4058889e706d1902d5b378be3f33550f10115ecff74d91cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba7c0376a076eb94d15b37201da7093475b05999b48a046d735ca198dd53eafeddf35d62a84497ebc1bb180aab5a9ec2e92b23b166af2dddef0e8733c39fc5ba"} 03:35:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:35:40 INFO - Copying logs to upload dir... 03:35:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:35:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.507255 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-06 03:35:37.962889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:35:37.966943) ========= 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=574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468 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/d6f671434feae15cf96d4c112978be53080b6c66ff998384f2dcc9367d81b57fe1884bc663d639af4058889e706d1902d5b378be3f33550f10115ecff74d91cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba7c0376a076eb94d15b37201da7093475b05999b48a046d735ca198dd53eafeddf35d62a84497ebc1bb180aab5a9ec2e92b23b166af2dddef0e8733c39fc5ba"} build_url:https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6f671434feae15cf96d4c112978be53080b6c66ff998384f2dcc9367d81b57fe1884bc663d639af4058889e706d1902d5b378be3f33550f10115ecff74d91cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba7c0376a076eb94d15b37201da7093475b05999b48a046d735ca198dd53eafeddf35d62a84497ebc1bb180aab5a9ec2e92b23b166af2dddef0e8733c39fc5ba"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:35:37.991140) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:35:37.991435) ========= 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=574dc5aafe09851ec43d388c000001b6-1462524709.129377-371890468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:35:38.073069) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:35:38.073354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:35:38.073651) ========= ========= Total master_lag: 0.18 =========