builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1460641698.19 results: success (0) buildid: 20160414033456 builduid: e21ed88e933a46a783e3cf09d9517e74 revision: f33dbaaf6abd2af0dd3a917c880e759aca2a5c12 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:18.193236) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:18.193675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:18.194261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:18.211275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:18.212604) ========= 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=eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 06:48:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.9M=0s 2016-04-14 06:48:18 (88.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158520 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:18.384521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:18.384841) ========= 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=eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022184 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:18.434174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:18.434536) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f33dbaaf6abd2af0dd3a917c880e759aca2a5c12 --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 f33dbaaf6abd2af0dd3a917c880e759aca2a5c12 --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=eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 06:48:19,103 truncating revision to first 12 chars 2016-04-14 06:48:19,103 Setting DEBUG logging. 2016-04-14 06:48:19,103 attempt 1/10 2016-04-14 06:48:19,103 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f33dbaaf6abd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 06:48:19,341 unpacking tar archive at: mozilla-aurora-f33dbaaf6abd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:19.010997) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:19.011324) ========= script_repo_revision: f33dbaaf6abd2af0dd3a917c880e759aca2a5c12 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:19.011729) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:19.012002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 06:48:19.020023) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-14 06:48:19.020335) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:48:19 INFO - MultiFileLogger online at 20160414 06:48:19 in /builds/slave/test 06:48:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:48:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:48:19 INFO - {'append_to_log': False, 06:48:19 INFO - 'base_work_dir': '/builds/slave/test', 06:48:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:48:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:48:19 INFO - 'branch': 'Mozilla-Aurora', 06:48:19 INFO - 'buildbot_json_path': 'buildprops.json', 06:48:19 INFO - 'config_files': ('talos/linux_config.py',), 06:48:19 INFO - 'default_actions': ('clobber', 06:48:19 INFO - 'read-buildbot-config', 06:48:19 INFO - 'download-and-extract', 06:48:19 INFO - 'populate-webroot', 06:48:19 INFO - 'create-virtualenv', 06:48:19 INFO - 'install', 06:48:19 INFO - 'run-tests'), 06:48:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:48:19 INFO - 'download_minidump_stackwalk': True, 06:48:19 INFO - 'download_symbols': 'ondemand', 06:48:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:48:19 INFO - 'tooltool.py': '/tools/tooltool.py', 06:48:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:48:19 INFO - '/tools/misc-python/virtualenv.py')}, 06:48:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:48:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:48:19 INFO - 'installer_path': 'installer.exe', 06:48:19 INFO - 'log_level': 'info', 06:48:19 INFO - 'log_name': 'talos', 06:48:19 INFO - 'log_to_console': True, 06:48:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:48:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:48:19 INFO - 'opt_config_files': (), 06:48:19 INFO - 'pip_index': False, 06:48:19 INFO - 'sps_profile': False, 06:48:19 INFO - 'sps_profile_interval': 0, 06:48:19 INFO - 'suite': 'dromaeojs', 06:48:19 INFO - 'system_bits': '32', 06:48:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:48:19 INFO - 'title': 'talos-linux64-ix-010', 06:48:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:48:19 INFO - 'use_talos_json': True, 06:48:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:48:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:48:19 INFO - 'work_dir': 'build'} 06:48:19 INFO - ##### 06:48:19 INFO - ##### Running clobber step. 06:48:19 INFO - ##### 06:48:19 INFO - Running pre-action listener: _resource_record_pre_action 06:48:19 INFO - Running main action method: clobber 06:48:19 INFO - rmtree: /builds/slave/test/build 06:48:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:48:20 INFO - Running post-action listener: _resource_record_post_action 06:48:20 INFO - ##### 06:48:20 INFO - ##### Running read-buildbot-config step. 06:48:20 INFO - ##### 06:48:20 INFO - Running pre-action listener: _resource_record_pre_action 06:48:20 INFO - Running main action method: read_buildbot_config 06:48:20 INFO - Using buildbot properties: 06:48:20 INFO - { 06:48:20 INFO - "project": "", 06:48:20 INFO - "product": "firefox", 06:48:20 INFO - "script_repo_revision": "production", 06:48:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:48:20 INFO - "repository": "", 06:48:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:48:20 INFO - "buildid": "20160414033456", 06:48:20 INFO - "pgo_build": "True", 06:48:20 INFO - "basedir": "/builds/slave/test", 06:48:20 INFO - "buildnumber": 166, 06:48:20 INFO - "slavename": "talos-linux64-ix-010", 06:48:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:48:20 INFO - "platform": "ubuntu64_hw", 06:48:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:48:20 INFO - "branch": "mozilla-aurora", 06:48:20 INFO - "repo_path": "releases/mozilla-aurora", 06:48:20 INFO - "revision": "f33dbaaf6abd2af0dd3a917c880e759aca2a5c12", 06:48:20 INFO - "stage_platform": "linux64-pgo", 06:48:20 INFO - "builduid": "e21ed88e933a46a783e3cf09d9517e74", 06:48:20 INFO - "slavebuilddir": "test" 06:48:20 INFO - } 06:48:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 06:48:20 INFO - Running post-action listener: _resource_record_post_action 06:48:20 INFO - ##### 06:48:20 INFO - ##### Running download-and-extract step. 06:48:20 INFO - ##### 06:48:20 INFO - Running pre-action listener: _resource_record_pre_action 06:48:20 INFO - Running main action method: download_and_extract 06:48:20 INFO - mkdir: /builds/slave/test/build/tests 06:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:20 INFO - https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 06:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 06:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 06:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:48:23 INFO - Downloaded 1448 bytes. 06:48:23 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 06:48:23 INFO - Using the following test package requirements: 06:48:23 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 06:48:23 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:48:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:48:23 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:48:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:48:23 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:48:23 INFO - u'jsshell-linux-x86_64.zip'], 06:48:23 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:48:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:48:23 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 06:48:23 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:48:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:48:23 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:48:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:48:23 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:48:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:48:23 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 06:48:23 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 06:48:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:48:23 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:23 INFO - https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:48:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:48:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:48:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:48:25 INFO - Downloaded 23352277 bytes. 06:48:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:48:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:48:26 INFO - Return code: 0 06:48:26 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:48: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')]} 06:48:26 INFO - https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:48:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:48:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:48:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 06:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:48:29 INFO - Downloaded 23352277 bytes. 06:48:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:48:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:48:31 INFO - Return code: 0 06:48: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')]} 06:48:31 INFO - https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:48:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 06:48:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 06:48:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 06:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:48:32 INFO - Downloaded 10845168 bytes. 06:48:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:48:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:48:32 INFO - Return code: 0 06:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:32 INFO - https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:48:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:48:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:48:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:48:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:48:34 INFO - Downloaded 60573479 bytes. 06:48:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:48:34 INFO - mkdir: /builds/slave/test/properties 06:48:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:48:34 INFO - Writing to file /builds/slave/test/properties/build_url 06:48:34 INFO - Contents: 06:48:34 INFO - build_url:https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 06:48:35 INFO - Running post-action listener: _resource_record_post_action 06:48:35 INFO - Running post-action listener: set_extra_try_arguments 06:48:35 INFO - ##### 06:48:35 INFO - ##### Running populate-webroot step. 06:48:35 INFO - ##### 06:48:35 INFO - Running pre-action listener: _resource_record_pre_action 06:48:35 INFO - Running main action method: populate_webroot 06:48:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:48:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:48:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:48:35 INFO - '--tppagecycles', 06:48:35 INFO - '7'], 06:48:35 INFO - 'tests': ['tsvgm']}}, 06:48:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:48:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:48:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:48:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:48:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:48:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:48:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:48:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:35 INFO - 'talos_options': ['--e10s'], 06:48:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:48:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:35 INFO - 'tests': ['damp', 'tps']}, 06:48:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:35 INFO - 'talos_options': ['--e10s'], 06:48:35 INFO - 'tests': ['damp', 'tps']}, 06:48:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:48:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:48:35 INFO - 'other': {'tests': ['a11yr', 06:48:35 INFO - 'ts_paint', 06:48:35 INFO - 'tpaint', 06:48:35 INFO - 'sessionrestore', 06:48:35 INFO - 'sessionrestore_no_auto_restore', 06:48:35 INFO - 'tabpaint']}, 06:48:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:48:35 INFO - 'tests': ['a11yr', 06:48:35 INFO - 'ts_paint', 06:48:35 INFO - 'tpaint', 06:48:35 INFO - 'sessionrestore', 06:48:35 INFO - 'sessionrestore_no_auto_restore', 06:48:35 INFO - 'tabpaint']}, 06:48:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:48:35 INFO - 'tests': ['a11yr', 06:48:35 INFO - 'ts_paint', 06:48:35 INFO - 'tpaint', 06:48:35 INFO - 'sessionrestore', 06:48:35 INFO - 'sessionrestore_no_auto_restore', 06:48:35 INFO - 'tabpaint']}, 06:48:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:48:35 INFO - 'tests': ['a11yr', 06:48:35 INFO - 'ts_paint', 06:48:35 INFO - 'tpaint', 06:48:35 INFO - 'sessionrestore', 06:48:35 INFO - 'sessionrestore_no_auto_restore', 06:48:35 INFO - 'tabpaint']}, 06:48:35 INFO - 'other_l64': {'tests': ['a11yr', 06:48:35 INFO - 'ts_paint', 06:48:35 INFO - 'tpaint', 06:48:35 INFO - 'sessionrestore', 06:48:35 INFO - 'sessionrestore_no_auto_restore', 06:48:35 INFO - 'tabpaint']}, 06:48:35 INFO - 'other_nol64': {'tests': ['a11yr', 06:48:35 INFO - 'ts_paint', 06:48:35 INFO - 'tpaint', 06:48:35 INFO - 'sessionrestore', 06:48:35 INFO - 'sessionrestore_no_auto_restore', 06:48:35 INFO - 'tabpaint']}, 06:48:35 INFO - 'svgr': {'tests': ['tsvgx', 06:48:35 INFO - 'tsvgr_opacity', 06:48:35 INFO - 'tart', 06:48:35 INFO - 'tscrollx', 06:48:35 INFO - 'cart']}, 06:48:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:48:35 INFO - 'tests': ['tsvgx', 06:48:35 INFO - 'tsvgr_opacity', 06:48:35 INFO - 'tart', 06:48:35 INFO - 'tscrollx', 06:48:35 INFO - 'cart']}, 06:48:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:35 INFO - 'tests': ['tp5o']}, 06:48:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:35 INFO - 'talos_options': ['--e10s'], 06:48:35 INFO - 'tests': ['tp5o']}, 06:48:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:35 INFO - 'talos_options': ['--xperf_path', 06:48:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:48:35 INFO - 'tests': ['tp5n']}, 06:48:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:35 INFO - 'talos_options': ['--e10s', 06:48:35 INFO - '--xperf_path', 06:48:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:48:35 INFO - 'tests': ['tp5n']}}, 06:48:35 INFO - 'talos.zip': {'path': '', 06:48:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:48:35 INFO - Running post-action listener: _resource_record_post_action 06:48:35 INFO - ##### 06:48:35 INFO - ##### Running create-virtualenv step. 06:48:35 INFO - ##### 06:48:35 INFO - Running pre-action listener: _resource_record_pre_action 06:48:35 INFO - Running main action method: create_virtualenv 06:48:35 INFO - Creating virtualenv /builds/slave/test/build/venv 06:48:35 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 06:48:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:48:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:48:35 INFO - Using real prefix '/usr' 06:48:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:48:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:48:38 INFO - Installing pip.................done. 06:48:38 INFO - Return code: 0 06:48:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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')]} 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa133950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d42410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', '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 06:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:48:38 INFO - Using env: {'DISPLAY': ':0', 06:48:38 INFO - 'HOME': '/home/cltbld', 06:48:38 INFO - 'LANG': 'en_US.UTF-8', 06:48:38 INFO - 'LANGUAGE': 'en_US:en', 06:48:38 INFO - 'LOGNAME': 'cltbld', 06:48:38 INFO - 'MAIL': '/var/mail/cltbld', 06:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:38 INFO - 'MOZ_NO_REMOTE': '1', 06:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:38 INFO - 'NO_EM_RESTART': '1', 06:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:38 INFO - 'PWD': '/builds/slave/test', 06:48:38 INFO - 'SHELL': '/bin/bash', 06:48:38 INFO - 'SHLVL': '1', 06:48:38 INFO - 'TERM': 'linux', 06:48:38 INFO - 'TMOUT': '86400', 06:48:38 INFO - 'USER': 'cltbld', 06:48:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:38 INFO - '_': '/tools/buildbot/bin/python'} 06:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:38 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 06:48:38 INFO - Cleaning up... 06:48:38 INFO - Return code: 0 06:48:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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')]} 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa133950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d42410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', '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 06:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:48:38 INFO - Using env: {'DISPLAY': ':0', 06:48:38 INFO - 'HOME': '/home/cltbld', 06:48:38 INFO - 'LANG': 'en_US.UTF-8', 06:48:38 INFO - 'LANGUAGE': 'en_US:en', 06:48:38 INFO - 'LOGNAME': 'cltbld', 06:48:38 INFO - 'MAIL': '/var/mail/cltbld', 06:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:38 INFO - 'MOZ_NO_REMOTE': '1', 06:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:38 INFO - 'NO_EM_RESTART': '1', 06:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:38 INFO - 'PWD': '/builds/slave/test', 06:48:38 INFO - 'SHELL': '/bin/bash', 06:48:38 INFO - 'SHLVL': '1', 06:48:38 INFO - 'TERM': 'linux', 06:48:38 INFO - 'TMOUT': '86400', 06:48:38 INFO - 'USER': 'cltbld', 06:48:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:38 INFO - '_': '/tools/buildbot/bin/python'} 06:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:38 INFO - Downloading/unpacking psutil>=0.7.1 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:48:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:48:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:48:40 INFO - Installing collected packages: psutil 06:48:40 INFO - Running setup.py install for psutil 06:48:40 INFO - building 'psutil._psutil_linux' extension 06:48:40 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 06:48:40 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 06:48:40 INFO - building 'psutil._psutil_posix' extension 06:48:40 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 06:48:40 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 06:48:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:48:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:48:41 INFO - Successfully installed psutil 06:48:41 INFO - Cleaning up... 06:48:41 INFO - Return code: 0 06:48:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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')]} 06:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:41 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 0x7fa133950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d42410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', '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 06:48:41 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 06:48:41 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 06:48:41 INFO - Using env: {'DISPLAY': ':0', 06:48:41 INFO - 'HOME': '/home/cltbld', 06:48:41 INFO - 'LANG': 'en_US.UTF-8', 06:48:41 INFO - 'LANGUAGE': 'en_US:en', 06:48:41 INFO - 'LOGNAME': 'cltbld', 06:48:41 INFO - 'MAIL': '/var/mail/cltbld', 06:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:41 INFO - 'MOZ_NO_REMOTE': '1', 06:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:41 INFO - 'NO_EM_RESTART': '1', 06:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:41 INFO - 'PWD': '/builds/slave/test', 06:48:41 INFO - 'SHELL': '/bin/bash', 06:48:41 INFO - 'SHLVL': '1', 06:48:41 INFO - 'TERM': 'linux', 06:48:41 INFO - 'TMOUT': '86400', 06:48:41 INFO - 'USER': 'cltbld', 06:48:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:41 INFO - '_': '/tools/buildbot/bin/python'} 06:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:48:43 INFO - Installing collected packages: mozsystemmonitor 06:48:43 INFO - Running setup.py install for mozsystemmonitor 06:48:43 INFO - Successfully installed mozsystemmonitor 06:48:43 INFO - Cleaning up... 06:48:43 INFO - Return code: 0 06:48:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:43 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 0x7fa133950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d42410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', '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 06:48:43 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 06:48:43 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 06:48:43 INFO - Using env: {'DISPLAY': ':0', 06:48:43 INFO - 'HOME': '/home/cltbld', 06:48:43 INFO - 'LANG': 'en_US.UTF-8', 06:48:43 INFO - 'LANGUAGE': 'en_US:en', 06:48:43 INFO - 'LOGNAME': 'cltbld', 06:48:43 INFO - 'MAIL': '/var/mail/cltbld', 06:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:43 INFO - 'MOZ_NO_REMOTE': '1', 06:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:43 INFO - 'NO_EM_RESTART': '1', 06:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:43 INFO - 'PWD': '/builds/slave/test', 06:48:43 INFO - 'SHELL': '/bin/bash', 06:48:43 INFO - 'SHLVL': '1', 06:48:43 INFO - 'TERM': 'linux', 06:48:43 INFO - 'TMOUT': '86400', 06:48:43 INFO - 'USER': 'cltbld', 06:48:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:43 INFO - '_': '/tools/buildbot/bin/python'} 06:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:43 INFO - Downloading/unpacking blobuploader==1.2.4 06:48:43 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 06:48:43 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 06:48:43 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 06:48:43 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 06:48:43 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 06:48:43 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 06:48:45 INFO - Downloading blobuploader-1.2.4.tar.gz 06:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:48:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:48:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:46 INFO - Downloading docopt-0.6.1.tar.gz 06:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:48:46 INFO - Installing collected packages: blobuploader, requests, docopt 06:48:46 INFO - Running setup.py install for blobuploader 06:48:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:48:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:48:46 INFO - Running setup.py install for requests 06:48:46 INFO - Running setup.py install for docopt 06:48:46 INFO - Successfully installed blobuploader requests docopt 06:48:46 INFO - Cleaning up... 06:48:46 INFO - Return code: 0 06:48:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:46 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 0x7fa133950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d42410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', '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 06:48:46 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 06:48:46 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 06:48:46 INFO - Using env: {'DISPLAY': ':0', 06:48:46 INFO - 'HOME': '/home/cltbld', 06:48:46 INFO - 'LANG': 'en_US.UTF-8', 06:48:46 INFO - 'LANGUAGE': 'en_US:en', 06:48:46 INFO - 'LOGNAME': 'cltbld', 06:48:46 INFO - 'MAIL': '/var/mail/cltbld', 06:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:46 INFO - 'MOZ_NO_REMOTE': '1', 06:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:46 INFO - 'NO_EM_RESTART': '1', 06:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:46 INFO - 'PWD': '/builds/slave/test', 06:48:46 INFO - 'SHELL': '/bin/bash', 06:48:46 INFO - 'SHLVL': '1', 06:48:46 INFO - 'TERM': 'linux', 06:48:46 INFO - 'TMOUT': '86400', 06:48:46 INFO - 'USER': 'cltbld', 06:48:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:46 INFO - '_': '/tools/buildbot/bin/python'} 06:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:47 INFO - Running setup.py (path:/tmp/pip-4SAC_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:47 INFO - Running setup.py (path:/tmp/pip-APzrXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:47 INFO - Running setup.py (path:/tmp/pip-2VMnWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:47 INFO - Running setup.py (path:/tmp/pip-PTRlfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:47 INFO - Running setup.py (path:/tmp/pip-JLCyYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:47 INFO - Running setup.py (path:/tmp/pip-E5aSVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:47 INFO - Running setup.py (path:/tmp/pip-YsRAvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:47 INFO - Running setup.py (path:/tmp/pip-avFhEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:47 INFO - Running setup.py (path:/tmp/pip-1lJ2ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:47 INFO - Running setup.py (path:/tmp/pip-Z_JAIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:47 INFO - Running setup.py (path:/tmp/pip-RHuEW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:47 INFO - Running setup.py (path:/tmp/pip-UKsU3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:47 INFO - Running setup.py (path:/tmp/pip-hmJno_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:48 INFO - Running setup.py (path:/tmp/pip-0sBdSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:48 INFO - Running setup.py (path:/tmp/pip-gteOlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:48 INFO - Running setup.py (path:/tmp/pip-2kFlnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:48 INFO - Running setup.py (path:/tmp/pip-4cPApn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:48:48 INFO - Running setup.py install for manifestparser 06:48:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:48:48 INFO - Running setup.py install for mozcrash 06:48:48 INFO - Running setup.py install for mozdebug 06:48:48 INFO - Running setup.py install for mozdevice 06:48:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:48:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:48:48 INFO - Running setup.py install for mozfile 06:48:48 INFO - Running setup.py install for mozhttpd 06:48:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:48:48 INFO - Running setup.py install for mozinfo 06:48:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:48:48 INFO - Running setup.py install for mozInstall 06:48:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Running setup.py install for mozleak 06:48:49 INFO - Running setup.py install for mozlog 06:48:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Running setup.py install for moznetwork 06:48:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Running setup.py install for mozprocess 06:48:49 INFO - Running setup.py install for mozprofile 06:48:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Running setup.py install for mozrunner 06:48:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Running setup.py install for mozscreenshot 06:48:49 INFO - Running setup.py install for moztest 06:48:49 INFO - Running setup.py install for mozversion 06:48:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:48:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:48:50 INFO - Cleaning up... 06:48:50 INFO - Return code: 0 06:48:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:50 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 0x7fa133950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d42410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', '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 06:48:50 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 06:48:50 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 06:48:50 INFO - Using env: {'DISPLAY': ':0', 06:48:50 INFO - 'HOME': '/home/cltbld', 06:48:50 INFO - 'LANG': 'en_US.UTF-8', 06:48:50 INFO - 'LANGUAGE': 'en_US:en', 06:48:50 INFO - 'LOGNAME': 'cltbld', 06:48:50 INFO - 'MAIL': '/var/mail/cltbld', 06:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:50 INFO - 'MOZ_NO_REMOTE': '1', 06:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:50 INFO - 'NO_EM_RESTART': '1', 06:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:50 INFO - 'PWD': '/builds/slave/test', 06:48:50 INFO - 'SHELL': '/bin/bash', 06:48:50 INFO - 'SHLVL': '1', 06:48:50 INFO - 'TERM': 'linux', 06:48:50 INFO - 'TMOUT': '86400', 06:48:50 INFO - 'USER': 'cltbld', 06:48:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:50 INFO - '_': '/tools/buildbot/bin/python'} 06:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:50 INFO - Running setup.py (path:/tmp/pip-bdcgYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:50 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)) 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:50 INFO - Running setup.py (path:/tmp/pip-w8tWVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:50 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)) 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:50 INFO - Running setup.py (path:/tmp/pip-YZV47W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:50 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)) 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:50 INFO - Running setup.py (path:/tmp/pip-wv5CFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:50 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)) 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:50 INFO - Running setup.py (path:/tmp/pip-3MXtc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:50 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)) 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:50 INFO - Running setup.py (path:/tmp/pip-we9sQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:50 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)) 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:50 INFO - Running setup.py (path:/tmp/pip-Z_URvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:50 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)) 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:50 INFO - Running setup.py (path:/tmp/pip-UMNTMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:50 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)) 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:50 INFO - Running setup.py (path:/tmp/pip-Sz_LLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:50 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)) 06:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:50 INFO - Running setup.py (path:/tmp/pip-9_eCUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:51 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)) 06:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:51 INFO - Running setup.py (path:/tmp/pip-z9UbIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:51 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)) 06:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:51 INFO - Running setup.py (path:/tmp/pip-TyXiT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:51 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)) 06:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:51 INFO - Running setup.py (path:/tmp/pip-pvKEKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:51 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)) 06:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:51 INFO - Running setup.py (path:/tmp/pip-72_bcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:51 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)) 06:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:51 INFO - Running setup.py (path:/tmp/pip-SBHEUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:51 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)) 06:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:51 INFO - Running setup.py (path:/tmp/pip-4fh3CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:51 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)) 06:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:51 INFO - Running setup.py (path:/tmp/pip-9tPtYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:51 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)) 06:48:51 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)) 06:48:51 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)) 06:48:51 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)) 06:48:51 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)) 06:48:51 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)) 06:48:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:53 INFO - Downloading blessings-1.6.tar.gz 06:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:48:53 INFO - Installing collected packages: blessings 06:48:53 INFO - Running setup.py install for blessings 06:48:53 INFO - Successfully installed blessings 06:48:53 INFO - Cleaning up... 06:48:53 INFO - Return code: 0 06:48:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:53 INFO - Reading from file tmpfile_stdout 06:48:53 INFO - Current package versions: 06:48:53 INFO - argparse == 1.2.1 06:48:53 INFO - blessings == 1.6 06:48:53 INFO - blobuploader == 1.2.4 06:48:53 INFO - docopt == 0.6.1 06:48:53 INFO - manifestparser == 1.1 06:48:53 INFO - mozInstall == 1.12 06:48:53 INFO - mozcrash == 0.17 06:48:53 INFO - mozdebug == 0.1 06:48:53 INFO - mozdevice == 0.48 06:48:53 INFO - mozfile == 1.2 06:48:53 INFO - mozhttpd == 0.7 06:48:53 INFO - mozinfo == 0.9 06:48:53 INFO - mozleak == 0.1 06:48:53 INFO - mozlog == 3.1 06:48:53 INFO - moznetwork == 0.27 06:48:53 INFO - mozprocess == 0.22 06:48:53 INFO - mozprofile == 0.28 06:48:53 INFO - mozrunner == 6.11 06:48:53 INFO - mozscreenshot == 0.1 06:48:53 INFO - mozsystemmonitor == 0.0 06:48:53 INFO - moztest == 0.7 06:48:53 INFO - mozversion == 1.4 06:48:53 INFO - psutil == 3.1.1 06:48:53 INFO - requests == 1.2.3 06:48:53 INFO - wsgiref == 0.1.2 06:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:53 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 0x7fa133950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d42410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', '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 06:48:53 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 06:48:53 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 06:48:53 INFO - Using env: {'DISPLAY': ':0', 06:48:53 INFO - 'HOME': '/home/cltbld', 06:48:53 INFO - 'LANG': 'en_US.UTF-8', 06:48:53 INFO - 'LANGUAGE': 'en_US:en', 06:48:53 INFO - 'LOGNAME': 'cltbld', 06:48:53 INFO - 'MAIL': '/var/mail/cltbld', 06:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:53 INFO - 'MOZ_NO_REMOTE': '1', 06:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:53 INFO - 'NO_EM_RESTART': '1', 06:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:53 INFO - 'PWD': '/builds/slave/test', 06:48:53 INFO - 'SHELL': '/bin/bash', 06:48:53 INFO - 'SHLVL': '1', 06:48:53 INFO - 'TERM': 'linux', 06:48:53 INFO - 'TMOUT': '86400', 06:48:53 INFO - 'USER': 'cltbld', 06:48:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:53 INFO - '_': '/tools/buildbot/bin/python'} 06:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 INFO - Cleaning up... 06:48:54 INFO - Return code: 0 06:48:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:48:54 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')]} 06:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:54 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')]} 06:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:54 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 0x7fa133950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d42410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', '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 06:48:54 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 06:48:54 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 06:48:54 INFO - Using env: {'DISPLAY': ':0', 06:48:54 INFO - 'HOME': '/home/cltbld', 06:48:54 INFO - 'LANG': 'en_US.UTF-8', 06:48:54 INFO - 'LANGUAGE': 'en_US:en', 06:48:54 INFO - 'LOGNAME': 'cltbld', 06:48:54 INFO - 'MAIL': '/var/mail/cltbld', 06:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:54 INFO - 'MOZ_NO_REMOTE': '1', 06:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:54 INFO - 'NO_EM_RESTART': '1', 06:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:54 INFO - 'PWD': '/builds/slave/test', 06:48:54 INFO - 'SHELL': '/bin/bash', 06:48:54 INFO - 'SHLVL': '1', 06:48:54 INFO - 'TERM': 'linux', 06:48:54 INFO - 'TMOUT': '86400', 06:48:54 INFO - 'USER': 'cltbld', 06:48:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:54 INFO - '_': '/tools/buildbot/bin/python'} 06:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:54 INFO - Downloading/unpacking jsonschema 06:48:54 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 06:48:54 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 06:48:54 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 06:48:54 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 06:48:54 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 06:48:54 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 06:48:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:48:56 INFO - Downloading/unpacking functools32 (from jsonschema) 06:48:56 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 06:48:56 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 06:48:56 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 06:48:56 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 06:48:56 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 06:48:56 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 06:48:56 INFO - Downloading functools32-3.2.3-2.tar.gz 06:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:48:56 INFO - warning: no files found matching '*.txt' 06:48:56 INFO - no previously-included directories found matching 'build' 06:48:56 INFO - no previously-included directories found matching 'dist' 06:48:56 INFO - no previously-included directories found matching '.git*' 06:48:56 INFO - Installing collected packages: jsonschema, functools32 06:48:56 INFO - Running setup.py install for functools32 06:48:56 INFO - warning: no files found matching '*.txt' 06:48:56 INFO - no previously-included directories found matching 'build' 06:48:56 INFO - no previously-included directories found matching 'dist' 06:48:56 INFO - no previously-included directories found matching '.git*' 06:48:56 INFO - Successfully installed jsonschema functools32 06:48:56 INFO - Cleaning up... 06:48:56 INFO - Return code: 0 06:48:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:48:56 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')]} 06:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:56 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')]} 06:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:56 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 0x7fa133950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d42410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', '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 06:48:56 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 06:48:56 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 06:48:56 INFO - Using env: {'DISPLAY': ':0', 06:48:56 INFO - 'HOME': '/home/cltbld', 06:48:56 INFO - 'LANG': 'en_US.UTF-8', 06:48:56 INFO - 'LANGUAGE': 'en_US:en', 06:48:56 INFO - 'LOGNAME': 'cltbld', 06:48:56 INFO - 'MAIL': '/var/mail/cltbld', 06:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:56 INFO - 'MOZ_NO_REMOTE': '1', 06:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:56 INFO - 'NO_EM_RESTART': '1', 06:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:56 INFO - 'PWD': '/builds/slave/test', 06:48:56 INFO - 'SHELL': '/bin/bash', 06:48:56 INFO - 'SHLVL': '1', 06:48:56 INFO - 'TERM': 'linux', 06:48:56 INFO - 'TMOUT': '86400', 06:48:56 INFO - 'USER': 'cltbld', 06:48:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:56 INFO - '_': '/tools/buildbot/bin/python'} 06:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:56 INFO - Downloading/unpacking flake8 06:48:56 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 06:48:56 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 06:48:56 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 06:48:56 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 06:48:56 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 06:48:56 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 06:48:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:48:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:48:58 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 06:48:58 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 06:48:58 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 06:48:58 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 06:48:58 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 06:48:58 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 06:48:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:48:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:48:59 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 06:48:59 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 06:48:59 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 06:48:59 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 06:48:59 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 06:48:59 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 06:48:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:48:59 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 06:48:59 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 06:48:59 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 06:48:59 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 06:48:59 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 06:48:59 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 06:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:48:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:48:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:48:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:48:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:48:59 INFO - no previously-included directories found matching 'docs/_build' 06:48:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:48:59 INFO - Running setup.py install for pep8 06:48:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:48:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:48:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:48:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:48:59 INFO - no previously-included directories found matching 'docs/_build' 06:48:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:48:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:48:59 INFO - Cleaning up... 06:48:59 INFO - Return code: 0 06:48:59 INFO - Running post-action listener: _resource_record_post_action 06:48:59 INFO - Running post-action listener: _start_resource_monitoring 06:48:59 INFO - Starting resource monitoring. 06:48:59 INFO - ##### 06:48:59 INFO - ##### Running install step. 06:48:59 INFO - ##### 06:48:59 INFO - Running pre-action listener: _resource_record_pre_action 06:48:59 INFO - Running main action method: install 06:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:49:00 INFO - Reading from file tmpfile_stdout 06:49:00 INFO - Detecting whether we're running mozinstall >=1.0... 06:49:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:49:00 INFO - Reading from file tmpfile_stdout 06:49:00 INFO - Output received: 06:49:00 INFO - Usage: mozinstall [options] installer 06:49:00 INFO - Options: 06:49:00 INFO - -h, --help show this help message and exit 06:49:00 INFO - -d DEST, --destination=DEST 06:49:00 INFO - Directory to install application into. [default: 06:49:00 INFO - "/builds/slave/test"] 06:49:00 INFO - --app=APP Application being installed. [default: firefox] 06:49:00 INFO - mkdir: /builds/slave/test/build/application 06:49:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:49:15 INFO - Reading from file tmpfile_stdout 06:49:15 INFO - Output received: 06:49:15 INFO - /builds/slave/test/build/application/firefox/firefox 06:49:15 INFO - Running post-action listener: _resource_record_post_action 06:49:15 INFO - ##### 06:49:15 INFO - ##### Running run-tests step. 06:49:15 INFO - ##### 06:49:15 INFO - Running pre-action listener: _resource_record_pre_action 06:49:15 INFO - Running main action method: run_tests 06:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:49:15 INFO - Python 2.7.3 06:49:15 INFO - Return code: 0 06:49:15 INFO - grabbing minidump binary from tooltool 06:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:15 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 0x1dd1160>, '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 0x1dd2060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd24f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:49:15 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 06:49:15 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 06:49:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:49:15 INFO - Return code: 0 06:49:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:49:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:49:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:49:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:49:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:49:16 INFO - Return code: 0 06:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:49:16 INFO - Using env: {'DISPLAY': ':0', 06:49:16 INFO - 'HOME': '/home/cltbld', 06:49:16 INFO - 'LANG': 'en_US.UTF-8', 06:49:16 INFO - 'LANGUAGE': 'en_US:en', 06:49:16 INFO - 'LOGNAME': 'cltbld', 06:49:16 INFO - 'MAIL': '/var/mail/cltbld', 06:49:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:49:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:16 INFO - 'MOZ_NO_REMOTE': '1', 06:49:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:16 INFO - 'NO_EM_RESTART': '1', 06:49:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:16 INFO - 'PWD': '/builds/slave/test', 06:49:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:49:16 INFO - 'SHELL': '/bin/bash', 06:49:16 INFO - 'SHLVL': '1', 06:49:16 INFO - 'TERM': 'linux', 06:49:16 INFO - 'TMOUT': '86400', 06:49:16 INFO - 'USER': 'cltbld', 06:49:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068', 06:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:16 INFO - '_': '/tools/buildbot/bin/python'} 06:49:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:49:16 INFO - mozversion application_buildid: 20160414033456 06:49:16 INFO - mozversion application_changeset: f33dbaaf6abd2af0dd3a917c880e759aca2a5c12 06:49:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:49:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:49:16 INFO - mozversion application_name: Firefox 06:49:16 INFO - mozversion application_remotingname: firefox-dev 06:49:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:49:16 INFO - mozversion application_vendor: Mozilla 06:49:16 INFO - mozversion application_version: 47.0a2 06:49:16 INFO - mozversion platform_buildid: 20160414033456 06:49:16 INFO - mozversion platform_changeset: f33dbaaf6abd2af0dd3a917c880e759aca2a5c12 06:49:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:49:16 INFO - mozversion platform_version: 47.0a2 06:49:16 INFO - using testdate: 1460641756 06:49:16 INFO - actual date: 1460641756 06:49:16 INFO - starting webserver on 'localhost:52385' 06:49:16 INFO - SUITE-START | Running 2 tests 06:49:16 INFO - TEST-START | dromaeo_css 06:49:16 INFO - operating with platform_type : linux_ 06:49:16 INFO - Initialising browser for dromaeo_css test... 06:49:16 INFO - TEST-INFO | started process 26055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvMMAf/profile http://localhost:52385/getInfo.html) 06:49:21 INFO - PROCESS | 26055 | __metrics Screen width/height:1600/1200 06:49:21 INFO - PROCESS | 26055 | colorDepth:24 06:49:21 INFO - PROCESS | 26055 | Browser inner width/height: 1024/697 06:49:21 INFO - PROCESS | 26055 | __metrics 06:49:22 INFO - PROCESS | 26055 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:49:23 INFO - TEST-INFO | 26055: exit 0 06:49:23 INFO - Browser initialized. 06:49:23 INFO - Running cycle 1/1 for dromaeo_css test... 06:49:23 INFO - TEST-INFO | started process 26145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkvMMAf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:35 INFO - PROCESS | 26145 | RSS: Main: 141197312 06:49:35 INFO - PROCESS | 26145 | 06:50:26 INFO - PROCESS | 26145 | 1460641826059 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] 06:52:33 INFO - PROCESS | 26145 | Cycle 1(1): loaded http://localhost:52385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52385/tests/dromaeo/cssquery-ext.html) 06:52:34 INFO - PROCESS | 26145 | RSS: Main: 248053760 06:52:34 INFO - PROCESS | 26145 | 06:55:37 INFO - PROCESS | 26145 | Cycle 1(1): loaded http://localhost:52385/tests/dromaeo/cssquery-ext.html (next: http://localhost:52385/tests/dromaeo/cssquery-jquery.html) 06:55:37 INFO - PROCESS | 26145 | RSS: Main: 221155328 06:55:37 INFO - PROCESS | 26145 | 06:58:39 INFO - PROCESS | 26145 | Cycle 1(1): loaded http://localhost:52385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52385/tests/dromaeo/cssquery-mootools.html) 06:58:40 INFO - PROCESS | 26145 | RSS: Main: 223449088 06:58:40 INFO - PROCESS | 26145 | 07:01:41 INFO - PROCESS | 26145 | Cycle 1(1): loaded http://localhost:52385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52385/tests/dromaeo/cssquery-prototype.html) 07:01:42 INFO - PROCESS | 26145 | RSS: Main: 197148672 07:01:42 INFO - PROCESS | 26145 | 07:04:44 INFO - PROCESS | 26145 | Cycle 1(1): loaded http://localhost:52385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52385/tests/dromaeo/cssquery-yui.html) 07:04:45 INFO - PROCESS | 26145 | RSS: Main: 212561920 07:04:45 INFO - PROCESS | 26145 | 07:07:47 INFO - PROCESS | 26145 | Cycle 1(1): loaded http://localhost:52385/tests/dromaeo/cssquery-yui.html (next: http://localhost:52385/tests/dromaeo/cssquery-dojo.html) 07:07:47 INFO - PROCESS | 26145 | RSS: Main: 254836736 07:07:47 INFO - PROCESS | 26145 | 07:07:47 INFO - PROCESS | 26145 | __start_tp_report 07:07:47 INFO - PROCESS | 26145 | _x_x_mozilla_page_load 07:07:47 INFO - PROCESS | 26145 | _x_x_mozilla_page_load_details 07:07:47 INFO - PROCESS | 26145 | |i|pagename|runs| 07:07:47 INFO - PROCESS | 26145 | |0;dojo.html;3263.8041717496953;3333.1833700743323;3349.8660053597855;3355.278615097755;3388.2037721135534;5370.409254981953;5384.892302153955;5404.378496472907;5422.078246698065;5434.266374039504;5397.190421436787;5418.241446197536;5431.755570999305;5437.619366644337;5442.809501667442;4799.592034677056;4919.680220785655;4981.676191047589;4995.550400463958;5032.7735251913755;4832.951670483303;4851.611871050325;4892.192788189945;4929.580985616227;4931.408231012284;4920.7785649645675;4969.950300497003;4985.800567977277;5028.572571331441;5035.144025515671;4948.653594248404;4996.800127994876;5011.123053465629;5017.8243761468175;5032.5470707636305;4840.1771698810935;4870.0746858096845;4913.656044076916;4958;4962.255661650745;5224.190250511177;5232.947670523284;5249.895002099936;5254.579633629301;5275.86810329741;5724.5992780505385;5726.141078838166;5746.885062298772;5751.798687045934;5755.654660720328;5658.971705141489;5684.516816070639;5740.913886291709;5768.307803063659;5783.363829978699;5315.229291752674;5315.3090098286975;5318.867028324285;5322.600804939606;5330.253764472977;5710.828675139753;5755.510781583613;5767.134929760569;5774.422557744192;5834.27071616048;5669.348024977098;5733.8566535836935;5735.483806457439;5768.74040668171;5769.538436925036;5732.570057245724;5753.194552762617;5754.798582049608;5758.193852860602;5758.568107391962;5600.467955544217;5643.774249030075;5656.406077361818;5674.744636491368;5675.772969081273;5678.4605462480995;5719.7140142992685;5723.885522289531;5726.169705392778;5752.9712351437975;4272.060146767706;4301.989032577342;4310.784460776948;4311.935320970188;4337.891552711208;3858.2476417098956;3893;3903.6291552302487;3939.2909276330533;3998;5482.972585137049;5497.257870187474;5497.340319161726;5499.395066542677;5514.448555144453;5803.303603567599;5819.563532735062;5820.73806678692;5826.970865145732;5832.241808564944;5394.649347792381;5466.726663666801;5496.532794712414;5534.335879694462;5541.889162216733;4932.235503496964;4972.552470277692;4976.651634385558;4979.676321039121;5024.849254522297;5938.257717785277;5967.254093238345;5972.581919265696;5973.432523910222;5977.193078934375;5634.4365563443325;5797.2173756542325;5856.297244330707;5864.44287792659;5872.588918775645;5973.074173503114;5978.850528736816;5983;5987;5992.161097446448;5550.4449555044175;5711.343195532567;5715.771369145187;5721.656700597978;5729.742161602655;5784.21913041734;5846;5852.385499522659;5855.824325270249;5885.882282354414;5629.634073785191;5671.120976248688;5672.7163641816915;5676.602637815313;5679.119736440858;5385.8114965976;5567.24842146305;5647.887042259214;5660.179274005329;5661.405552416937;5549.112142057252;5557.5553955682635;5561.110222364402;5567.777288908398;5600.0479918414785;5656.604037717485;5683.602147849776;5685.260916081049;5693.345265294544;5693.402192769865;5380.757865895966;5529.723513824373;5583.162525621027;5617.073182924772;5617.578681598979 07:07:47 INFO - PROCESS | 26145 | |1;ext.html;508.23003150227413;563.4478211352873;583.1806312131457;594.8423667728052;625.971831267593;31865.840670796642;32646;39546.40680389797;40126.79936600313;40241;42233.788831055805;42700;42902;42967.78516107423;43024.3546346805;8050.5974701264995;8859.82280354391;9066.637334506611;9068.77328066797;9074.047225041375;10632.946835265813;10929.836052459219;10932;10934.289271197387;10938.835917461205;10661.360318380883;10699.197560182978;10747.032767050963;10764.78470430591;10772.73068173298;10576.947115264451;10680.78638427235;10682.893171068345;10689.198310126732;10696.572137114545;10434.269601127924;10588.735281617945;10591.523381447852;10601.257911946166;10607.045365917027;42387.15225695469;42599.78700106511;42830.57169428297;42998;43017.78491107524;3539.0444579963264;3638.945415818765;3658.8902332930056;4069.369247766601;4424.225760491933;33134.6686533134;33424.83287583571;33426.83286583576;34284;35744.821275893715;4217.7891105444605;4259.871134149453;4288.9785551072355;4294.202826184657;4343.283358245885;286752;287420;287865;288041;288361.67457488156;47393;47667;47692.284615730794;68504.6574767123;69056.309436906;45252.77373613177;45630.77184614056;45726.314105288446;45835.77082114568;45865.312020319725;14563.563093107225;14706.852931470548;14774.409023638935;14781.556553303419;14814.92592537052;10624.256302058782;10858.077063449537;11621.07031437483;11816.940915295369;11894.524219031142;15231.086134831945;15258.771118433233;15329.540113796604;15362.078275303295;15474.84525154734;5929.399062253167;6100.206973093558;6160.568760186834;6329.968350158219;6352.333005034498;1023.0587859169582;1034.3121823986965;1082.3830416662584;1088.3919805843761;1157.976840463186;29709.85145074304;29867.850660746557;30088;30643.233919151753;31114;1129.745807193375;1133.2124173699365;1153.9056612248742;1175.2419689300352;1199.9460024298928;16076.633486153574;16197.109158996132;16202.918985404998;16393.59016024585;16516.256768445448;354411;356586;356624;356680;357839;58788.412115879146;58919.70540147358;59507;59581.702091489264;59623;1344.1061693973593;1360.2314692199075;1377.807107005;1413.3781136299995;1470.477980316972;28178.039055209865;28263.15210543687;28508.287292817844;30192;30894.69105308918;47127.52872471231;47260;47658.52341476541;47667;47706.52293477021;203714;205180;206058;206320;206418;30748.385032299677;34434;35074.82462587773;35210.64789352176;35211.82394088116;41655.7917210412;42134;43021.784891075346;43354.56645433505;45079.32381014222;38879;38965.80517097397;39626.42428242155;39671.40492892551;40129.598704012584;37198.44202337021;37818.62181378151;38937.805310973265;39254;39524.802375987936;38261.617383825804;38817.22365552617;39209;39598.60401395949;39788.403173953;33746.83126584352;34555;34988.47517287294;35030.64969350274;35290.82354588211;26231.475370492866;26738.866305668347;26823.865880670473;26867.86566067157;27177 07:07:47 INFO - PROCESS | 26145 | |2;jquery.html;367.5662717992769;373.50510573490124;383.03093174269094;386.5438782236961;391.0653538044073;18055.277788888445;18956.810431895676;19600.509987250327;19738.60522789547;19755.111020004082;17512.12439378029;17695.73456398155;18135.274589016422;18191.636167276647;18215.362462313788;5595.328560572727;5674.801381951633;5676.971615141939;5710.914336284938;5716.1711551824965;4246.745195288293;5978.581499295051;6221.59559628625;6222.719977601018;6226.657533835637;6128.877422451548;6221.595596286227;6223.284322302925;6250.4062114099315;6259.405356491126;6004.759809607611;6079.848003799896;6137.110119032715;6142.907856382158;6157.6305421674615;3861.44009118679;5268.31511903454;5483.396826349099;5484.040292948718;5488.121900495901;21862.211282663255;22013.339599812032;22150.55698886013;22580.43548911274;22762.317130486113;2411.602085655865;2445.6209287560455;2546.261584140597;2738.6165936768866;2878.668953070403;13674.521391751341;13806.240656763874;14078.85921140796;14180;14414.207218602973;1798.154867212421;1853.7497437845852;1888.8205620466033;1890.5651700108915;1917.166032775747;64529;65870;66283.33716662868;66383.66808165929;66406.99999999952;9237.353385262966;9483.099105584959;9593;9883.703488895344;9925.751856203653;13069.803952940714;13175.60473185806;13180.538681146305;13315.733685326433;13633.590992270249;7328.706851725871;7501.062367204099;7525.172231054579;7592.658330375147;7592.8481430371085;7247.673854676552;7298.70805167798;7355.632218389059;7364.521306115085;7368.263173682589;6073.119397687311;6076;6077.6353418795015;6120.540959428061;6176.320604733476;1719.5701074731317;1770.513108895064;1821.3898344054626;1839.667582842387;1852.9655899120703;450.33350641051425;450.73181457033013;453.9432570928634;466.2772702311404;1040.5369610523244;11250.718732031764;11461.71345716347;11465.942670286595;11570.421478926188;11647.53409863613;467.68898682376516;473.5453964194412;475.7026858213616;477.5105516845192;490.9018196360742;6142.293636231801;6309.842253943688;6328.240611126695;6340.175777149033;6427.58220715652;448550;457499;465016;470969;473818;82157.58921205475;83649.58175209085;83859.58070209732;84025.57987210147;84359.15640843636;499.41568365013023;501.47846239910814;502.703404991057;504.3619820926531;505.020260694252;10497.632582859564;10705.9464702676;10782.406967616856;10862.565497380016;10904.945475272572;34270.657293426746;34813.303733925684;34851.30297393987;35510.46734299039;35707.642923570435;51709.22436163385;52039.47960520498;52216.21675674792;52274.73862630662;52911.470885290655;8400.117987611457;8481.109483504144;8625.87061194095;8694.565271736261;8717.389782715149;8833;12276.877231227574;12881.162724422882;12940.547080852126;13194.274314912387;11036.944815276194;11314;11410.087193024372;11587.536498539965;11613.187076904536;11055.115590752881;11176.88823111791;11202.49588768491;11274.154438416988;11460.369679667698;11344.20590558686;11459.656210313704;11499.310041397543;11528;11861.22902011401;8155.959220203861;8257.504549727035;8287.337013039063;8352.290055345364;8379.203975622306;10720.678379648623;11405.942970285096;11430.314181149157;11493.712657183638;11543.942280288546 07:07:47 INFO - PROCESS | 26145 | |3;mootools.html;1433.2761955212616;1559.3061087815922;1580.1546172797548;1799.1454059321825;1926.5665225324303;8336.124706905772;8547.97424309083;8571.057183709787;8573.485590864553;8575.957120214405;8519.1906768857;8675.349348798834;8676.566171691422;8680.869786953184;8684.2618377438;2049.4876280929766;2084.843636727244;2344.1443872986324;2406.4585468269674;2456.754324567547;2437.524682686877;2444.303373538542;2445.0342114864616;2445.7187423446353;2446.7308596054418;2320.4894923116885;2333.7782910623464;2364.6925899633025;2365.95268094638;2373.4422410733464;2392.6530653055297;2416.4079800448912;2425.2724182745196;2447.119037146626;2447.6940382452194;2416;2434.1480481831395;2452.1785201957364;2457.127719659531;2462.6182941644074;8478.703245386443;8523.914760852374;8525.957370213171;8528.189821966904;8536.27441667459;5035.169197082477;5139.511746384088;5157;5158.071547121516;5159.1229490986625;3063.89276375328;3073.6465306489818;3107.409592177479;3216.292415668549;3216.372807302577;972.9416235025922;997.5710444508858;1000.6147633161213;1056.4295280548495;1057.4924036462542;12387.19483233596;12429;12430.813537796941;12435.44040518179;12444.253344799341;4435.534268901783;4465.933011004838;4510.887227819265;4583.816647334069;4606.193916064675;10414.531346089445;10418.06237438619;10429.739256518496;10474.214433917334;10476.47617619116;5121.359830021247;5127.743612819344;5173.793048278102;5177.767000484987;5179.300794392709;3942.802859857053;4463.8214471421425;4602.240630296031;4619.6073333766335;4622;3865.072382628205;3955.6637685796454;3971.225611005884;3974.105826189142;4015.5382131054716;1235.975280494403;1241.596481143632;1245.3212998915612;1248.2323371126693;1258.0124602187238;1418.4326269492285;1427.3291552970088;1439.5105664074056;1452.2230606625405;1469.0377802539354;8392;8430.957845210734;8446.324294056583;8463.49219046859;8468.40721149526;504.64674727690766;507.33792400917156;507.801957236678;514.1516497778695;518.4582111693289;6355.142055822497;6357.7139028742895;6384;6424.775132870327;6438.903416448757;10430.269881108401;10838.729031774268;10873.456327183609;11027.503762330714;11041.613543525938;10432.947835260775;10627.89372106269;10753.83869241962;10796.190285728602;10809.513571889283;8324.83350333002;8333.66665333392;8379.539125348165;8429.789255268668;8434.493930364199;7997.880031799644;8065.637046332812;8078.071021832329;8085.191480851868;8087.0295564532635;9436.339456238273;9504.19214366759;9506.144446999802;9645.180159686224;9715.465649389069;9415.15263626277;9734.659286924923;9952.601895924372;10094.697159085239;10163.085322321027;6522.15212022453;7321.890171647323;7650.4644674872225;7926;8004.039515258206;8298.128696487023;8316.750497485085;8326.50040997542;8367.874481882654;8370.204830541088;7395.926040739739;7506.887396688945;7556.1310449299035;7591.544507329578;7642.121156066901;7341.045664063851;7398.778036658909;7408.259174082764;7504.887426688495;7522.172561018393;7933.286004259644;7961.084475285184;7978.4016198786485;7991.800204994922;7999;7195.676194571152;7234.6744396501235;7257.600831954293;7295.7081716732855;7312.1591017033725;7338.743143989935;7349.375303099297;7393.1497877742595;7395.149557800706;7398.889016664647 07:07:47 INFO - PROCESS | 26145 | |4;prototype.html;357.6066327040256;358.46767550187985;359.3531643042523;360.52950899076706;367.7664682926341;6013.759449622021;6059.757609695607;6065.69671516424;6073.331933487313;6125.387461253884;6015.21802165719;6023.789167379143;6024.578279520435;6029.849253768658;6033.969830150854;4463.33050042493;4560.5667461591265;4657.51096134906;4680.812767489297;4708.976455117737;4677.13473007493;4679.134360143385;4683.250679891218;4707.576318131368;4713.575778179963;4644.094401591691;4649.953500464986;4652.604528615055;4657.138429390574;4663.440387153546;4431.756253406077;4545.204589196894;4649.721016739007;4658.743769092698;4663.2305669564485;4065.390191471303;4074.9592504074876;4078.163976384834;4100.097978444737;4111.424400583921;5749.0801471764735;5753.223314852483;5754.971225143848;5755.68343741094;5766.423357664242;5386.946130538684;5395.406505284415;5397.865053373697;5401.216823560601;5401.891962160735;6357.968210158966;6364.077208804697;6366.618002919793;6378.649174295459;6379.904301435482;4331.285337919239;4431.734095954221;4444.266695995157;4450;4549.454065512126;6577.539572229945;6637.767678131242;6645.700943457556;6665.133532640774;6672.2660507344635;4468.821247150077;4492.887677808081;4495.2358099122575;4501.549845015537;4508.797104130322;4551.7724113794175;4559.407277054028;4562.520935301812;4563.315502674625;4567.086582683477;5274.5780337572905;5288.81489147878;5291.126964050965;5291.603129765283;5298.337707786527;6253.6873156342;6391.1371964785085;6422.935770642327;6443.871122577522;6444.065610486453;1603.5830684022237;1611.0816834404277;1613.2659639864069;1615.2166199393284;1621.9026858388534;974.6637410093506;1076.160594736107;1083.268793564341;1127.6842484104463;1174.7121955120879;6184.350643182491;6214.440700336901;6215.782447614311;6225.968870155621;6226.066090086523;6608.504362172856;6608.669566521655;6620.073189753439;6621.4040736333;6622.768203112868;6201.534884883652;6203.286622038523;6203.410675985774;6208.379162083846;6216.160818289563;3541.061618671054;3574.8391322390553;3577.94633080504;3580.7672501287334;3581.3374525712825;6685.030670552743;6810.557313774589;6902.068220790229;6906;6917.792466226021;6819.761308354184;6855.6572171391235;6856.211535673362;6885.380315771505;6900.689468973908;6907.896381554281;6930.549514281656;6932.930670693228;6938.826529336807;6943.791686249521;6734.02356658272;6737.225219099866;6739.629320387426;6744.393004629607;6754.763583274562;6437.324080971618;6572.934270657423;6580.144581204604;6586.736530538725;6604.438622717123;6867.862642747217;6905.620190889549;6905.75829845953;6909.861802763816;6914.9308506914285;4610.308453731833;4644.442666879996;4645.07098580292;4650.767461626838;4654.4414670239785;6691.130153080068;6702.899456508058;6703.66481675924;6703.698333574904;6707.396334329934;6312.257523330129;6480.675966201577;6483.384078512534;6499.610023398611;6502.772402965874;6439.003908788291;6493.058506516623;6496.415322620986;6503.772367967098;6504.089427480251;6347.873042539031;6350.079238510298;6353.4599559038;6360.459360954371;6361;6527.51043671736;6530.955047192427;6531.608103513804;6543.934560654523;6549.181352330958;5916.49709774674;6110;6210.844728881814;6369.33122022181;6380.138681278154 07:07:47 INFO - PROCESS | 26145 | |5;yui.html;802.3701394405392;814.6904176412962;829.4318391901547;832.3798769916409;879.050625324649;14836.480723174678;14980;15000.774988375184;15023.098614083163;15048.84951150488;14038.227897465635;14042.157470551774;14094.718105637881;14127.92936035321;14203.147811131339;779.4855395439012;910.544727636182;924.3529529329462;925.3984909808611;926.1109335038371;920.8388532006873;942.9387089839173;945.9763505912339;948.6869333120088;948.8149810786899;993.135971704618;996.4021587047749;999.6950929966357;999.7450650084219;1000.3097862474906;819.0499021135454;956.6747305915952;987.9753006174831;988.9456079915566;989.0307498651326;739.4601940583404;739.7410906182847;740.3854800515559;740.4335683202354;740.5297636001125;14256.073355231876;14271.357788899524;14290.428382864673;14300.213488258141;14318.069325493914;13327.933360333232;14119.364628591738;14164.858351416457;14349.354279057468;14378.784318235235;10407.167426605853;10488.31825931312;10537;10824.891751082547;11237.101031917427;3921.941170882439;3937.547182074041;3970.4441378207075;3984.163325701606;4010.218007488541;52600;53360.46639533594;54266.72866635681;54551.45448545503;55072.44927550713;10771.353718776898;10782;10875.673729788119;10990;11213.66359009231;20938.162473501194;20938.37184884456;20948.266810661553;20954.47613809667;20972.47568810792;7864.724734634375;7965.283124518821;7965.6017199139815;8075.152109028468;8076.434649574591;4333.1766964276685;4372.759498227628;4441.977790111029;4522.88692782683;4534.229181039232;3325.185329594265;3331.1838599542784;3342.899713008565;3348;3348.8325583720716;596.9492593129632;603.7524614907867;609.2901769438555;617.0651463033507;619.2878190081352;610.3591229209312;637.9537558404221;658.5686375424104;684.1789852177407;697.2156324135348;8601.741947741577;8830.375616743604;8966.86549701755;9094.136057074567;9245.445273283625;559.9692016939026;593.9495142912814;619.362057081198;634.8603307272392;683.3235097253782;3935.74417662851;4002.8198731057173;4042.5351084625645;4070.1859628074503;4157.168566286755;58744.11883821746;60614.696926515964;60741.39258607446;60764.69617651883;60887;52542.949141016965;52543.474565254626;53314.73342633262;54808.72595636996;55117;47763.805904851964;48415.51584484181;48771.5122848767;49204.75397622989;49741.751291243316;7987.16134805837;8090.15053419406;8122.147174546588;8257.545834979133;8281.337493000425;36171.457428139125;37110.8144459276;37298.44052339271;37512;38183.618163818006;41859.372109417774;41950.58049419467;43554.78222608867;45591.31613025741;46381.53618463907;10007.899921000697;10066;10153.05334190527;10221.693349199535;10230.76923076923;11242.66272011841;11350.772984540428;11413.771724565628;11549.711257218636;11693.298402095561;10086.79826403453;10575.841362379724;10602.89397106019;10671.413072281099;10674.252802304074;10227.94886025565;10235.795284094127;10506.317089389166;10523;10619.575216991543;9748.707538773564;10080.747981300232;10119.7470063249;10132.74668133273;10292.330998485075;9123.817523649623;9126.954365228132;9157.633694652139;9220.492872892055;9221.077892210726;8715.869261961203;8887.955560222157;9130.95434522823;9140.817183656423;9193.908060919306 07:07:47 INFO - PROCESS | 26145 | __end_tp_report 07:07:47 INFO - PROCESS | 26145 | __start_cc_report 07:07:47 INFO - PROCESS | 26145 | _x_x_mozilla_cycle_collect,817 07:07:47 INFO - PROCESS | 26145 | __end_cc_report 07:07:47 INFO - PROCESS | 26145 | __startTimestamp1460642867776__endTimestamp 07:07:47 INFO - PROCESS | 26145 | 07:07:47 INFO - PROCESS | 26145 | ------- Summary: start ------- 07:07:47 INFO - PROCESS | 26145 | Number of tests: 6 07:07:47 INFO - PROCESS | 26145 | 07:07:47 INFO - PROCESS | 26145 | [#0] dojo.html Cycles:165 Average:5360.56 Median:5567.25 stddev:584.15 (10.5%) stddev-sans-first:562.30 07:07:47 INFO - PROCESS | 26145 | Values: 3263.8 3333.2 3349.9 3355.3 3388.2 5370.4 5384.9 5404.4 5422.1 5434.3 5397.2 5418.2 5431.8 5437.6 5442.8 4799.6 4919.7 4981.7 4995.6 5032.8 4833.0 4851.6 4892.2 4929.6 4931.4 4920.8 4970.0 4985.8 5028.6 5035.1 4948.7 4996.8 5011.1 5017.8 5032.5 4840.2 4870.1 4913.7 4958.0 4962.3 5224.2 5232.9 5249.9 5254.6 5275.9 5724.6 5726.1 5746.9 5751.8 5755.7 5659.0 5684.5 5740.9 5768.3 5783.4 5315.2 5315.3 5318.9 5322.6 5330.3 5710.8 5755.5 5767.1 5774.4 5834.3 5669.3 5733.9 5735.5 5768.7 5769.5 5732.6 5753.2 5754.8 5758.2 5758.6 5600.5 5643.8 5656.4 5674.7 5675.8 5678.5 5719.7 5723.9 5726.2 5753.0 4272.1 4302.0 4310.8 4311.9 4337.9 3858.2 3893.0 3903.6 3939.3 3998.0 5483.0 5497.3 5497.3 5499.4 5514.4 5803.3 5819.6 5820.7 5827.0 5832.2 5394.6 5466.7 5496.5 5534.3 5541.9 4932.2 4972.6 4976.7 4979.7 5024.8 5938.3 5967.3 5972.6 5973.4 5977.2 5634.4 5797.2 5856.3 5864.4 5872.6 5973.1 5978.9 5983.0 5987.0 5992.2 5550.4 5711.3 5715.8 5721.7 5729.7 5784.2 5846.0 5852.4 5855.8 5885.9 5629.6 5671.1 5672.7 5676.6 5679.1 5385.8 5567.2 5647.9 5660.2 5661.4 5549.1 5557.6 5561.1 5567.8 5600.0 5656.6 5683.6 5685.3 5693.3 5693.4 5380.8 5529.7 5583.2 5617.1 5617.6 07:07:47 INFO - PROCESS | 26145 | 07:07:47 INFO - PROCESS | 26145 | [#1] ext.html Cycles:180 Average:46048.66 Median:35009.56 stddev:75812.89 (216.5%) stddev-sans-first:75948.45 07:07:47 INFO - PROCESS | 26145 | Values: 508.2 563.4 583.2 594.8 626.0 31865.8 32646.0 39546.4 40126.8 40241.0 42233.8 42700.0 42902.0 42967.8 43024.4 8050.6 8859.8 9066.6 9068.8 9074.0 10632.9 10929.8 10932.0 10934.3 10938.8 10661.4 10699.2 10747.0 10764.8 10772.7 10576.9 10680.8 10682.9 10689.2 10696.6 10434.3 10588.7 10591.5 10601.3 10607.0 42387.2 42599.8 42830.6 42998.0 43017.8 3539.0 3638.9 3658.9 4069.4 4424.2 33134.7 33424.8 33426.8 34284.0 35744.8 4217.8 4259.9 4289.0 4294.2 4343.3 286752.0 287420.0 287865.0 288041.0 288361.7 47393.0 47667.0 47692.3 68504.7 69056.3 45252.8 45630.8 45726.3 45835.8 45865.3 14563.6 14706.9 14774.4 14781.6 14814.9 10624.3 10858.1 11621.1 11816.9 11894.5 15231.1 15258.8 15329.5 15362.1 15474.8 5929.4 6100.2 6160.6 6330.0 6352.3 1023.1 1034.3 1082.4 1088.4 1158.0 29709.9 29867.9 30088.0 30643.2 31114.0 1129.7 1133.2 1153.9 1175.2 1199.9 16076.6 16197.1 16202.9 16393.6 16516.3 354411.0 356586.0 356624.0 356680.0 357839.0 58788.4 58919.7 59507.0 59581.7 59623.0 1344.1 1360.2 1377.8 1413.4 1470.5 28178.0 28263.2 28508.3 30192.0 30894.7 47127.5 47260.0 47658.5 47667.0 47706.5 203714.0 205180.0 206058.0 206320.0 206418.0 30748.4 34434.0 35074.8 35210.6 35211.8 41655.8 42134.0 43021.8 43354.6 45079.3 38879.0 38965.8 39626.4 39671.4 40129.6 37198.4 37818.6 38937.8 39254.0 39524.8 38261.6 38817.2 39209.0 39598.6 39788.4 33746.8 34555.0 34988.5 35030.6 35290.8 26231.5 26738.9 26823.9 26867.9 27177.0 07:07:47 INFO - PROCESS | 26145 | 07:07:47 INFO - PROCESS | 26145 | [#2] jquery.html Cycles:180 Average:26590.82 Median:228976.47 stddev:76136.74 (33.3%) stddev-sans-first:76324.86 07:07:47 INFO - PROCESS | 26145 | Values: 367.6 373.5 383.0 386.5 391.1 18055.3 18956.8 19600.5 19738.6 19755.1 17512.1 17695.7 18135.3 18191.6 18215.4 5595.3 5674.8 5677.0 5710.9 5716.2 4246.7 5978.6 6221.6 6222.7 6226.7 6128.9 6221.6 6223.3 6250.4 6259.4 6004.8 6079.8 6137.1 6142.9 6157.6 3861.4 5268.3 5483.4 5484.0 5488.1 21862.2 22013.3 22150.6 22580.4 22762.3 2411.6 2445.6 2546.3 2738.6 2878.7 13674.5 13806.2 14078.9 14180.0 14414.2 1798.2 1853.7 1888.8 1890.6 1917.2 64529.0 65870.0 66283.3 66383.7 66407.0 9237.4 9483.1 9593.0 9883.7 9925.8 13069.8 13175.6 13180.5 13315.7 13633.6 7328.7 7501.1 7525.2 7592.7 7592.8 7247.7 7298.7 7355.6 7364.5 7368.3 6073.1 6076.0 6077.6 6120.5 6176.3 1719.6 1770.5 1821.4 1839.7 1853.0 450.3 450.7 453.9 466.3 1040.5 11250.7 11461.7 11465.9 11570.4 11647.5 467.7 473.5 475.7 477.5 490.9 6142.3 6309.8 6328.2 6340.2 6427.6 448550.0 457499.0 465016.0 470969.0 473818.0 82157.6 83649.6 83859.6 84025.6 84359.2 499.4 501.5 502.7 504.4 505.0 10497.6 10705.9 10782.4 10862.6 10904.9 34270.7 34813.3 34851.3 35510.5 35707.6 51709.2 52039.5 52216.2 52274.7 52911.5 8400.1 8481.1 8625.9 8694.6 8717.4 8833.0 12276.9 12881.2 12940.5 13194.3 11036.9 11314.0 11410.1 11587.5 11613.2 11055.1 11176.9 11202.5 11274.2 11460.4 11344.2 11459.7 11499.3 11528.0 11861.2 8156.0 8257.5 8287.3 8352.3 8379.2 10720.7 11405.9 11430.3 11493.7 11543.9 07:07:47 INFO - PROCESS | 26145 | 07:07:47 INFO - PROCESS | 26145 | [#3] mootools.html Cycles:180 Average:6065.22 Median:5133.63 stddev:3303.44 (64.3%) stddev-sans-first:3294.37 07:07:47 INFO - PROCESS | 26145 | Values: 1433.3 1559.3 1580.2 1799.1 1926.6 8336.1 8548.0 8571.1 8573.5 8576.0 8519.2 8675.3 8676.6 8680.9 8684.3 2049.5 2084.8 2344.1 2406.5 2456.8 2437.5 2444.3 2445.0 2445.7 2446.7 2320.5 2333.8 2364.7 2366.0 2373.4 2392.7 2416.4 2425.3 2447.1 2447.7 2416.0 2434.1 2452.2 2457.1 2462.6 8478.7 8523.9 8526.0 8528.2 8536.3 5035.2 5139.5 5157.0 5158.1 5159.1 3063.9 3073.6 3107.4 3216.3 3216.4 972.9 997.6 1000.6 1056.4 1057.5 12387.2 12429.0 12430.8 12435.4 12444.3 4435.5 4465.9 4510.9 4583.8 4606.2 10414.5 10418.1 10429.7 10474.2 10476.5 5121.4 5127.7 5173.8 5177.8 5179.3 3942.8 4463.8 4602.2 4619.6 4622.0 3865.1 3955.7 3971.2 3974.1 4015.5 1236.0 1241.6 1245.3 1248.2 1258.0 1418.4 1427.3 1439.5 1452.2 1469.0 8392.0 8431.0 8446.3 8463.5 8468.4 504.6 507.3 507.8 514.2 518.5 6355.1 6357.7 6384.0 6424.8 6438.9 10430.3 10838.7 10873.5 11027.5 11041.6 10432.9 10627.9 10753.8 10796.2 10809.5 8324.8 8333.7 8379.5 8429.8 8434.5 7997.9 8065.6 8078.1 8085.2 8087.0 9436.3 9504.2 9506.1 9645.2 9715.5 9415.2 9734.7 9952.6 10094.7 10163.1 6522.2 7321.9 7650.5 7926.0 8004.0 8298.1 8316.8 8326.5 8367.9 8370.2 7395.9 7506.9 7556.1 7591.5 7642.1 7341.0 7398.8 7408.3 7504.9 7522.2 7933.3 7961.1 7978.4 7991.8 7999.0 7195.7 7234.7 7257.6 7295.7 7312.2 7338.7 7349.4 7393.1 7395.1 7398.9 07:07:47 INFO - PROCESS | 26145 | 07:07:47 INFO - PROCESS | 26145 | [#4] prototype.html Cycles:180 Average:5387.40 Median:6154.87 stddev:1627.76 (26.4%) stddev-sans-first:1587.94 07:07:47 INFO - PROCESS | 26145 | Values: 357.6 358.5 359.4 360.5 367.8 6013.8 6059.8 6065.7 6073.3 6125.4 6015.2 6023.8 6024.6 6029.8 6034.0 4463.3 4560.6 4657.5 4680.8 4709.0 4677.1 4679.1 4683.3 4707.6 4713.6 4644.1 4650.0 4652.6 4657.1 4663.4 4431.8 4545.2 4649.7 4658.7 4663.2 4065.4 4075.0 4078.2 4100.1 4111.4 5749.1 5753.2 5755.0 5755.7 5766.4 5386.9 5395.4 5397.9 5401.2 5401.9 6358.0 6364.1 6366.6 6378.6 6379.9 4331.3 4431.7 4444.3 4450.0 4549.5 6577.5 6637.8 6645.7 6665.1 6672.3 4468.8 4492.9 4495.2 4501.5 4508.8 4551.8 4559.4 4562.5 4563.3 4567.1 5274.6 5288.8 5291.1 5291.6 5298.3 6253.7 6391.1 6422.9 6443.9 6444.1 1603.6 1611.1 1613.3 1615.2 1621.9 974.7 1076.2 1083.3 1127.7 1174.7 6184.4 6214.4 6215.8 6226.0 6226.1 6608.5 6608.7 6620.1 6621.4 6622.8 6201.5 6203.3 6203.4 6208.4 6216.2 3541.1 3574.8 3577.9 3580.8 3581.3 6685.0 6810.6 6902.1 6906.0 6917.8 6819.8 6855.7 6856.2 6885.4 6900.7 6907.9 6930.5 6932.9 6938.8 6943.8 6734.0 6737.2 6739.6 6744.4 6754.8 6437.3 6572.9 6580.1 6586.7 6604.4 6867.9 6905.6 6905.8 6909.9 6914.9 4610.3 4644.4 4645.1 4650.8 4654.4 6691.1 6702.9 6703.7 6703.7 6707.4 6312.3 6480.7 6483.4 6499.6 6502.8 6439.0 6493.1 6496.4 6503.8 6504.1 6347.9 6350.1 6353.5 6360.5 6361.0 6527.5 6531.0 6531.6 6543.9 6549.2 5916.5 6110.0 6210.8 6369.3 6380.1 07:07:47 INFO - PROCESS | 26145 | 07:07:47 INFO - PROCESS | 26145 | [#5] yui.html Cycles:180 Average:14355.48 Median:48089.66 stddev:16889.81 (35.1%) stddev-sans-first:16906.53 07:07:47 INFO - PROCESS | 26145 | Values: 802.4 814.7 829.4 832.4 879.1 14836.5 14980.0 15000.8 15023.1 15048.8 14038.2 14042.2 14094.7 14127.9 14203.1 779.5 910.5 924.4 925.4 926.1 920.8 942.9 946.0 948.7 948.8 993.1 996.4 999.7 999.7 1000.3 819.0 956.7 988.0 988.9 989.0 739.5 739.7 740.4 740.4 740.5 14256.1 14271.4 14290.4 14300.2 14318.1 13327.9 14119.4 14164.9 14349.4 14378.8 10407.2 10488.3 10537.0 10824.9 11237.1 3921.9 3937.5 3970.4 3984.2 4010.2 52600.0 53360.5 54266.7 54551.5 55072.4 10771.4 10782.0 10875.7 10990.0 11213.7 20938.2 20938.4 20948.3 20954.5 20972.5 7864.7 7965.3 7965.6 8075.2 8076.4 4333.2 4372.8 4442.0 4522.9 4534.2 3325.2 3331.2 3342.9 3348.0 3348.8 596.9 603.8 609.3 617.1 619.3 610.4 638.0 658.6 684.2 697.2 8601.7 8830.4 8966.9 9094.1 9245.4 560.0 593.9 619.4 634.9 683.3 3935.7 4002.8 4042.5 4070.2 4157.2 58744.1 60614.7 60741.4 60764.7 60887.0 52542.9 52543.5 53314.7 54808.7 55117.0 47763.8 48415.5 48771.5 49204.8 49741.8 7987.2 8090.2 8122.1 8257.5 8281.3 36171.5 37110.8 37298.4 37512.0 38183.6 41859.4 41950.6 43554.8 45591.3 46381.5 10007.9 10066.0 10153.1 10221.7 10230.8 11242.7 11350.8 11413.8 11549.7 11693.3 10086.8 10575.8 10602.9 10671.4 10674.3 10227.9 10235.8 10506.3 10523.0 10619.6 9748.7 10080.7 10119.7 10132.7 10292.3 9123.8 9127.0 9157.6 9220.5 9221.1 8715.9 8888.0 9131.0 9140.8 9193.9 07:07:47 INFO - PROCESS | 26145 | -------- Summary: end -------- 07:07:47 INFO - PROCESS | 26145 | 07:07:48 INFO - TEST-INFO | 26145: exit 0 07:07:48 INFO - TEST-OK | dromaeo_css | took 1111794ms 07:07:48 INFO - TEST-START | kraken 07:07:48 INFO - operating with platform_type : linux_ 07:07:48 INFO - Initialising browser for kraken test... 07:07:48 INFO - TEST-INFO | started process 26331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8LuiLO/profile http://localhost:52385/getInfo.html) 07:07:52 INFO - PROCESS | 26331 | __metrics Screen width/height:1600/1200 07:07:52 INFO - PROCESS | 26331 | colorDepth:24 07:07:52 INFO - PROCESS | 26331 | Browser inner width/height: 1024/697 07:07:52 INFO - PROCESS | 26331 | __metrics 07:07:54 INFO - PROCESS | 26331 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:55 INFO - TEST-INFO | 26331: exit 0 07:07:55 INFO - Browser initialized. 07:07:55 INFO - Running cycle 1/1 for kraken test... 07:07:55 INFO - TEST-INFO | started process 26418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8LuiLO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:06 INFO - PROCESS | 26418 | RSS: Main: 141877248 07:08:06 INFO - PROCESS | 26418 | 07:08:09 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52385/tests/kraken/driver.html?testName=audio-beat-detection) 07:08:09 INFO - PROCESS | 26418 | RSS: Main: 177434624 07:08:09 INFO - PROCESS | 26418 | 07:08:12 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52385/tests/kraken/driver.html?testName=audio-dft) 07:08:13 INFO - PROCESS | 26418 | RSS: Main: 175968256 07:08:13 INFO - PROCESS | 26418 | 07:08:16 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52385/tests/kraken/driver.html?testName=audio-fft) 07:08:16 INFO - PROCESS | 26418 | RSS: Main: 174546944 07:08:16 INFO - PROCESS | 26418 | 07:08:18 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52385/tests/kraken/driver.html?testName=audio-oscillator) 07:08:19 INFO - PROCESS | 26418 | RSS: Main: 174927872 07:08:19 INFO - PROCESS | 26418 | 07:08:21 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:08:22 INFO - PROCESS | 26418 | RSS: Main: 172228608 07:08:22 INFO - PROCESS | 26418 | 07:08:25 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52385/tests/kraken/driver.html?testName=imaging-darkroom) 07:08:25 INFO - PROCESS | 26418 | RSS: Main: 172720128 07:08:25 INFO - PROCESS | 26418 | 07:08:29 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52385/tests/kraken/driver.html?testName=imaging-desaturate) 07:08:29 INFO - PROCESS | 26418 | RSS: Main: 171573248 07:08:29 INFO - PROCESS | 26418 | 07:08:32 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52385/tests/kraken/driver.html?testName=json-parse-financial) 07:08:32 INFO - PROCESS | 26418 | RSS: Main: 172617728 07:08:32 INFO - PROCESS | 26418 | 07:08:34 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:08:35 INFO - PROCESS | 26418 | RSS: Main: 176635904 07:08:35 INFO - PROCESS | 26418 | 07:08:36 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52385/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:08:37 INFO - PROCESS | 26418 | RSS: Main: 175403008 07:08:37 INFO - PROCESS | 26418 | 07:08:39 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:08:40 INFO - PROCESS | 26418 | RSS: Main: 181329920 07:08:40 INFO - PROCESS | 26418 | 07:08:42 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:08:42 INFO - PROCESS | 26418 | RSS: Main: 189263872 07:08:42 INFO - PROCESS | 26418 | 07:08:45 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:08:46 INFO - PROCESS | 26418 | RSS: Main: 187506688 07:08:46 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | Cycle 1(1): loaded http://localhost:52385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52385/tests/kraken/driver.html?testName=ai-astar) 07:08:47 INFO - PROCESS | 26418 | RSS: Main: 249298944 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | __start_tp_report 07:08:47 INFO - PROCESS | 26418 | _x_x_mozilla_page_load 07:08:47 INFO - PROCESS | 26418 | _x_x_mozilla_page_load_details 07:08:47 INFO - PROCESS | 26418 | |i|pagename|runs| 07:08:47 INFO - PROCESS | 26418 | |0;ai-astar;109;112;106;109;110;110;100;109;111;111 07:08:47 INFO - PROCESS | 26418 | |1;audio-beat-detection;152;136;162;176;129;166;161;133;184;127 07:08:47 INFO - PROCESS | 26418 | |2;audio-dft;160;161;161;160;160;160;160;165;162;160 07:08:47 INFO - PROCESS | 26418 | |3;audio-fft;75;76;76;167;78;75;75;74;166;77 07:08:47 INFO - PROCESS | 26418 | |4;audio-oscillator;92;93;152;93;93;94;135;93;93;152 07:08:47 INFO - PROCESS | 26418 | |5;imaging-gaussian-blur;116;116;116;117;117;116;116;117;116;118 07:08:47 INFO - PROCESS | 26418 | |6;imaging-darkroom;146;146;146;145;147;146;145;146;146;146 07:08:47 INFO - PROCESS | 26418 | |7;imaging-desaturate;95;96;96;95;96;95;95;96;95;95 07:08:47 INFO - PROCESS | 26418 | |8;json-parse-financial;55;55;57;55;55;54;55;64;53;52 07:08:47 INFO - PROCESS | 26418 | |9;json-stringify-tinderbox;64;67;65;65;65;65;64;65;65;65 07:08:47 INFO - PROCESS | 26418 | |10;stanford-crypto-aes;78;79;86;78;78;80;80;77;79;78 07:08:47 INFO - PROCESS | 26418 | |11;stanford-crypto-ccm;113;111;120;119;113;111;117;112;111;109 07:08:47 INFO - PROCESS | 26418 | |12;stanford-crypto-pbkdf2;154;144;138;143;135;137;148;146;152;142 07:08:47 INFO - PROCESS | 26418 | |13;stanford-crypto-sha256-iterative;69;68;65;67;65;66;67;68;65;68 07:08:47 INFO - PROCESS | 26418 | __end_tp_report 07:08:47 INFO - PROCESS | 26418 | __start_cc_report 07:08:47 INFO - PROCESS | 26418 | _x_x_mozilla_cycle_collect,1058 07:08:47 INFO - PROCESS | 26418 | __end_cc_report 07:08:47 INFO - PROCESS | 26418 | __startTimestamp1460642927971__endTimestamp 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | ------- Summary: start ------- 07:08:47 INFO - PROCESS | 26418 | Number of tests: 14 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.47 (3.2%) stddev-sans-first:3.67 07:08:47 INFO - PROCESS | 26418 | Values: 109.0 112.0 106.0 109.0 110.0 110.0 100.0 109.0 111.0 111.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:161.50 stddev:20.40 (12.6%) stddev-sans-first:21.63 07:08:47 INFO - PROCESS | 26418 | Values: 152.0 136.0 162.0 176.0 129.0 166.0 161.0 133.0 184.0 127.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#2] audio-dft Cycles:10 Average:160.90 Median:160.50 stddev:1.60 (1.0%) stddev-sans-first:1.66 07:08:47 INFO - PROCESS | 26418 | Values: 160.0 161.0 161.0 160.0 160.0 160.0 160.0 165.0 162.0 160.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.50 stddev:38.28 (50.7%) stddev-sans-first:39.99 07:08:47 INFO - PROCESS | 26418 | Values: 75.0 76.0 76.0 167.0 78.0 75.0 75.0 74.0 166.0 77.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.00 stddev:26.18 (28.1%) stddev-sans-first:27.03 07:08:47 INFO - PROCESS | 26418 | Values: 92.0 93.0 152.0 93.0 93.0 94.0 135.0 93.0 93.0 152.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 07:08:47 INFO - PROCESS | 26418 | Values: 116.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 116.0 118.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:08:47 INFO - PROCESS | 26418 | Values: 146.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 146.0 146.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:08:47 INFO - PROCESS | 26418 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.27 (6.0%) stddev-sans-first:3.47 07:08:47 INFO - PROCESS | 26418 | Values: 55.0 55.0 57.0 55.0 55.0 54.0 55.0 64.0 53.0 52.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 07:08:47 INFO - PROCESS | 26418 | Values: 64.0 67.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:2.54 (3.2%) stddev-sans-first:2.65 07:08:47 INFO - PROCESS | 26418 | Values: 78.0 79.0 86.0 78.0 78.0 80.0 80.0 77.0 79.0 78.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#11] stanford-crypto-ccm Cycles:10 Average:113.60 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:3.97 07:08:47 INFO - PROCESS | 26418 | Values: 113.0 111.0 120.0 119.0 113.0 111.0 117.0 112.0 111.0 109.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:145.00 stddev:6.28 (4.3%) stddev-sans-first:5.49 07:08:47 INFO - PROCESS | 26418 | Values: 154.0 144.0 138.0 143.0 135.0 137.0 148.0 146.0 152.0 142.0 07:08:47 INFO - PROCESS | 26418 | 07:08:47 INFO - PROCESS | 26418 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.48 (2.2%) stddev-sans-first:1.33 07:08:47 INFO - PROCESS | 26418 | Values: 69.0 68.0 65.0 67.0 65.0 66.0 67.0 68.0 65.0 68.0 07:08:47 INFO - PROCESS | 26418 | -------- Summary: end -------- 07:08:47 INFO - PROCESS | 26418 | 07:08:48 INFO - TEST-INFO | 26418: exit 0 07:08:48 INFO - TEST-OK | kraken | took 60441ms 07:08:48 INFO - SUITE-END | took 1172s 07:08:49 INFO - Completed test suite (00:19:32) 07:08:49 INFO - javascript benchmark 07:08:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3263.8041717496953, 3333.1833700743323, 3349.8660053597855, 3355.278615097755, 3388.2037721135534, 5370.409254981953, 5384.892302153955, 5404.378496472907, 5422.078246698065, 5434.266374039504, 5397.190421436787, 5418.241446197536, 5431.755570999305, 5437.619366644337, 5442.809501667442, 4799.592034677056, 4919.680220785655, 4981.676191047589, 4995.550400463958, 5032.7735251913755, 4832.951670483303, 4851.611871050325, 4892.192788189945, 4929.580985616227, 4931.408231012284, 4920.7785649645675, 4969.950300497003, 4985.800567977277, 5028.572571331441, 5035.144025515671, 4948.653594248404, 4996.800127994876, 5011.123053465629, 5017.8243761468175, 5032.5470707636305, 4840.1771698810935, 4870.0746858096845, 4913.656044076916, 4958.0, 4962.255661650745, 5224.190250511177, 5232.947670523284, 5249.895002099936, 5254.579633629301, 5275.86810329741, 5724.5992780505385, 5726.141078838166, 5746.885062298772, 5751.798687045934, 5755.654660720328, 5658.971705141489, 5684.516816070639, 5740.913886291709, 5768.307803063659, 5783.363829978699, 5315.229291752674, 5315.3090098286975, 5318.867028324285, 5322.600804939606, 5330.253764472977, 5710.828675139753, 5755.510781583613, 5767.134929760569, 5774.422557744192, 5834.27071616048, 5669.348024977098, 5733.8566535836935, 5735.483806457439, 5768.74040668171, 5769.538436925036, 5732.570057245724, 5753.194552762617, 5754.798582049608, 5758.193852860602, 5758.568107391962, 5600.467955544217, 5643.774249030075, 5656.406077361818, 5674.744636491368, 5675.772969081273, 5678.4605462480995, 5719.7140142992685, 5723.885522289531, 5726.169705392778, 5752.9712351437975, 4272.060146767706, 4301.989032577342, 4310.784460776948, 4311.935320970188, 4337.891552711208, 3858.2476417098956, 3893.0, 3903.6291552302487, 3939.2909276330533, 3998.0, 5482.972585137049, 5497.257870187474, 5497.340319161726, 5499.395066542677, 5514.448555144453, 5803.303603567599, 5819.563532735062, 5820.73806678692, 5826.970865145732, 5832.241808564944, 5394.649347792381, 5466.726663666801, 5496.532794712414, 5534.335879694462, 5541.889162216733, 4932.235503496964, 4972.552470277692, 4976.651634385558, 4979.676321039121, 5024.849254522297, 5938.257717785277, 5967.254093238345, 5972.581919265696, 5973.432523910222, 5977.193078934375, 5634.4365563443325, 5797.2173756542325, 5856.297244330707, 5864.44287792659, 5872.588918775645, 5973.074173503114, 5978.850528736816, 5983.0, 5987.0, 5992.161097446448, 5550.4449555044175, 5711.343195532567, 5715.771369145187, 5721.656700597978, 5729.742161602655, 5784.21913041734, 5846.0, 5852.385499522659, 5855.824325270249, 5885.882282354414, 5629.634073785191, 5671.120976248688, 5672.7163641816915, 5676.602637815313, 5679.119736440858, 5385.8114965976, 5567.24842146305, 5647.887042259214, 5660.179274005329, 5661.405552416937, 5549.112142057252, 5557.5553955682635, 5561.110222364402, 5567.777288908398, 5600.0479918414785, 5656.604037717485, 5683.602147849776, 5685.260916081049, 5693.345265294544, 5693.402192769865, 5380.757865895966, 5529.723513824373, 5583.162525621027, 5617.073182924772, 5617.578681598979], "unit": "score", "name": "dojo.html", "value": 5323.585418544775}, {"lowerIsBetter": false, "replicates": [508.23003150227413, 563.4478211352873, 583.1806312131457, 594.8423667728052, 625.971831267593, 31865.840670796642, 32646.0, 39546.40680389797, 40126.79936600313, 40241.0, 42233.788831055805, 42700.0, 42902.0, 42967.78516107423, 43024.3546346805, 8050.5974701264995, 8859.82280354391, 9066.637334506611, 9068.77328066797, 9074.047225041375, 10632.946835265813, 10929.836052459219, 10932.0, 10934.289271197387, 10938.835917461205, 10661.360318380883, 10699.197560182978, 10747.032767050963, 10764.78470430591, 10772.73068173298, 10576.947115264451, 10680.78638427235, 10682.893171068345, 10689.198310126732, 10696.572137114545, 10434.269601127924, 10588.735281617945, 10591.523381447852, 10601.257911946166, 10607.045365917027, 42387.15225695469, 42599.78700106511, 42830.57169428297, 42998.0, 43017.78491107524, 3539.0444579963264, 3638.945415818765, 3658.8902332930056, 4069.369247766601, 4424.225760491933, 33134.6686533134, 33424.83287583571, 33426.83286583576, 34284.0, 35744.821275893715, 4217.7891105444605, 4259.871134149453, 4288.9785551072355, 4294.202826184657, 4343.283358245885, 286752.0, 287420.0, 287865.0, 288041.0, 288361.67457488156, 47393.0, 47667.0, 47692.284615730794, 68504.6574767123, 69056.309436906, 45252.77373613177, 45630.77184614056, 45726.314105288446, 45835.77082114568, 45865.312020319725, 14563.563093107225, 14706.852931470548, 14774.409023638935, 14781.556553303419, 14814.92592537052, 10624.256302058782, 10858.077063449537, 11621.07031437483, 11816.940915295369, 11894.524219031142, 15231.086134831945, 15258.771118433233, 15329.540113796604, 15362.078275303295, 15474.84525154734, 5929.399062253167, 6100.206973093558, 6160.568760186834, 6329.968350158219, 6352.333005034498, 1023.0587859169582, 1034.3121823986965, 1082.3830416662584, 1088.3919805843761, 1157.976840463186, 29709.85145074304, 29867.850660746557, 30088.0, 30643.233919151753, 31114.0, 1129.745807193375, 1133.2124173699365, 1153.9056612248742, 1175.2419689300352, 1199.9460024298928, 16076.633486153574, 16197.109158996132, 16202.918985404998, 16393.59016024585, 16516.256768445448, 354411.0, 356586.0, 356624.0, 356680.0, 357839.0, 58788.412115879146, 58919.70540147358, 59507.0, 59581.702091489264, 59623.0, 1344.1061693973593, 1360.2314692199075, 1377.807107005, 1413.3781136299995, 1470.477980316972, 28178.039055209865, 28263.15210543687, 28508.287292817844, 30192.0, 30894.69105308918, 47127.52872471231, 47260.0, 47658.52341476541, 47667.0, 47706.52293477021, 203714.0, 205180.0, 206058.0, 206320.0, 206418.0, 30748.385032299677, 34434.0, 35074.82462587773, 35210.64789352176, 35211.82394088116, 41655.7917210412, 42134.0, 43021.784891075346, 43354.56645433505, 45079.32381014222, 38879.0, 38965.80517097397, 39626.42428242155, 39671.40492892551, 40129.598704012584, 37198.44202337021, 37818.62181378151, 38937.805310973265, 39254.0, 39524.802375987936, 38261.617383825804, 38817.22365552617, 39209.0, 39598.60401395949, 39788.403173953, 33746.83126584352, 34555.0, 34988.47517287294, 35030.64969350274, 35290.82354588211, 26231.475370492866, 26738.866305668347, 26823.865880670473, 26867.86566067157, 27177.0], "unit": "score", "name": "ext.html", "value": 19073.196886386624}, {"lowerIsBetter": false, "replicates": [367.5662717992769, 373.50510573490124, 383.03093174269094, 386.5438782236961, 391.0653538044073, 18055.277788888445, 18956.810431895676, 19600.509987250327, 19738.60522789547, 19755.111020004082, 17512.12439378029, 17695.73456398155, 18135.274589016422, 18191.636167276647, 18215.362462313788, 5595.328560572727, 5674.801381951633, 5676.971615141939, 5710.914336284938, 5716.1711551824965, 4246.745195288293, 5978.581499295051, 6221.59559628625, 6222.719977601018, 6226.657533835637, 6128.877422451548, 6221.595596286227, 6223.284322302925, 6250.4062114099315, 6259.405356491126, 6004.759809607611, 6079.848003799896, 6137.110119032715, 6142.907856382158, 6157.6305421674615, 3861.44009118679, 5268.31511903454, 5483.396826349099, 5484.040292948718, 5488.121900495901, 21862.211282663255, 22013.339599812032, 22150.55698886013, 22580.43548911274, 22762.317130486113, 2411.602085655865, 2445.6209287560455, 2546.261584140597, 2738.6165936768866, 2878.668953070403, 13674.521391751341, 13806.240656763874, 14078.85921140796, 14180.0, 14414.207218602973, 1798.154867212421, 1853.7497437845852, 1888.8205620466033, 1890.5651700108915, 1917.166032775747, 64529.0, 65870.0, 66283.33716662868, 66383.66808165929, 66406.99999999952, 9237.353385262966, 9483.099105584959, 9593.0, 9883.703488895344, 9925.751856203653, 13069.803952940714, 13175.60473185806, 13180.538681146305, 13315.733685326433, 13633.590992270249, 7328.706851725871, 7501.062367204099, 7525.172231054579, 7592.658330375147, 7592.8481430371085, 7247.673854676552, 7298.70805167798, 7355.632218389059, 7364.521306115085, 7368.263173682589, 6073.119397687311, 6076.0, 6077.6353418795015, 6120.540959428061, 6176.320604733476, 1719.5701074731317, 1770.513108895064, 1821.3898344054626, 1839.667582842387, 1852.9655899120703, 450.33350641051425, 450.73181457033013, 453.9432570928634, 466.2772702311404, 1040.5369610523244, 11250.718732031764, 11461.71345716347, 11465.942670286595, 11570.421478926188, 11647.53409863613, 467.68898682376516, 473.5453964194412, 475.7026858213616, 477.5105516845192, 490.9018196360742, 6142.293636231801, 6309.842253943688, 6328.240611126695, 6340.175777149033, 6427.58220715652, 448550.0, 457499.0, 465016.0, 470969.0, 473818.0, 82157.58921205475, 83649.58175209085, 83859.58070209732, 84025.57987210147, 84359.15640843636, 499.41568365013023, 501.47846239910814, 502.703404991057, 504.3619820926531, 505.020260694252, 10497.632582859564, 10705.9464702676, 10782.406967616856, 10862.565497380016, 10904.945475272572, 34270.657293426746, 34813.303733925684, 34851.30297393987, 35510.46734299039, 35707.642923570435, 51709.22436163385, 52039.47960520498, 52216.21675674792, 52274.73862630662, 52911.470885290655, 8400.117987611457, 8481.109483504144, 8625.87061194095, 8694.565271736261, 8717.389782715149, 8833.0, 12276.877231227574, 12881.162724422882, 12940.547080852126, 13194.274314912387, 11036.944815276194, 11314.0, 11410.087193024372, 11587.536498539965, 11613.187076904536, 11055.115590752881, 11176.88823111791, 11202.49588768491, 11274.154438416988, 11460.369679667698, 11344.20590558686, 11459.656210313704, 11499.310041397543, 11528.0, 11861.22902011401, 8155.959220203861, 8257.504549727035, 8287.337013039063, 8352.290055345364, 8379.203975622306, 10720.678379648623, 11405.942970285096, 11430.314181149157, 11493.712657183638, 11543.942280288546], "unit": "score", "name": "jquery.html", "value": 8174.859381999844}, {"lowerIsBetter": false, "replicates": [1433.2761955212616, 1559.3061087815922, 1580.1546172797548, 1799.1454059321825, 1926.5665225324303, 8336.124706905772, 8547.97424309083, 8571.057183709787, 8573.485590864553, 8575.957120214405, 8519.1906768857, 8675.349348798834, 8676.566171691422, 8680.869786953184, 8684.2618377438, 2049.4876280929766, 2084.843636727244, 2344.1443872986324, 2406.4585468269674, 2456.754324567547, 2437.524682686877, 2444.303373538542, 2445.0342114864616, 2445.7187423446353, 2446.7308596054418, 2320.4894923116885, 2333.7782910623464, 2364.6925899633025, 2365.95268094638, 2373.4422410733464, 2392.6530653055297, 2416.4079800448912, 2425.2724182745196, 2447.119037146626, 2447.6940382452194, 2416.0, 2434.1480481831395, 2452.1785201957364, 2457.127719659531, 2462.6182941644074, 8478.703245386443, 8523.914760852374, 8525.957370213171, 8528.189821966904, 8536.27441667459, 5035.169197082477, 5139.511746384088, 5157.0, 5158.071547121516, 5159.1229490986625, 3063.89276375328, 3073.6465306489818, 3107.409592177479, 3216.292415668549, 3216.372807302577, 972.9416235025922, 997.5710444508858, 1000.6147633161213, 1056.4295280548495, 1057.4924036462542, 12387.19483233596, 12429.0, 12430.813537796941, 12435.44040518179, 12444.253344799341, 4435.534268901783, 4465.933011004838, 4510.887227819265, 4583.816647334069, 4606.193916064675, 10414.531346089445, 10418.06237438619, 10429.739256518496, 10474.214433917334, 10476.47617619116, 5121.359830021247, 5127.743612819344, 5173.793048278102, 5177.767000484987, 5179.300794392709, 3942.802859857053, 4463.8214471421425, 4602.240630296031, 4619.6073333766335, 4622.0, 3865.072382628205, 3955.6637685796454, 3971.225611005884, 3974.105826189142, 4015.5382131054716, 1235.975280494403, 1241.596481143632, 1245.3212998915612, 1248.2323371126693, 1258.0124602187238, 1418.4326269492285, 1427.3291552970088, 1439.5105664074056, 1452.2230606625405, 1469.0377802539354, 8392.0, 8430.957845210734, 8446.324294056583, 8463.49219046859, 8468.40721149526, 504.64674727690766, 507.33792400917156, 507.801957236678, 514.1516497778695, 518.4582111693289, 6355.142055822497, 6357.7139028742895, 6384.0, 6424.775132870327, 6438.903416448757, 10430.269881108401, 10838.729031774268, 10873.456327183609, 11027.503762330714, 11041.613543525938, 10432.947835260775, 10627.89372106269, 10753.83869241962, 10796.190285728602, 10809.513571889283, 8324.83350333002, 8333.66665333392, 8379.539125348165, 8429.789255268668, 8434.493930364199, 7997.880031799644, 8065.637046332812, 8078.071021832329, 8085.191480851868, 8087.0295564532635, 9436.339456238273, 9504.19214366759, 9506.144446999802, 9645.180159686224, 9715.465649389069, 9415.15263626277, 9734.659286924923, 9952.601895924372, 10094.697159085239, 10163.085322321027, 6522.15212022453, 7321.890171647323, 7650.4644674872225, 7926.0, 8004.039515258206, 8298.128696487023, 8316.750497485085, 8326.50040997542, 8367.874481882654, 8370.204830541088, 7395.926040739739, 7506.887396688945, 7556.1310449299035, 7591.544507329578, 7642.121156066901, 7341.045664063851, 7398.778036658909, 7408.259174082764, 7504.887426688495, 7522.172561018393, 7933.286004259644, 7961.084475285184, 7978.4016198786485, 7991.800204994922, 7999.0, 7195.676194571152, 7234.6744396501235, 7257.600831954293, 7295.7081716732855, 7312.1591017033725, 7338.743143989935, 7349.375303099297, 7393.1497877742595, 7395.149557800706, 7398.889016664647], "unit": "score", "name": "mootools.html", "value": 4818.291516991522}, {"lowerIsBetter": false, "replicates": [357.6066327040256, 358.46767550187985, 359.3531643042523, 360.52950899076706, 367.7664682926341, 6013.759449622021, 6059.757609695607, 6065.69671516424, 6073.331933487313, 6125.387461253884, 6015.21802165719, 6023.789167379143, 6024.578279520435, 6029.849253768658, 6033.969830150854, 4463.33050042493, 4560.5667461591265, 4657.51096134906, 4680.812767489297, 4708.976455117737, 4677.13473007493, 4679.134360143385, 4683.250679891218, 4707.576318131368, 4713.575778179963, 4644.094401591691, 4649.953500464986, 4652.604528615055, 4657.138429390574, 4663.440387153546, 4431.756253406077, 4545.204589196894, 4649.721016739007, 4658.743769092698, 4663.2305669564485, 4065.390191471303, 4074.9592504074876, 4078.163976384834, 4100.097978444737, 4111.424400583921, 5749.0801471764735, 5753.223314852483, 5754.971225143848, 5755.68343741094, 5766.423357664242, 5386.946130538684, 5395.406505284415, 5397.865053373697, 5401.216823560601, 5401.891962160735, 6357.968210158966, 6364.077208804697, 6366.618002919793, 6378.649174295459, 6379.904301435482, 4331.285337919239, 4431.734095954221, 4444.266695995157, 4450.0, 4549.454065512126, 6577.539572229945, 6637.767678131242, 6645.700943457556, 6665.133532640774, 6672.2660507344635, 4468.821247150077, 4492.887677808081, 4495.2358099122575, 4501.549845015537, 4508.797104130322, 4551.7724113794175, 4559.407277054028, 4562.520935301812, 4563.315502674625, 4567.086582683477, 5274.5780337572905, 5288.81489147878, 5291.126964050965, 5291.603129765283, 5298.337707786527, 6253.6873156342, 6391.1371964785085, 6422.935770642327, 6443.871122577522, 6444.065610486453, 1603.5830684022237, 1611.0816834404277, 1613.2659639864069, 1615.2166199393284, 1621.9026858388534, 974.6637410093506, 1076.160594736107, 1083.268793564341, 1127.6842484104463, 1174.7121955120879, 6184.350643182491, 6214.440700336901, 6215.782447614311, 6225.968870155621, 6226.066090086523, 6608.504362172856, 6608.669566521655, 6620.073189753439, 6621.4040736333, 6622.768203112868, 6201.534884883652, 6203.286622038523, 6203.410675985774, 6208.379162083846, 6216.160818289563, 3541.061618671054, 3574.8391322390553, 3577.94633080504, 3580.7672501287334, 3581.3374525712825, 6685.030670552743, 6810.557313774589, 6902.068220790229, 6906.0, 6917.792466226021, 6819.761308354184, 6855.6572171391235, 6856.211535673362, 6885.380315771505, 6900.689468973908, 6907.896381554281, 6930.549514281656, 6932.930670693228, 6938.826529336807, 6943.791686249521, 6734.02356658272, 6737.225219099866, 6739.629320387426, 6744.393004629607, 6754.763583274562, 6437.324080971618, 6572.934270657423, 6580.144581204604, 6586.736530538725, 6604.438622717123, 6867.862642747217, 6905.620190889549, 6905.75829845953, 6909.861802763816, 6914.9308506914285, 4610.308453731833, 4644.442666879996, 4645.07098580292, 4650.767461626838, 4654.4414670239785, 6691.130153080068, 6702.899456508058, 6703.66481675924, 6703.698333574904, 6707.396334329934, 6312.257523330129, 6480.675966201577, 6483.384078512534, 6499.610023398611, 6502.772402965874, 6439.003908788291, 6493.058506516623, 6496.415322620986, 6503.772367967098, 6504.089427480251, 6347.873042539031, 6350.079238510298, 6353.4599559038, 6360.459360954371, 6361.0, 6527.51043671736, 6530.955047192427, 6531.608103513804, 6543.934560654523, 6549.181352330958, 5916.49709774674, 6110.0, 6210.844728881814, 6369.33122022181, 6380.138681278154], "unit": "score", "name": "prototype.html", "value": 4863.566961157397}, {"lowerIsBetter": false, "replicates": [802.3701394405392, 814.6904176412962, 829.4318391901547, 832.3798769916409, 879.050625324649, 14836.480723174678, 14980.0, 15000.774988375184, 15023.098614083163, 15048.84951150488, 14038.227897465635, 14042.157470551774, 14094.718105637881, 14127.92936035321, 14203.147811131339, 779.4855395439012, 910.544727636182, 924.3529529329462, 925.3984909808611, 926.1109335038371, 920.8388532006873, 942.9387089839173, 945.9763505912339, 948.6869333120088, 948.8149810786899, 993.135971704618, 996.4021587047749, 999.6950929966357, 999.7450650084219, 1000.3097862474906, 819.0499021135454, 956.6747305915952, 987.9753006174831, 988.9456079915566, 989.0307498651326, 739.4601940583404, 739.7410906182847, 740.3854800515559, 740.4335683202354, 740.5297636001125, 14256.073355231876, 14271.357788899524, 14290.428382864673, 14300.213488258141, 14318.069325493914, 13327.933360333232, 14119.364628591738, 14164.858351416457, 14349.354279057468, 14378.784318235235, 10407.167426605853, 10488.31825931312, 10537.0, 10824.891751082547, 11237.101031917427, 3921.941170882439, 3937.547182074041, 3970.4441378207075, 3984.163325701606, 4010.218007488541, 52600.0, 53360.46639533594, 54266.72866635681, 54551.45448545503, 55072.44927550713, 10771.353718776898, 10782.0, 10875.673729788119, 10990.0, 11213.66359009231, 20938.162473501194, 20938.37184884456, 20948.266810661553, 20954.47613809667, 20972.47568810792, 7864.724734634375, 7965.283124518821, 7965.6017199139815, 8075.152109028468, 8076.434649574591, 4333.1766964276685, 4372.759498227628, 4441.977790111029, 4522.88692782683, 4534.229181039232, 3325.185329594265, 3331.1838599542784, 3342.899713008565, 3348.0, 3348.8325583720716, 596.9492593129632, 603.7524614907867, 609.2901769438555, 617.0651463033507, 619.2878190081352, 610.3591229209312, 637.9537558404221, 658.5686375424104, 684.1789852177407, 697.2156324135348, 8601.741947741577, 8830.375616743604, 8966.86549701755, 9094.136057074567, 9245.445273283625, 559.9692016939026, 593.9495142912814, 619.362057081198, 634.8603307272392, 683.3235097253782, 3935.74417662851, 4002.8198731057173, 4042.5351084625645, 4070.1859628074503, 4157.168566286755, 58744.11883821746, 60614.696926515964, 60741.39258607446, 60764.69617651883, 60887.0, 52542.949141016965, 52543.474565254626, 53314.73342633262, 54808.72595636996, 55117.0, 47763.805904851964, 48415.51584484181, 48771.5122848767, 49204.75397622989, 49741.751291243316, 7987.16134805837, 8090.15053419406, 8122.147174546588, 8257.545834979133, 8281.337493000425, 36171.457428139125, 37110.8144459276, 37298.44052339271, 37512.0, 38183.618163818006, 41859.372109417774, 41950.58049419467, 43554.78222608867, 45591.31613025741, 46381.53618463907, 10007.899921000697, 10066.0, 10153.05334190527, 10221.693349199535, 10230.76923076923, 11242.66272011841, 11350.772984540428, 11413.771724565628, 11549.711257218636, 11693.298402095561, 10086.79826403453, 10575.841362379724, 10602.89397106019, 10671.413072281099, 10674.252802304074, 10227.94886025565, 10235.795284094127, 10506.317089389166, 10523.0, 10619.575216991543, 9748.707538773564, 10080.747981300232, 10119.7470063249, 10132.74668133273, 10292.330998485075, 9123.817523649623, 9126.954365228132, 9157.633694652139, 9220.492872892055, 9221.077892210726, 8715.869261961203, 8887.955560222157, 9130.95434522823, 9140.817183656423, 9193.908060919306], "unit": "score", "name": "yui.html", "value": 6562.8115636392595}], "name": "dromaeo_css", "value": 7096.00035292581}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 106.0, 109.0, 110.0, 110.0, 100.0, 109.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [152.0, 136.0, 162.0, 176.0, 129.0, 166.0, 161.0, 133.0, 184.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 152.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 165.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 76.0, 167.0, 78.0, 75.0, 75.0, 74.0, 166.0, 77.0], "unit": "score", "name": "audio-fft", "value": 93.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 152.0, 93.0, 93.0, 94.0, 135.0, 93.0, 93.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 57.0, 55.0, 55.0, 54.0, 55.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 86.0, 78.0, 78.0, 80.0, 80.0, 77.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [113.0, 111.0, 120.0, 119.0, 113.0, 111.0, 117.0, 112.0, 111.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.6}, {"lowerIsBetter": true, "replicates": [154.0, 144.0, 138.0, 143.0, 135.0, 137.0, 148.0, 146.0, 152.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 65.0, 67.0, 65.0, 66.0, 67.0, 68.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1507.0}]} 07:08:49 INFO - Return code: 0 07:08:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:08:49 INFO - # TBPL SUCCESS # 07:08:49 INFO - Running post-action listener: _resource_record_post_action 07:08:49 INFO - Running post-run listener: _resource_record_post_run 07:08:50 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 495050752; Read time: 16; Write time: 592920 07:08:50 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 244989952; Read time: 0; Write time: 401364 07:08:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250060800; Read time: 16; Write time: 191556 07:08:50 INFO - Running post-run listener: _upload_blobber_files 07:08:50 INFO - Blob upload gear active. 07:08:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:08:50 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 07:08:50 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'] 07:08:50 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 07:08:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:08:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:08:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:08:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:51 INFO - (blobuploader) - INFO - Done attempting. 07:08:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:08:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:08:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:52 INFO - (blobuploader) - INFO - Done attempting. 07:08:52 INFO - (blobuploader) - INFO - Iteration through files over. 07:08:52 INFO - Return code: 0 07:08:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:08:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:08:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cc269eafc6230fd1ceec0c5d3c3da1077b50391196ea3d34432b309891b60054bc548924ab876c40b72999ab7ca362bbe22fe18ffee559cd34f2a5f9f7bdd11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b7f5d959ad0a6faa211de658da3390b46f8d84c6db2b444df626f3ebdae55f1a9f1dc654511d78d12e3943182358ce3e0c6297a776a9d70eef22c547254967f"} 07:08:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:08:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:08:52 INFO - Contents: 07:08:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cc269eafc6230fd1ceec0c5d3c3da1077b50391196ea3d34432b309891b60054bc548924ab876c40b72999ab7ca362bbe22fe18ffee559cd34f2a5f9f7bdd11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b7f5d959ad0a6faa211de658da3390b46f8d84c6db2b444df626f3ebdae55f1a9f1dc654511d78d12e3943182358ce3e0c6297a776a9d70eef22c547254967f"} 07:08:52 INFO - Running post-run listener: copy_logs_to_upload_dir 07:08:52 INFO - Copying logs to upload dir... 07:08:52 INFO - mkdir: /builds/slave/test/build/upload/logs 07:08:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.676824 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-14 07:08:51.713053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:08:51.716695) ========= 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=eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cc269eafc6230fd1ceec0c5d3c3da1077b50391196ea3d34432b309891b60054bc548924ab876c40b72999ab7ca362bbe22fe18ffee559cd34f2a5f9f7bdd11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b7f5d959ad0a6faa211de658da3390b46f8d84c6db2b444df626f3ebdae55f1a9f1dc654511d78d12e3943182358ce3e0c6297a776a9d70eef22c547254967f"} build_url:https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/YO73epPWQqm-0kMLflbKXQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cc269eafc6230fd1ceec0c5d3c3da1077b50391196ea3d34432b309891b60054bc548924ab876c40b72999ab7ca362bbe22fe18ffee559cd34f2a5f9f7bdd11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b7f5d959ad0a6faa211de658da3390b46f8d84c6db2b444df626f3ebdae55f1a9f1dc654511d78d12e3943182358ce3e0c6297a776a9d70eef22c547254967f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:08:51.741759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:08:51.742085) ========= 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=eca2ab57546de7b41f256b19000001ef-1460640669.694763-864964068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:08:51.826263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:08:51.826592) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:08:51.826901) ========= ========= Total master_lag: 0.16 =========