builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1461416053.87 results: success (0) buildid: 20160423030220 builduid: 2457a9127ed446a2b9165a59ccaf8d25 revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:13.883242) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:13.883876) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:13.884161) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:13.920276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:13.920631) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 05:54:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 56.2K=0.2s 2016-04-23 05:54:14 (56.2 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.369670 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.308506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.308859) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023042 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.358707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.359082) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --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=9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 05:54:14,893 truncating revision to first 12 chars 2016-04-23 05:54:14,893 Setting DEBUG logging. 2016-04-23 05:54:14,893 attempt 1/10 2016-04-23 05:54:14,893 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37f04460ddb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 05:54:15,143 unpacking tar archive at: mozilla-central-37f04460ddb7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.909330) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.909645) ========= script_repo_revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.910090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.910416) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 05:54:14.919986) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-23 05:54:14.920308) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:15 INFO - MultiFileLogger online at 20160423 05:54:15 in /builds/slave/test 05:54:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:54:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:15 INFO - {'append_to_log': False, 05:54:15 INFO - 'base_work_dir': '/builds/slave/test', 05:54:15 INFO - 'blob_upload_branch': 'Firefox', 05:54:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:15 INFO - 'branch': 'Firefox', 05:54:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:15 INFO - 'config_files': ('talos/linux_config.py',), 05:54:15 INFO - 'default_actions': ('clobber', 05:54:15 INFO - 'read-buildbot-config', 05:54:15 INFO - 'download-and-extract', 05:54:15 INFO - 'populate-webroot', 05:54:15 INFO - 'create-virtualenv', 05:54:15 INFO - 'install', 05:54:15 INFO - 'run-tests'), 05:54:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:15 INFO - 'download_minidump_stackwalk': True, 05:54:15 INFO - 'download_symbols': 'ondemand', 05:54:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:15 INFO - 'installer_path': 'installer.exe', 05:54:15 INFO - 'log_level': 'info', 05:54:15 INFO - 'log_name': 'talos', 05:54:15 INFO - 'log_to_console': True, 05:54:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:15 INFO - 'opt_config_files': (), 05:54:15 INFO - 'pip_index': False, 05:54:15 INFO - 'sps_profile': False, 05:54:15 INFO - 'sps_profile_interval': 0, 05:54:15 INFO - 'suite': 'dromaeojs-e10s', 05:54:15 INFO - 'system_bits': '32', 05:54:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:15 INFO - 'title': 'talos-linux64-ix-013', 05:54:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:15 INFO - 'use_talos_json': True, 05:54:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:15 INFO - 'work_dir': 'build'} 05:54:15 INFO - ##### 05:54:15 INFO - ##### Running clobber step. 05:54:15 INFO - ##### 05:54:15 INFO - Running pre-action listener: _resource_record_pre_action 05:54:15 INFO - Running main action method: clobber 05:54:15 INFO - rmtree: /builds/slave/test/build 05:54:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:16 INFO - Running post-action listener: _resource_record_post_action 05:54:16 INFO - ##### 05:54:16 INFO - ##### Running read-buildbot-config step. 05:54:16 INFO - ##### 05:54:16 INFO - Running pre-action listener: _resource_record_pre_action 05:54:16 INFO - Running main action method: read_buildbot_config 05:54:16 INFO - Using buildbot properties: 05:54:16 INFO - { 05:54:16 INFO - "project": "", 05:54:16 INFO - "product": "firefox", 05:54:16 INFO - "script_repo_revision": "production", 05:54:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:54:16 INFO - "repository": "", 05:54:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:54:16 INFO - "buildid": "20160423030220", 05:54:16 INFO - "stage_platform": "linux64-pgo", 05:54:16 INFO - "basedir": "/builds/slave/test", 05:54:16 INFO - "nightly_build": "True", 05:54:16 INFO - "buildnumber": 187, 05:54:16 INFO - "slavename": "talos-linux64-ix-013", 05:54:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:54:16 INFO - "platform": "ubuntu64_hw", 05:54:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:54:16 INFO - "branch": "mozilla-central", 05:54:16 INFO - "repo_path": "mozilla-central", 05:54:16 INFO - "revision": "37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776", 05:54:16 INFO - "pgo_build": "True", 05:54:16 INFO - "builduid": "2457a9127ed446a2b9165a59ccaf8d25", 05:54:16 INFO - "slavebuilddir": "test" 05:54:16 INFO - } 05:54:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:54:16 INFO - Running post-action listener: _resource_record_post_action 05:54:16 INFO - ##### 05:54:16 INFO - ##### Running download-and-extract step. 05:54:16 INFO - ##### 05:54:16 INFO - Running pre-action listener: _resource_record_pre_action 05:54:16 INFO - Running main action method: download_and_extract 05:54:16 INFO - mkdir: /builds/slave/test/build/tests 05:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:16 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:54:20 INFO - Downloaded 1361 bytes. 05:54:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:54:20 INFO - Using the following test package requirements: 05:54:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:54:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:20 INFO - u'jsshell-linux-x86_64.zip'], 05:54:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:54:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:54:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54: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')]} 05:54:20 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:21 INFO - Downloaded 23858027 bytes. 05:54:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:54:23 INFO - Return code: 0 05:54:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:54: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')]} 05:54:23 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:54:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:24 INFO - Downloaded 23858027 bytes. 05:54:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:54:26 INFO - Return code: 0 05:54: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')]} 05:54:26 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:26 INFO - Downloaded 10840145 bytes. 05:54:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:54:27 INFO - Return code: 0 05:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:27 INFO - https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:54:28 INFO - Downloaded 58376013 bytes. 05:54:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:28 INFO - mkdir: /builds/slave/test/properties 05:54:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:28 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:28 INFO - Contents: 05:54:28 INFO - build_url:https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:54:29 INFO - Running post-action listener: _resource_record_post_action 05:54:29 INFO - Running post-action listener: set_extra_try_arguments 05:54:29 INFO - ##### 05:54:29 INFO - ##### Running populate-webroot step. 05:54:29 INFO - ##### 05:54:29 INFO - Running pre-action listener: _resource_record_pre_action 05:54:29 INFO - Running main action method: populate_webroot 05:54:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:29 INFO - '--tppagecycles', 05:54:29 INFO - '7'], 05:54:29 INFO - 'tests': ['tsvgm']}}, 05:54:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:29 INFO - 'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:29 INFO - 'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['damp', 'tps']}, 05:54:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:29 INFO - 'tests': ['damp', 'tps']}, 05:54:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['dromaeo_dom']}, 05:54:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['a11yr', 05:54:29 INFO - 'ts_paint', 05:54:29 INFO - 'tpaint', 05:54:29 INFO - 'sessionrestore', 05:54:29 INFO - 'sessionrestore_no_auto_restore', 05:54:29 INFO - 'tabpaint']}, 05:54:29 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:29 INFO - 'ts_paint', 05:54:29 INFO - 'tpaint', 05:54:29 INFO - 'sessionrestore', 05:54:29 INFO - 'sessionrestore_no_auto_restore', 05:54:29 INFO - 'tabpaint']}, 05:54:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:29 INFO - 'ts_paint', 05:54:29 INFO - 'tpaint', 05:54:29 INFO - 'sessionrestore', 05:54:29 INFO - 'sessionrestore_no_auto_restore', 05:54:29 INFO - 'tabpaint']}, 05:54:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:29 INFO - 'ts_paint', 05:54:29 INFO - 'tpaint', 05:54:29 INFO - 'sessionrestore', 05:54:29 INFO - 'sessionrestore_no_auto_restore', 05:54:29 INFO - 'tabpaint']}, 05:54:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['a11yr', 05:54:29 INFO - 'ts_paint', 05:54:29 INFO - 'tpaint', 05:54:29 INFO - 'sessionrestore', 05:54:29 INFO - 'sessionrestore_no_auto_restore', 05:54:29 INFO - 'tabpaint']}, 05:54:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['a11yr', 05:54:29 INFO - 'ts_paint', 05:54:29 INFO - 'tpaint', 05:54:29 INFO - 'sessionrestore', 05:54:29 INFO - 'sessionrestore_no_auto_restore', 05:54:29 INFO - 'tabpaint']}, 05:54:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['tsvgx', 05:54:29 INFO - 'tsvgr_opacity', 05:54:29 INFO - 'tart', 05:54:29 INFO - 'tscrollx', 05:54:29 INFO - 'cart']}, 05:54:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:29 INFO - 'tsvgr_opacity', 05:54:29 INFO - 'tart', 05:54:29 INFO - 'tscrollx', 05:54:29 INFO - 'cart']}, 05:54:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:29 INFO - 'talos_options': ['--disable-e10s'], 05:54:29 INFO - 'tests': ['tp5o']}, 05:54:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:29 INFO - 'tests': ['tp5o']}, 05:54:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:29 INFO - 'talos_options': ['--disable-e10s', 05:54:29 INFO - '--xperf_path', 05:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:29 INFO - 'tests': ['tp5n']}, 05:54:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:29 INFO - 'talos_options': ['--xperf_path', 05:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:29 INFO - 'tests': ['tp5n']}}, 05:54:29 INFO - 'talos.zip': {'path': '', 05:54:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:29 INFO - Running post-action listener: _resource_record_post_action 05:54:29 INFO - ##### 05:54:29 INFO - ##### Running create-virtualenv step. 05:54:29 INFO - ##### 05:54:29 INFO - Running pre-action listener: _resource_record_pre_action 05:54:29 INFO - Running main action method: create_virtualenv 05:54:29 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:54:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:29 INFO - Using real prefix '/usr' 05:54:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:31 INFO - Installing pip.................done. 05:54:31 INFO - Return code: 0 05:54:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c21daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', '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 05:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:54:31 INFO - Using env: {'DISPLAY': ':0', 05:54:31 INFO - 'HOME': '/home/cltbld', 05:54:31 INFO - 'LANG': 'en_US.UTF-8', 05:54:31 INFO - 'LANGUAGE': 'en_US:en', 05:54:31 INFO - 'LOGNAME': 'cltbld', 05:54:31 INFO - 'MAIL': '/var/mail/cltbld', 05:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:31 INFO - 'MOZ_NO_REMOTE': '1', 05:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:31 INFO - 'NO_EM_RESTART': '1', 05:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:31 INFO - 'PWD': '/builds/slave/test', 05:54:31 INFO - 'SHELL': '/bin/bash', 05:54:31 INFO - 'SHLVL': '1', 05:54:31 INFO - 'TERM': 'linux', 05:54:31 INFO - 'TMOUT': '86400', 05:54:31 INFO - 'USER': 'cltbld', 05:54:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:31 INFO - '_': '/tools/buildbot/bin/python'} 05:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:54:32 INFO - Cleaning up... 05:54:32 INFO - Return code: 0 05:54:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c21daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', '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 05:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:54:32 INFO - Using env: {'DISPLAY': ':0', 05:54:32 INFO - 'HOME': '/home/cltbld', 05:54:32 INFO - 'LANG': 'en_US.UTF-8', 05:54:32 INFO - 'LANGUAGE': 'en_US:en', 05:54:32 INFO - 'LOGNAME': 'cltbld', 05:54:32 INFO - 'MAIL': '/var/mail/cltbld', 05:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:32 INFO - 'MOZ_NO_REMOTE': '1', 05:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:32 INFO - 'NO_EM_RESTART': '1', 05:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:32 INFO - 'PWD': '/builds/slave/test', 05:54:32 INFO - 'SHELL': '/bin/bash', 05:54:32 INFO - 'SHLVL': '1', 05:54:32 INFO - 'TERM': 'linux', 05:54:32 INFO - 'TMOUT': '86400', 05:54:32 INFO - 'USER': 'cltbld', 05:54:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:32 INFO - '_': '/tools/buildbot/bin/python'} 05:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:32 INFO - Downloading/unpacking psutil>=0.7.1 05:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:34 INFO - Installing collected packages: psutil 05:54:34 INFO - Running setup.py install for psutil 05:54:34 INFO - building 'psutil._psutil_linux' extension 05:54:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:54:34 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 05:54:34 INFO - building 'psutil._psutil_posix' extension 05:54:34 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 05:54:34 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 05:54:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:34 INFO - Successfully installed psutil 05:54:34 INFO - Cleaning up... 05:54:34 INFO - Return code: 0 05:54:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd1c21daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', '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 05:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:54:34 INFO - Using env: {'DISPLAY': ':0', 05:54:34 INFO - 'HOME': '/home/cltbld', 05:54:34 INFO - 'LANG': 'en_US.UTF-8', 05:54:34 INFO - 'LANGUAGE': 'en_US:en', 05:54:34 INFO - 'LOGNAME': 'cltbld', 05:54:34 INFO - 'MAIL': '/var/mail/cltbld', 05:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:34 INFO - 'MOZ_NO_REMOTE': '1', 05:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:34 INFO - 'NO_EM_RESTART': '1', 05:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:34 INFO - 'PWD': '/builds/slave/test', 05:54:34 INFO - 'SHELL': '/bin/bash', 05:54:34 INFO - 'SHLVL': '1', 05:54:34 INFO - 'TERM': 'linux', 05:54:34 INFO - 'TMOUT': '86400', 05:54:34 INFO - 'USER': 'cltbld', 05:54:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:34 INFO - '_': '/tools/buildbot/bin/python'} 05:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:54:37 INFO - Installing collected packages: mozsystemmonitor 05:54:37 INFO - Running setup.py install for mozsystemmonitor 05:54:37 INFO - Successfully installed mozsystemmonitor 05:54:37 INFO - Cleaning up... 05:54:37 INFO - Return code: 0 05:54:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c21daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', '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 05:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:54:37 INFO - Using env: {'DISPLAY': ':0', 05:54:37 INFO - 'HOME': '/home/cltbld', 05:54:37 INFO - 'LANG': 'en_US.UTF-8', 05:54:37 INFO - 'LANGUAGE': 'en_US:en', 05:54:37 INFO - 'LOGNAME': 'cltbld', 05:54:37 INFO - 'MAIL': '/var/mail/cltbld', 05:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:37 INFO - 'MOZ_NO_REMOTE': '1', 05:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:37 INFO - 'NO_EM_RESTART': '1', 05:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:37 INFO - 'PWD': '/builds/slave/test', 05:54:37 INFO - 'SHELL': '/bin/bash', 05:54:37 INFO - 'SHLVL': '1', 05:54:37 INFO - 'TERM': 'linux', 05:54:37 INFO - 'TMOUT': '86400', 05:54:37 INFO - 'USER': 'cltbld', 05:54:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:37 INFO - '_': '/tools/buildbot/bin/python'} 05:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:37 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:39 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:39 INFO - Downloading docopt-0.6.1.tar.gz 05:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:40 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:40 INFO - Running setup.py install for blobuploader 05:54:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:40 INFO - Running setup.py install for requests 05:54:40 INFO - Running setup.py install for docopt 05:54:40 INFO - Successfully installed blobuploader requests docopt 05:54:40 INFO - Cleaning up... 05:54:40 INFO - Return code: 0 05:54:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:40 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')]} 05:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:40 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')]} 05:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:40 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 0x7fd1c21daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', '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 05:54:40 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 05:54:40 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 05:54:40 INFO - Using env: {'DISPLAY': ':0', 05:54:40 INFO - 'HOME': '/home/cltbld', 05:54:40 INFO - 'LANG': 'en_US.UTF-8', 05:54:40 INFO - 'LANGUAGE': 'en_US:en', 05:54:40 INFO - 'LOGNAME': 'cltbld', 05:54:40 INFO - 'MAIL': '/var/mail/cltbld', 05:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:40 INFO - 'MOZ_NO_REMOTE': '1', 05:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:40 INFO - 'NO_EM_RESTART': '1', 05:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:40 INFO - 'PWD': '/builds/slave/test', 05:54:40 INFO - 'SHELL': '/bin/bash', 05:54:40 INFO - 'SHLVL': '1', 05:54:40 INFO - 'TERM': 'linux', 05:54:40 INFO - 'TMOUT': '86400', 05:54:40 INFO - 'USER': 'cltbld', 05:54:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:40 INFO - '_': '/tools/buildbot/bin/python'} 05:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:40 INFO - Running setup.py (path:/tmp/pip-5CT0tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:40 INFO - Running setup.py (path:/tmp/pip-JKZArO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:41 INFO - Running setup.py (path:/tmp/pip-c_7eY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:41 INFO - Running setup.py (path:/tmp/pip-s25ce1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:41 INFO - Running setup.py (path:/tmp/pip-6994w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:41 INFO - Running setup.py (path:/tmp/pip-jCFKML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:41 INFO - Running setup.py (path:/tmp/pip-MLN9st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:41 INFO - Running setup.py (path:/tmp/pip-v0fhLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:41 INFO - Running setup.py (path:/tmp/pip-_Pmgst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:41 INFO - Running setup.py (path:/tmp/pip-Rffjln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:41 INFO - Running setup.py (path:/tmp/pip-VMOmnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:41 INFO - Running setup.py (path:/tmp/pip-BAhHmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:41 INFO - Running setup.py (path:/tmp/pip-GM9S_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:41 INFO - Running setup.py (path:/tmp/pip-W2FFx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:41 INFO - Running setup.py (path:/tmp/pip-cx04v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:41 INFO - Running setup.py (path:/tmp/pip-rwEuVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:42 INFO - Running setup.py (path:/tmp/pip-zyLs3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:42 INFO - Running setup.py install for manifestparser 05:54:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Running setup.py install for mozcrash 05:54:42 INFO - Running setup.py install for mozdebug 05:54:42 INFO - Running setup.py install for mozdevice 05:54:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Running setup.py install for mozfile 05:54:42 INFO - Running setup.py install for mozhttpd 05:54:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Running setup.py install for mozinfo 05:54:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Running setup.py install for mozInstall 05:54:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Running setup.py install for mozleak 05:54:43 INFO - Running setup.py install for mozlog 05:54:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Running setup.py install for moznetwork 05:54:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Running setup.py install for mozprocess 05:54:43 INFO - Running setup.py install for mozprofile 05:54:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Running setup.py install for mozrunner 05:54:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Running setup.py install for mozscreenshot 05:54:43 INFO - Running setup.py install for moztest 05:54:43 INFO - Running setup.py install for mozversion 05:54:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:43 INFO - Cleaning up... 05:54:43 INFO - Return code: 0 05:54:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:43 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 0x7fd1c21daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', '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 05:54:43 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 05:54:43 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 05:54:43 INFO - Using env: {'DISPLAY': ':0', 05:54:43 INFO - 'HOME': '/home/cltbld', 05:54:43 INFO - 'LANG': 'en_US.UTF-8', 05:54:43 INFO - 'LANGUAGE': 'en_US:en', 05:54:43 INFO - 'LOGNAME': 'cltbld', 05:54:43 INFO - 'MAIL': '/var/mail/cltbld', 05:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:43 INFO - 'MOZ_NO_REMOTE': '1', 05:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:43 INFO - 'NO_EM_RESTART': '1', 05:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:43 INFO - 'PWD': '/builds/slave/test', 05:54:43 INFO - 'SHELL': '/bin/bash', 05:54:43 INFO - 'SHLVL': '1', 05:54:43 INFO - 'TERM': 'linux', 05:54:43 INFO - 'TMOUT': '86400', 05:54:43 INFO - 'USER': 'cltbld', 05:54:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:43 INFO - '_': '/tools/buildbot/bin/python'} 05:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:44 INFO - Running setup.py (path:/tmp/pip-ZXUr9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:44 INFO - Running setup.py (path:/tmp/pip-MMmtn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:44 INFO - Running setup.py (path:/tmp/pip-uoxrf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:44 INFO - Running setup.py (path:/tmp/pip-6cnH8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:44 INFO - Running setup.py (path:/tmp/pip-nOqmHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:44 INFO - Running setup.py (path:/tmp/pip-HxfKvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:44 INFO - Running setup.py (path:/tmp/pip-AQU8u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:44 INFO - Running setup.py (path:/tmp/pip-P35VZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:44 INFO - Running setup.py (path:/tmp/pip-VHvDuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:44 INFO - Running setup.py (path:/tmp/pip-DMHmbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:44 INFO - Running setup.py (path:/tmp/pip-z1Vxi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:44 INFO - Running setup.py (path:/tmp/pip-ZkTjnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:44 INFO - Running setup.py (path:/tmp/pip-y5Mmka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:45 INFO - Running setup.py (path:/tmp/pip-nXgJqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:45 INFO - Running setup.py (path:/tmp/pip-acX_nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:45 INFO - Running setup.py (path:/tmp/pip-Q0ravy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:45 INFO - Running setup.py (path:/tmp/pip-6K9jcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54:47 INFO - Downloading blessings-1.6.tar.gz 05:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:47 INFO - Installing collected packages: blessings 05:54:47 INFO - Running setup.py install for blessings 05:54:47 INFO - Successfully installed blessings 05:54:47 INFO - Cleaning up... 05:54:47 INFO - Return code: 0 05:54:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:47 INFO - Reading from file tmpfile_stdout 05:54:47 INFO - Current package versions: 05:54:47 INFO - argparse == 1.2.1 05:54:47 INFO - blessings == 1.6 05:54:47 INFO - blobuploader == 1.2.4 05:54:47 INFO - docopt == 0.6.1 05:54:47 INFO - manifestparser == 1.1 05:54:47 INFO - mozInstall == 1.12 05:54:47 INFO - mozcrash == 0.17 05:54:47 INFO - mozdebug == 0.1 05:54:47 INFO - mozdevice == 0.48 05:54:47 INFO - mozfile == 1.2 05:54:47 INFO - mozhttpd == 0.7 05:54:47 INFO - mozinfo == 0.9 05:54:47 INFO - mozleak == 0.1 05:54:47 INFO - mozlog == 3.1 05:54:47 INFO - moznetwork == 0.27 05:54:47 INFO - mozprocess == 0.22 05:54:47 INFO - mozprofile == 0.28 05:54:47 INFO - mozrunner == 6.11 05:54:47 INFO - mozscreenshot == 0.1 05:54:47 INFO - mozsystemmonitor == 0.0 05:54:47 INFO - moztest == 0.7 05:54:47 INFO - mozversion == 1.4 05:54:47 INFO - psutil == 3.1.1 05:54:47 INFO - requests == 1.2.3 05:54:47 INFO - wsgiref == 0.1.2 05:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:47 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')]} 05:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 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')]} 05:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 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 0x7fd1c21daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', '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 05:54:47 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 05:54:47 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 05:54:47 INFO - Using env: {'DISPLAY': ':0', 05:54:47 INFO - 'HOME': '/home/cltbld', 05:54:47 INFO - 'LANG': 'en_US.UTF-8', 05:54:47 INFO - 'LANGUAGE': 'en_US:en', 05:54:47 INFO - 'LOGNAME': 'cltbld', 05:54:47 INFO - 'MAIL': '/var/mail/cltbld', 05:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:47 INFO - 'MOZ_NO_REMOTE': '1', 05:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:47 INFO - 'NO_EM_RESTART': '1', 05:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:47 INFO - 'PWD': '/builds/slave/test', 05:54:47 INFO - 'SHELL': '/bin/bash', 05:54:47 INFO - 'SHLVL': '1', 05:54:47 INFO - 'TERM': 'linux', 05:54:47 INFO - 'TMOUT': '86400', 05:54:47 INFO - 'USER': 'cltbld', 05:54:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:47 INFO - '_': '/tools/buildbot/bin/python'} 05:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:47 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)) 05:54:47 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)) 05:54:47 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)) 05:54:47 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)) 05:54:47 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)) 05:54:47 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)) 05:54:47 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)) 05:54:47 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)) 05:54:47 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)) 05:54:47 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)) 05:54:47 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)) 05:54:47 INFO - Cleaning up... 05:54:47 INFO - Return code: 0 05:54:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:47 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')]} 05:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 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')]} 05:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:47 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 0x7fd1c21daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', '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 05:54:47 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 05:54:47 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 05:54:47 INFO - Using env: {'DISPLAY': ':0', 05:54:47 INFO - 'HOME': '/home/cltbld', 05:54:47 INFO - 'LANG': 'en_US.UTF-8', 05:54:47 INFO - 'LANGUAGE': 'en_US:en', 05:54:47 INFO - 'LOGNAME': 'cltbld', 05:54:47 INFO - 'MAIL': '/var/mail/cltbld', 05:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:47 INFO - 'MOZ_NO_REMOTE': '1', 05:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:47 INFO - 'NO_EM_RESTART': '1', 05:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:47 INFO - 'PWD': '/builds/slave/test', 05:54:47 INFO - 'SHELL': '/bin/bash', 05:54:47 INFO - 'SHLVL': '1', 05:54:47 INFO - 'TERM': 'linux', 05:54:47 INFO - 'TMOUT': '86400', 05:54:47 INFO - 'USER': 'cltbld', 05:54:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:47 INFO - '_': '/tools/buildbot/bin/python'} 05:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:48 INFO - Downloading/unpacking jsonschema 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:50 INFO - Downloading/unpacking functools32 (from jsonschema) 05:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:50 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:50 INFO - warning: no files found matching '*.txt' 05:54:50 INFO - no previously-included directories found matching 'build' 05:54:50 INFO - no previously-included directories found matching 'dist' 05:54:50 INFO - no previously-included directories found matching '.git*' 05:54:50 INFO - Installing collected packages: jsonschema, functools32 05:54:50 INFO - Running setup.py install for functools32 05:54:50 INFO - warning: no files found matching '*.txt' 05:54:50 INFO - no previously-included directories found matching 'build' 05:54:50 INFO - no previously-included directories found matching 'dist' 05:54:50 INFO - no previously-included directories found matching '.git*' 05:54:50 INFO - Successfully installed jsonschema functools32 05:54:50 INFO - Cleaning up... 05:54:50 INFO - Return code: 0 05:54:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c21daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25125a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', '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 05:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:54:50 INFO - Using env: {'DISPLAY': ':0', 05:54:50 INFO - 'HOME': '/home/cltbld', 05:54:50 INFO - 'LANG': 'en_US.UTF-8', 05:54:50 INFO - 'LANGUAGE': 'en_US:en', 05:54:50 INFO - 'LOGNAME': 'cltbld', 05:54:50 INFO - 'MAIL': '/var/mail/cltbld', 05:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:50 INFO - 'MOZ_NO_REMOTE': '1', 05:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:50 INFO - 'NO_EM_RESTART': '1', 05:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:50 INFO - 'PWD': '/builds/slave/test', 05:54:50 INFO - 'SHELL': '/bin/bash', 05:54:50 INFO - 'SHLVL': '1', 05:54:50 INFO - 'TERM': 'linux', 05:54:50 INFO - 'TMOUT': '86400', 05:54:50 INFO - 'USER': 'cltbld', 05:54:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:50 INFO - '_': '/tools/buildbot/bin/python'} 05:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:50 INFO - Downloading/unpacking flake8 05:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:54:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:54:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:54:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:54:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:54:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:54:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:54:53 INFO - no previously-included directories found matching 'docs/_build' 05:54:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:54:53 INFO - Running setup.py install for pep8 05:54:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:54:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:54:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:54:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:54:53 INFO - no previously-included directories found matching 'docs/_build' 05:54:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:54:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:54:53 INFO - Cleaning up... 05:54:53 INFO - Return code: 0 05:54:53 INFO - Running post-action listener: _resource_record_post_action 05:54:53 INFO - Running post-action listener: _start_resource_monitoring 05:54:53 INFO - Starting resource monitoring. 05:54:53 INFO - ##### 05:54:53 INFO - ##### Running install step. 05:54:53 INFO - ##### 05:54:53 INFO - Running pre-action listener: _resource_record_pre_action 05:54:53 INFO - Running main action method: install 05:54:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:53 INFO - Reading from file tmpfile_stdout 05:54:53 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:53 INFO - Reading from file tmpfile_stdout 05:54:53 INFO - Output received: 05:54:53 INFO - Usage: mozinstall [options] installer 05:54:53 INFO - Options: 05:54:53 INFO - -h, --help show this help message and exit 05:54:53 INFO - -d DEST, --destination=DEST 05:54:53 INFO - Directory to install application into. [default: 05:54:53 INFO - "/builds/slave/test"] 05:54:53 INFO - --app=APP Application being installed. [default: firefox] 05:54:53 INFO - mkdir: /builds/slave/test/build/application 05:54:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:55:10 INFO - Reading from file tmpfile_stdout 05:55:10 INFO - Output received: 05:55:10 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:10 INFO - Running post-action listener: _resource_record_post_action 05:55:10 INFO - ##### 05:55:10 INFO - ##### Running run-tests step. 05:55:10 INFO - ##### 05:55:10 INFO - Running pre-action listener: _resource_record_pre_action 05:55:10 INFO - Running main action method: run_tests 05:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:10 INFO - Python 2.7.3 05:55:10 INFO - Return code: 0 05:55:10 INFO - grabbing minidump binary from tooltool 05:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a1410>, '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 0x25a2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:55:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:55:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:10 INFO - Return code: 0 05:55:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:55:11 INFO - Return code: 0 05:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:55:11 INFO - Using env: {'DISPLAY': ':0', 05:55:11 INFO - 'HOME': '/home/cltbld', 05:55:11 INFO - 'LANG': 'en_US.UTF-8', 05:55:11 INFO - 'LANGUAGE': 'en_US:en', 05:55:11 INFO - 'LOGNAME': 'cltbld', 05:55:11 INFO - 'MAIL': '/var/mail/cltbld', 05:55:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:11 INFO - 'MOZ_NO_REMOTE': '1', 05:55:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:11 INFO - 'NO_EM_RESTART': '1', 05:55:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:11 INFO - 'PWD': '/builds/slave/test', 05:55:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:11 INFO - 'SHELL': '/bin/bash', 05:55:11 INFO - 'SHLVL': '1', 05:55:11 INFO - 'TERM': 'linux', 05:55:11 INFO - 'TMOUT': '86400', 05:55:11 INFO - 'USER': 'cltbld', 05:55:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522', 05:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:11 INFO - '_': '/tools/buildbot/bin/python'} 05:55:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:55:11 INFO - mozversion application_buildid: 20160423030220 05:55:11 INFO - mozversion application_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 05:55:11 INFO - mozversion application_display_name: Nightly 05:55:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:11 INFO - mozversion application_name: Firefox 05:55:11 INFO - mozversion application_remotingname: firefox 05:55:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:55:11 INFO - mozversion application_vendor: Mozilla 05:55:11 INFO - mozversion application_version: 48.0a1 05:55:11 INFO - mozversion platform_buildid: 20160423030220 05:55:11 INFO - mozversion platform_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 05:55:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:55:11 INFO - mozversion platform_version: 48.0a1 05:55:11 INFO - using testdate: 1461416111 05:55:11 INFO - actual date: 1461416111 05:55:11 INFO - starting webserver on 'localhost:36568' 05:55:11 INFO - SUITE-START | Running 2 tests 05:55:11 INFO - TEST-START | dromaeo_css 05:55:11 INFO - operating with platform_type : linux_ 05:55:11 INFO - Initialising browser for dromaeo_css test... 05:55:11 INFO - TEST-INFO | started process 32578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJp5Caf/profile http://localhost:36568/getInfo.html) 05:55:15 INFO - PROCESS | 32578 | 05:55:15 INFO - PROCESS | 32578 | (process:32645): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:55:16 INFO - PROCESS | 32578 | __metrics Screen width/height:1600/1200 05:55:16 INFO - PROCESS | 32578 | colorDepth:24 05:55:16 INFO - PROCESS | 32578 | Browser inner width/height: 1024/697 05:55:16 INFO - PROCESS | 32578 | __metrics 05:55:16 ERROR - PROCESS | 32578 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:55:17 INFO - TEST-INFO | 32578: exit 0 05:55:17 INFO - Browser initialized. 05:55:17 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:17 INFO - TEST-INFO | started process 32696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJp5Caf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:19 INFO - PROCESS | 32696 | 05:55:19 INFO - PROCESS | 32696 | (process:32756): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:55:29 INFO - PROCESS | 32696 | RSS: Main: 164749312 05:55:29 INFO - PROCESS | 32696 | 05:56:19 INFO - PROCESS | 32696 | 1461416179052 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] 05:58:26 INFO - PROCESS | 32696 | Cycle 1(1): loaded http://localhost:36568/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36568/tests/dromaeo/cssquery-ext.html) 05:58:27 INFO - PROCESS | 32696 | RSS: Main: 169185280 05:58:27 INFO - PROCESS | 32696 | 06:01:29 INFO - PROCESS | 32696 | Cycle 1(1): loaded http://localhost:36568/tests/dromaeo/cssquery-ext.html (next: http://localhost:36568/tests/dromaeo/cssquery-jquery.html) 06:01:29 INFO - PROCESS | 32696 | RSS: Main: 166989824 06:01:29 INFO - PROCESS | 32696 | 06:04:31 INFO - PROCESS | 32696 | Cycle 1(1): loaded http://localhost:36568/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36568/tests/dromaeo/cssquery-mootools.html) 06:04:32 INFO - PROCESS | 32696 | RSS: Main: 167587840 06:04:32 INFO - PROCESS | 32696 | 06:07:33 INFO - PROCESS | 32696 | Cycle 1(1): loaded http://localhost:36568/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36568/tests/dromaeo/cssquery-prototype.html) 06:07:34 INFO - PROCESS | 32696 | RSS: Main: 165146624 06:07:34 INFO - PROCESS | 32696 | 06:10:36 INFO - PROCESS | 32696 | Cycle 1(1): loaded http://localhost:36568/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36568/tests/dromaeo/cssquery-yui.html) 06:10:37 INFO - PROCESS | 32696 | RSS: Main: 166584320 06:10:37 INFO - PROCESS | 32696 | 06:13:39 INFO - PROCESS | 32696 | Cycle 1(1): loaded http://localhost:36568/tests/dromaeo/cssquery-yui.html (next: http://localhost:36568/tests/dromaeo/cssquery-dojo.html) 06:13:40 INFO - PROCESS | 32696 | RSS: Main: 168595456 06:13:40 INFO - PROCESS | 32696 | 06:13:40 INFO - PROCESS | 32696 | __start_tp_report 06:13:40 INFO - PROCESS | 32696 | _x_x_mozilla_page_load 06:13:40 INFO - PROCESS | 32696 | _x_x_mozilla_page_load_details 06:13:40 INFO - PROCESS | 32696 | |i|pagename|runs| 06:13:40 INFO - PROCESS | 32696 | |0;dojo.html;3151.4642510773165;3201.1516948008775;3204.7916885402433;3234.85443155058;3237.7733558650903;5219.8695032624155;5248.396434410044;5271.393789714184;5323.1749078892735;5401.729913504324;5277.788888444457;5319.680819150844;5426.538744206738;5439.673619582818;5505.119180931052;4949.084419382417;4994.850154495371;5044.571211447032;5052.418971818232;5115.2327150927285;616.5198612326615;4925.926111108336;5006.724630145341;5034;5052.823151189709;4953.777080031389;4957.405111386639;4987.326710894019;4988.8752781180765;5001.724905130234;4871;5075.162598171334;5084.694918304876;5091.389033316026;5096.311393517973;4829.1307564638355;4836.322914791932;4846.030793841246;4853.563179313844;4882.853514394574;5259.658122222043;5282.498162674578;5288.762005709752;5291.391489978663;5312.840614781563;5677.886442271173;5695.77216911323;5701.4013528579735;5708.800191993302;5724.856878578027;5731.254936858223;5739.512141467981;5744.540436765049;5748.367679555246;5808.8838223235725;5356.303680521546;5360.088784906575;5367.624266301322;5376.086065368897;5378.865528361783;5727.627704199213;5828.94171058284;5927.377625349276;5965.612235204698;6014.1580178775;5721.742521586539;5745.1382292656435;5746.540276777848;5761.452661997104;5761.625494342854;5794.072948328331;5794.50746686528;5806.767729290866;5812.186293918855;5815.9709201453725;5608.831735047955;5784.768609255582;5802.303723553201;5830.82507524775;5873.471387575139;5570.080936645408;5757.971210143923;5804.5356371491025;5813.447722466443;5834.387389324144;4347;4348.34774783785;4403.9779801100785;4426.84506042287;4471.8434854779925;3859.614038596118;3860.0735823402183;3898.863539776094;3912.784796836201;3946.960530394659;5536.833894983157;5550.583706221969;5556.138798486241;5562.610617256753;5616.887662246814;5707.74315155819;5797.536197104221;5850.23946886902;5874.206982057368;5894.911576326359;5484.122540393598;5505.779768809283;5515.61390702655;5550.16747487872;5576.33084029919;4986.576141027981;4999.950000500021;5001.7499125043605;5004.549590536869;5045.8738531537;5861.970690146607;5985.491233245136;5988.101784732238;5995.580309378389;6023.247094113236;5789.45000224978;5821.825345239649;5824.883502330014;5825.271841019872;5847.38602446737;5916.112583112567;5964.284285885721;5964.314103877936;5964.8807023860145;5966.850828729316;5589.441055894541;5692.231548740867;5703.800366987136;5730.885382292414;5770.740316685676;5643.689597072201;5681.914771278517;5684.9431505684415;5687.914681279867;5750;5551.278333816578;5555.138953462219;5558.221848941071;5568.331800184003;5571.860703482445;5531.557475402039;5558.694271814928;5721.313442386774;5770.711464426678;5801.912971305349;5475.863103422446;5538.141588053858;5547.306586676666;5556.111022236423;5569.888602228014;5532.474414930575;5739.282589676291;5768.394318596487;5804.1293805929445;5831.387704291158;5599.552035837205;5600.411956744483;5618.04493236159;5626.971865140648;5627.155926611041 06:13:40 INFO - PROCESS | 32696 | |1;ext.html;585.4555263604846;619.8853212155755;636.2778246690007;636.9712913644463;655.606636018389;38616;39916;39928.80035599825;39983.99999999996;40136.39795403071;41932.58067419325;42666.57333426665;42757.358639620354;42805.78597107018;42846.357304640456;8490.57547122646;8748.650053997833;8758.60586273616;8759.386842920998;8767;8820.823583528325;8932;8976.057513961037;8981.191692747652;9000.59497322622;8961.193492585666;8987.640494380217;8995.190432861042;8996.235319997775;9055.275577953747;8908.064653211417;8983.146601072887;8987.37088403812;8998.910010899905;9003.324750643662;8807.823843523158;8884.511351875644;8925.196732294125;8933;8956.507392093432;41410.585894140975;41664.375034374505;41816.1636767266;41962.37056444156;41971.7901410494;3382.238996225854;3457.4468085106514;3482;3519.5424594802766;3525.8589656413715;31950.520742188884;32597;32685;32891.83554082238;32916.177095572566;4216.156768646252;4268.146370725867;4295.871123866289;4362.1275744851155;4370.759608221547;214872;218643;218674;219491;219728;54627.72686136544;54715;55059.72470137624;55096.44903550913;55182;64373.356266436735;66510.33489665139;66731;66780.6660966692;66805;16829.41097061597;17065.7440138398;17121.743173852403;17124.058176800394;17125.14374281281;11891.524339026342;11939.582114625946;11977.281363118242;11988.580399686143;12003.279803211835;19179.257899043852;19515.90242048809;19693.704594431096;20280.391588252376;20314.492137696674;7091.030669580918;7246.239144889816;7277.3086556777025;7327.560346379234;7463.776086717407;1087.1302957633861;1104.6741211342512;1105.8949399807007;1190.9523619055315;1200.7058270723728;31311.53032704511;31516.527252091237;31580.52629210564;31690.207744806103;32631.510527341634;1081.5233116163897;1136.3295954946216;1187.9346635935105;1294.8446186457686;1299.9220046797034;16745.916270418813;16777.91611041937;16916.577085572713;17180.656386872193;17395.636146258894;471645;479430;479659;480157.78974366555;480750;58190;58611;58849;59021;59061.70469147627;1359.5309618181711;1396.5670642100981;1402.4530433131088;1407.8310602727738;1424.181095869879;30344.241393964443;30607.387852243275;30840;31230.687693123687;32050;51169.744151280494;52212.477875220764;52212.738936305075;52312.738436307576;52551;422785;425042;425273;426364;426373;28869.855650721613;42415;43422.34866476942;43625;44326.77836610797;41776.58223417727;43122.568774311854;47945;49675.50324496709;50333;38845.805770972096;39398.21203575855;39434;39733.20533589254;40012.799936000134;37989.81005094957;38903.80548097241;38992.415113772746;40160;40373.798131009156;40294.79852600718;42402.575974239866;42952.78523607362;44028.559714403724;44086.33870492009;33033.66966330306;36027.27945441129;36277;36421;36577.81711091534;27525.587116193674;27880.58179127274;27907.72092279051;28007.299817504725;28069.298267543476 06:13:40 INFO - PROCESS | 32696 | |2;jquery.html;381.351702106419;385.5989770638537;393.1841429034753;397.58452417224;403.26203048421394;16751.748723769153;18088.276468941225;18243.270269189234;18245.452636420894;18245.54386140344;17879.64240715185;18375.44873653789;18527.722084168716;18772.53068673284;18904.825945016328;5441.347038355403;5445.918311225335;5642.633228840133;5682.346530149044;5685.715714214293;5460.726963651821;5522.834314970557;5526.972365138168;5542.63972841766;5546.195801608765;5265.341832270966;5463.289772329592;5472.370677372093;5488.53347465466;5492.505674489295;5500.42245564218;5515.586331025189;5539.030669632818;5541.362743284533;5556.388797232301;4847.466778654345;4857.53853383928;4898.706077635354;4902.4362198346935;4958.033183529214;21684.78315216859;21761.455963600878;21982;22058.779412205833;22098.226562070413;2140.3364956863265;2273.8294627902974;2324.0936034946385;2611.6343711880354;2632.736726327371;14014.509492167725;14179.078359906676;14356.282185890665;14445;14473.710525789531;1773.379317238969;1812.7371531128044;1834.8440382567499;1841.686913224755;1876.5777700017386;50748;69548.30451695519;69653;71933.28066719318;72027.63986180088;9615.807683846284;10040.447775372424;10136.746581335377;10181.847272290921;10300.536475858455;14019.1588504688;14157.433702651779;14164.716705665829;14215.644608884653;14228.359723812453;8055.476394034369;8061.153578874251;8270.627821748036;8292.958535207285;8330.750077497685;8080.909077274493;8125.4312198146745;8173.182681731898;8295.377846661524;8313.501189928624;6241.906371404432;6274.090256912722;6342.302346741854;6397.392247736458;6425.903611445832;1874.7000479923147;1877.9061046947597;1911.3405874973112;1942.7765806932384;1944.0862794486568;998.7203582996773;1032.02989190161;1065.3128731967993;1135.5174051028446;1176.9117316201318;18388.540286492946;18414.17136228873;18806.153723082494;18934.43196704101;18979.90510047441;1057.8836328003913;1070.8500809886623;1080.0819303591884;1092.6940456671985;1097.643265938557;10447.68656940293;10755.924407559338;10883.129349652008;10943.781124377469;11027.889721102847;501648;509742;511360;516882.24676629883;521403;49982.75008624933;58920.705396472746;82225.17774822295;83831.5808420954;84261.15738842533;1044.7805960748176;1075.113031748826;1079.8704155501391;1093.1637297467444;1099.8955099265556;15992.680146396775;16063.277152527931;16086.43697470583;16208.594785130466;16408.589785255463;35772.821135894155;35867.82066089653;35936.82031589825;36104.819475902455;36133.63866361303;47049.52950470588;48018;49463.25805112854;49491;50880;7878.251566101211;7942.166072562298;8063.798405039921;8064.3548516119745;8315.334773218248;12279.815802762787;12503.499860005499;13008.089433739548;13241.404136813673;13260.867391325963;10658.14734821228;10931.617393391192;11356.886431135583;11537.423128843691;11820.349880756641;9341.392809467363;11272.718182045515;11350.978411942964;11608.361540115036;11620.954114129769;10971.808755069944;11626.186166968231;12027.699307517381;12052.397380130784;12112.93943530312;7943.165967573553;8193.180681931759;8313.168683131638;8423.115572865006;8489.95755021221;10732.67801965911;11275.548978040786;11380.601678941197;11562.421878906189;11682.12384071181 06:13:40 INFO - PROCESS | 32696 | |3;mootools.html;1526.8931174817765;1542.2982542942962;1688.2909178145178;1760.9647807043852;1827.7167039108936;7377.151627562832;7889.5266284023;7974.880376794353;8204.794880128;8223.58882055897;7995.040595128578;8005.839883202332;8010.279074883259;8015.118336982927;8060.959695201515;2265.275111964172;2286.16554957441;2286.6912966749524;2294.7475777664527;2294.9655755163685;2236.2173239366252;2243.55128974205;2292.117534749117;2302.8618282902994;2303.0327262549768;2270.2962081754627;2270.704808374909;2281;2299.37916762474;2319.5940710375703;2246.764089770575;2254.9887250563643;2263.818894488437;2264.1396269417596;2264.626336654458;2217.955640887173;2219.145628932856;2220.0897631970815;2221.677856710768;2222.0445208560313;8219.671213151467;8264.628091735887;8270.875936860952;8277;8316.085230624627;4928.531789479994;5073.543381095719;5097.337346144977;5124.256982737482;5129.9230511542355;3137.654857965622;3164.256399746058;3198.424283628946;3216.2120280531185;3276.115448828803;1048.4024106259435;1055.145332280855;1059.1156384419019;1064.8562444070028;1067.8344856547249;11338.206325557214;11338.773224535464;11340.829887551694;11349;11354.545818167264;4223.429836971969;4247.384129301234;4364.71629344098;4388.429504164438;4401.867943961686;9690.806183876424;9701.951490242503;9738.805223895624;9758.024197580186;9786.608535658635;5041.949580504222;5059.241113832881;5077.39071311445;5086.262491938648;5100.183970564766;4092.3043082676018;4454.420925279693;4547.886302842389;4581.5647513486165;4638.350630911675;3769.660730534265;3794.867179648699;3812.7712337259854;3893.96106038936;3896.220755848785;1244.6452760963082;1250.1249125612107;1254.0970501239094;1263.6524955637274;1288.3043156695467;950.6292545906964;978.6379039755336;985.4432245781111;996.531630133836;1003.8142943555465;5479.917801232985;5575.804846830341;5629.859253518613;5639.774409023676;5667.773289068474;405.65924623316556;406.8392984771058;408.31403242552204;413.4542404026716;426.3987777234085;3909.081365879016;3932.4691166692132;3940.665043471337;3945.743526670757;3987.940180897289;9899;10206.183505319557;10258.58965641381;10335.534900929477;10342.431166285927;9990.250731195189;10066.848997265048;10238.18094552449;10246.180305575535;10253.282270241012;7680.193579674054;7706.07527096752;7775.766726998199;7840.33357164636;7946.602669866484;5511.807086751945;5566.832995010156;5568.888622227451;5634.577406694432;5777.595568310178;9372.203362713974;9385.15533601979;9421.670241541513;9437.528123593656;9490.335676502578;9071.637134514545;9299.86050209261;9356.532173391439;9365.391249568756;9479.526023698925;6664.400203981665;7094.148702155774;7107.609081500567;7305.050343455317;7336.156342020736;7892.881606776018;7937.801554961172;7944.165862584577;7993.72021979228;7998.680052798056;7071.893921591078;7286.271372862671;7310.451716121206;7418.591977441292;7422.665980030803;7125.5368401053765;7185.065941427581;7238.472486240498;7339.339459448675;7411.295926886937;6862.759803406857;6885.311468853075;6921.653917304216;6921.930780692129;6928.515003949675;5036.395632523974;5052.898942021213;5054.140796064605;5056.595472362275;5092.516210959953;5045.4450010498085;5073;5099.719515426687;5125.666831655931;5127.46161653021 06:13:40 INFO - PROCESS | 32696 | |4;prototype.html;320.5864434879006;328.2155648001277;332.89347408829167;335.03342855860836;335.15707994394086;5902.173695682608;5973.475649366873;5985.533544281657;6072.939270607299;6080.908786368208;5752.309722833266;5824.534037277018;5887.145549152014;5973.074173503103;5995.310539287983;4512.052468981517;4524.886877828048;4526.6831321807485;4534.798278456212;4554.3168524721395;4409.647228221735;4552.494579174034;4558.544145585432;4564.589186973171;4569.314602809589;4496.685232033759;4509.143262780078;4521.615662668677;4525.683202175849;4556.817727290921;4531.909361812762;4541.931871021938;4549.727016379012;4562.292844609091;4569.543045695437;3698.14942563212;3893.1045859452483;3920.4318272690866;3952.940705889414;3981.292720949753;5746.482816546531;5787.247657804459;5797.188393624896;5807.680577568232;5826.155207494932;5205.427402985669;5206.062908676437;5245.973770131125;5247.2159465781815;5249.973750131263;6023.728932198062;6294.70958453516;6318.494520438354;6324.3043265240785;6332.303446620868;4294.355846623001;4311.547287534827;4311.82752689892;4323.135372925428;4332.3068309070395;6276.278228003838;6497.350264973512;6583.506237032242;6584.8024559263295;6590.637514936677;4359.782010899442;4372.3878656988045;4392.363107349416;4398.186335527937;4402.625776809007;4431.379606855043;4449.57729015743;4453.42105526286;4458.9331160032625;4467.5532446755715;5007.298978143063;5178.8964220716125;5184.688918664892;5199.688018718889;5206.344764170301;6111.480524155497;6330.024888302491;6347.96826015867;6358.904616430757;6412.583182093243;1487.8363380028188;1515.4923100761368;1521.254585253218;1524.4283393727353;1536.784850120984;1011.2668315471371;1013.7769690668041;1027.1577306608658;1029.156092004564;1036.2953191829477;6077.604955677867;6116.296625887991;6122;6126.479249263773;6130.693465326716;6518.41487182048;6525.771597994048;6527.902081468782;6528.608283503005;6566.409023187936;5990.610610310403;6079.908801367983;6129.295131059896;6130.540209484307;6164.599301045418;3509.298140371885;3515.7187425005936;3537.752357335013;3577.35607590631;3584.8566057357934;6544.312847151075;6761.290064543152;6766.966165169143;6809.829754256183;6839.2818754031105;6715.414565392359;6727.899081513781;6739.865202695919;6743.752405804942;6751.459883209332;6512.34876512345;6721.764738234237;6774.898376524257;6794.592324460548;6816.079829222991;6538.215414150332;6550.639714815731;6552.63960482178;6556.18047744032;6586.50601204902;6183.876322473615;6460.289368169404;6465.612063276219;6494.7077381517;6535.934640653722;6765.864682706417;6823.249442561215;6832.521723479309;6844.28135045813;6844.59685764427;4383.802728877145;4403.867883963486;4435.223835828781;4441.822327107009;4442.888927776831;6245.500359971283;6398.808035758934;6597.340265973557;6623.172103487064;6651.600903945779;6329.90505142414;6381.744730210739;6384.585001974857;6403.423691867754;6427.228732552124;6157.476614487639;6387.233531976192;6393.392627700361;6401.423871851555;6411.102445657519;6263.185785847811;6283.277423096402;6284.622922624657;6295.842603934938;6332.240131184103;6365.3316401779;6450.161928751334;6455.903161452488;6464.935350646621;6478.676066196577;5979.402059793986;6235.314115447207;6253.6560489173535;6260.591366942402;6269.122322874892 06:13:40 INFO - PROCESS | 32696 | |5;yui.html;827.7889138269742;848.3171047306918;849.5370023337281;856.901456332522;864.278327596457;13912.860871391284;13941.442342306322;13963.930180349096;14024.298785060731;14614.123152610851;11516;13357.666058348546;13369.665758356046;13374.331283435813;13380.866191338084;783.1698399696326;813.446856137826;814.4258297899967;814.8085199978001;818.7216346442209;793.7182300283403;802.0495712580581;802.4423025996934;802.4743792815685;807.648672827319;856.3021137772727;857.7212405968054;857.8027053777635;857.9914200857974;859.3511898516642;840.4495055738502;845.7716416567554;847.4830353484369;848.5587494502855;849.6856163219586;617.290116366178;624.5378419969236;627.3444250757968;629.2071989293523;630.2311180359953;14146.080504767157;14179.858201417957;14251.78622320666;14287.285635718172;14288.428462861473;14206.715865682629;14300.785488217685;14381.856181438156;14398.208098554574;14431.783523247159;11502;11587.47856346458;11604.30374177552;11666.824997625043;11809.114316426216;3844.2695887781233;3859.59474255202;3933.3116704576582;3937.251922134785;3972.523297204354;56298.43701562973;56919.71540142273;58970.41029589735;59069.704651476466;59346.703266483826;10925.945370273097;11176.552937882556;11176.888231117748;11265.324080555192;11291.435428228555;20607;20625.381238562866;20648.483787905123;20654.896725516275;20709.68935465969;8269.29710974562;8318.750437486764;8432.156784321642;8481.787955301043;8607;4635.930461043087;4653.325267836212;4673.205555055649;4911.8280860170435;5054.595632349403;3054.465468542996;3147;3151.5115157150676;3158.842057897096;3166.2875852933366;642.1170890026214;643.6942452335103;651.9380658837498;652.5725649699455;653.0498125227782;693.0505207865257;696.5611664651237;721.7473884140509;747.3834086878347;779.2402407652494;9150.176484116462;9426.628278886954;9608.471534065693;9628.374155679858;9630.951845240728;652.393274254938;727.7743899391099;748.7229725001675;757.2843662738659;767;4106.630403263721;4297.505786834554;4319.827206911688;4323.3947247385395;4450.154470650631;53313;56026.71986640041;66391;66434.66782666152;66561;47521.04957900892;47657;48530;48733.756331218116;49796.50203497991;49068.75465622649;49180;49968;49974.750126249135;50308.74845625748;9382.624695012397;9478.573464194265;9610.95194524023;9704.951475242578;9707.174890134418;32788.50817237791;32932.1766955828;33291.66708332886;33722.66277337195;34346.14134646654;44160.77919610382;45440;46196;46723;46736.29895551501;11810.17328787011;12324;12663.050271229511;12796.296203708886;12839;13800.240986745424;13853.37659805291;14104.647383815487;14273.57179284623;14380.35288412003;12827.871721282667;13127.803082953955;13199.802002970155;13757.31213439344;14240.786388203978;13132.868671313165;13194;13244.337783110614;13271.535496257584;13403.396847141707;12744.61766147017;12930.482780688668;13326.200427974352;13727.588172354845;13777.655558610713;10782.514786834454;10891.618793342195;11061.446927653424;11253.66239012831;11506.94246528762;10521.4739263035;11128.221024528206;11209.663710088711;11263.943680281545;11473.311601303949 06:13:40 INFO - PROCESS | 32696 | __end_tp_report 06:13:40 INFO - PROCESS | 32696 | __start_cc_report 06:13:40 INFO - PROCESS | 32696 | _x_x_mozilla_cycle_collect,335 06:13:40 INFO - PROCESS | 32696 | __end_cc_report 06:13:40 INFO - PROCESS | 32696 | __startTimestamp1461417220055__endTimestamp 06:13:40 INFO - PROCESS | 32696 | 06:13:40 INFO - PROCESS | 32696 | ------- Summary: start ------- 06:13:40 INFO - PROCESS | 32696 | Number of tests: 6 06:13:40 INFO - PROCESS | 32696 | 06:13:40 INFO - PROCESS | 32696 | [#0] dojo.html Cycles:165 Average:5348.27 Median:5568.33 stddev:703.11 (12.6%) stddev-sans-first:683.82 06:13:40 INFO - PROCESS | 32696 | Values: 3151.5 3201.2 3204.8 3234.9 3237.8 5219.9 5248.4 5271.4 5323.2 5401.7 5277.8 5319.7 5426.5 5439.7 5505.1 4949.1 4994.9 5044.6 5052.4 5115.2 616.5 4925.9 5006.7 5034.0 5052.8 4953.8 4957.4 4987.3 4988.9 5001.7 4871.0 5075.2 5084.7 5091.4 5096.3 4829.1 4836.3 4846.0 4853.6 4882.9 5259.7 5282.5 5288.8 5291.4 5312.8 5677.9 5695.8 5701.4 5708.8 5724.9 5731.3 5739.5 5744.5 5748.4 5808.9 5356.3 5360.1 5367.6 5376.1 5378.9 5727.6 5828.9 5927.4 5965.6 6014.2 5721.7 5745.1 5746.5 5761.5 5761.6 5794.1 5794.5 5806.8 5812.2 5816.0 5608.8 5784.8 5802.3 5830.8 5873.5 5570.1 5758.0 5804.5 5813.4 5834.4 4347.0 4348.3 4404.0 4426.8 4471.8 3859.6 3860.1 3898.9 3912.8 3947.0 5536.8 5550.6 5556.1 5562.6 5616.9 5707.7 5797.5 5850.2 5874.2 5894.9 5484.1 5505.8 5515.6 5550.2 5576.3 4986.6 5000.0 5001.7 5004.5 5045.9 5862.0 5985.5 5988.1 5995.6 6023.2 5789.5 5821.8 5824.9 5825.3 5847.4 5916.1 5964.3 5964.3 5964.9 5966.9 5589.4 5692.2 5703.8 5730.9 5770.7 5643.7 5681.9 5684.9 5687.9 5750.0 5551.3 5555.1 5558.2 5568.3 5571.9 5531.6 5558.7 5721.3 5770.7 5801.9 5475.9 5538.1 5547.3 5556.1 5569.9 5532.5 5739.3 5768.4 5804.1 5831.4 5599.6 5600.4 5618.0 5627.0 5627.2 06:13:40 INFO - PROCESS | 32696 | 06:13:40 INFO - PROCESS | 32696 | [#1] ext.html Cycles:180 Average:54865.84 Median:41874.37 stddev:103438.66 (247.0%) stddev-sans-first:103648.54 06:13:40 INFO - PROCESS | 32696 | Values: 585.5 619.9 636.3 637.0 655.6 38616.0 39916.0 39928.8 39984.0 40136.4 41932.6 42666.6 42757.4 42805.8 42846.4 8490.6 8748.7 8758.6 8759.4 8767.0 8820.8 8932.0 8976.1 8981.2 9000.6 8961.2 8987.6 8995.2 8996.2 9055.3 8908.1 8983.1 8987.4 8998.9 9003.3 8807.8 8884.5 8925.2 8933.0 8956.5 41410.6 41664.4 41816.2 41962.4 41971.8 3382.2 3457.4 3482.0 3519.5 3525.9 31950.5 32597.0 32685.0 32891.8 32916.2 4216.2 4268.1 4295.9 4362.1 4370.8 214872.0 218643.0 218674.0 219491.0 219728.0 54627.7 54715.0 55059.7 55096.4 55182.0 64373.4 66510.3 66731.0 66780.7 66805.0 16829.4 17065.7 17121.7 17124.1 17125.1 11891.5 11939.6 11977.3 11988.6 12003.3 19179.3 19515.9 19693.7 20280.4 20314.5 7091.0 7246.2 7277.3 7327.6 7463.8 1087.1 1104.7 1105.9 1191.0 1200.7 31311.5 31516.5 31580.5 31690.2 32631.5 1081.5 1136.3 1187.9 1294.8 1299.9 16745.9 16777.9 16916.6 17180.7 17395.6 471645.0 479430.0 479659.0 480157.8 480750.0 58190.0 58611.0 58849.0 59021.0 59061.7 1359.5 1396.6 1402.5 1407.8 1424.2 30344.2 30607.4 30840.0 31230.7 32050.0 51169.7 52212.5 52212.7 52312.7 52551.0 422785.0 425042.0 425273.0 426364.0 426373.0 28869.9 42415.0 43422.3 43625.0 44326.8 41776.6 43122.6 47945.0 49675.5 50333.0 38845.8 39398.2 39434.0 39733.2 40012.8 37989.8 38903.8 38992.4 40160.0 40373.8 40294.8 42402.6 42952.8 44028.6 44086.3 33033.7 36027.3 36277.0 36421.0 36577.8 27525.6 27880.6 27907.7 28007.3 28069.3 06:13:40 INFO - PROCESS | 32696 | 06:13:40 INFO - PROCESS | 32696 | [#2] jquery.html Cycles:180 Average:28119.61 Median:22020.39 stddev:83742.09 (380.3%) stddev-sans-first:83951.11 06:13:40 INFO - PROCESS | 32696 | Values: 381.4 385.6 393.2 397.6 403.3 16751.7 18088.3 18243.3 18245.5 18245.5 17879.6 18375.4 18527.7 18772.5 18904.8 5441.3 5445.9 5642.6 5682.3 5685.7 5460.7 5522.8 5527.0 5542.6 5546.2 5265.3 5463.3 5472.4 5488.5 5492.5 5500.4 5515.6 5539.0 5541.4 5556.4 4847.5 4857.5 4898.7 4902.4 4958.0 21684.8 21761.5 21982.0 22058.8 22098.2 2140.3 2273.8 2324.1 2611.6 2632.7 14014.5 14179.1 14356.3 14445.0 14473.7 1773.4 1812.7 1834.8 1841.7 1876.6 50748.0 69548.3 69653.0 71933.3 72027.6 9615.8 10040.4 10136.7 10181.8 10300.5 14019.2 14157.4 14164.7 14215.6 14228.4 8055.5 8061.2 8270.6 8293.0 8330.8 8080.9 8125.4 8173.2 8295.4 8313.5 6241.9 6274.1 6342.3 6397.4 6425.9 1874.7 1877.9 1911.3 1942.8 1944.1 998.7 1032.0 1065.3 1135.5 1176.9 18388.5 18414.2 18806.2 18934.4 18979.9 1057.9 1070.9 1080.1 1092.7 1097.6 10447.7 10755.9 10883.1 10943.8 11027.9 501648.0 509742.0 511360.0 516882.2 521403.0 49982.8 58920.7 82225.2 83831.6 84261.2 1044.8 1075.1 1079.9 1093.2 1099.9 15992.7 16063.3 16086.4 16208.6 16408.6 35772.8 35867.8 35936.8 36104.8 36133.6 47049.5 48018.0 49463.3 49491.0 50880.0 7878.3 7942.2 8063.8 8064.4 8315.3 12279.8 12503.5 13008.1 13241.4 13260.9 10658.1 10931.6 11356.9 11537.4 11820.3 9341.4 11272.7 11351.0 11608.4 11621.0 10971.8 11626.2 12027.7 12052.4 12112.9 7943.2 8193.2 8313.2 8423.1 8490.0 10732.7 11275.5 11380.6 11562.4 11682.1 06:13:40 INFO - PROCESS | 32696 | 06:13:40 INFO - PROCESS | 32696 | [#3] mootools.html Cycles:180 Average:5463.80 Median:5057.92 stddev:3049.55 (60.3%) stddev-sans-first:3043.76 06:13:40 INFO - PROCESS | 32696 | Values: 1526.9 1542.3 1688.3 1761.0 1827.7 7377.2 7889.5 7974.9 8204.8 8223.6 7995.0 8005.8 8010.3 8015.1 8061.0 2265.3 2286.2 2286.7 2294.7 2295.0 2236.2 2243.6 2292.1 2302.9 2303.0 2270.3 2270.7 2281.0 2299.4 2319.6 2246.8 2255.0 2263.8 2264.1 2264.6 2218.0 2219.1 2220.1 2221.7 2222.0 8219.7 8264.6 8270.9 8277.0 8316.1 4928.5 5073.5 5097.3 5124.3 5129.9 3137.7 3164.3 3198.4 3216.2 3276.1 1048.4 1055.1 1059.1 1064.9 1067.8 11338.2 11338.8 11340.8 11349.0 11354.5 4223.4 4247.4 4364.7 4388.4 4401.9 9690.8 9702.0 9738.8 9758.0 9786.6 5041.9 5059.2 5077.4 5086.3 5100.2 4092.3 4454.4 4547.9 4581.6 4638.4 3769.7 3794.9 3812.8 3894.0 3896.2 1244.6 1250.1 1254.1 1263.7 1288.3 950.6 978.6 985.4 996.5 1003.8 5479.9 5575.8 5629.9 5639.8 5667.8 405.7 406.8 408.3 413.5 426.4 3909.1 3932.5 3940.7 3945.7 3987.9 9899.0 10206.2 10258.6 10335.5 10342.4 9990.3 10066.8 10238.2 10246.2 10253.3 7680.2 7706.1 7775.8 7840.3 7946.6 5511.8 5566.8 5568.9 5634.6 5777.6 9372.2 9385.2 9421.7 9437.5 9490.3 9071.6 9299.9 9356.5 9365.4 9479.5 6664.4 7094.1 7107.6 7305.1 7336.2 7892.9 7937.8 7944.2 7993.7 7998.7 7071.9 7286.3 7310.5 7418.6 7422.7 7125.5 7185.1 7238.5 7339.3 7411.3 6862.8 6885.3 6921.7 6921.9 6928.5 5036.4 5052.9 5054.1 5056.6 5092.5 5045.4 5073.0 5099.7 5125.7 5127.5 06:13:40 INFO - PROCESS | 32696 | 06:13:40 INFO - PROCESS | 32696 | [#4] prototype.html Cycles:180 Average:5280.29 Median:6048.33 stddev:1617.56 (26.7%) stddev-sans-first:1578.68 06:13:40 INFO - PROCESS | 32696 | Values: 320.6 328.2 332.9 335.0 335.2 5902.2 5973.5 5985.5 6072.9 6080.9 5752.3 5824.5 5887.1 5973.1 5995.3 4512.1 4524.9 4526.7 4534.8 4554.3 4409.6 4552.5 4558.5 4564.6 4569.3 4496.7 4509.1 4521.6 4525.7 4556.8 4531.9 4541.9 4549.7 4562.3 4569.5 3698.1 3893.1 3920.4 3952.9 3981.3 5746.5 5787.2 5797.2 5807.7 5826.2 5205.4 5206.1 5246.0 5247.2 5250.0 6023.7 6294.7 6318.5 6324.3 6332.3 4294.4 4311.5 4311.8 4323.1 4332.3 6276.3 6497.4 6583.5 6584.8 6590.6 4359.8 4372.4 4392.4 4398.2 4402.6 4431.4 4449.6 4453.4 4458.9 4467.6 5007.3 5178.9 5184.7 5199.7 5206.3 6111.5 6330.0 6348.0 6358.9 6412.6 1487.8 1515.5 1521.3 1524.4 1536.8 1011.3 1013.8 1027.2 1029.2 1036.3 6077.6 6116.3 6122.0 6126.5 6130.7 6518.4 6525.8 6527.9 6528.6 6566.4 5990.6 6079.9 6129.3 6130.5 6164.6 3509.3 3515.7 3537.8 3577.4 3584.9 6544.3 6761.3 6767.0 6809.8 6839.3 6715.4 6727.9 6739.9 6743.8 6751.5 6512.3 6721.8 6774.9 6794.6 6816.1 6538.2 6550.6 6552.6 6556.2 6586.5 6183.9 6460.3 6465.6 6494.7 6535.9 6765.9 6823.2 6832.5 6844.3 6844.6 4383.8 4403.9 4435.2 4441.8 4442.9 6245.5 6398.8 6597.3 6623.2 6651.6 6329.9 6381.7 6384.6 6403.4 6427.2 6157.5 6387.2 6393.4 6401.4 6411.1 6263.2 6283.3 6284.6 6295.8 6332.2 6365.3 6450.2 6455.9 6464.9 6478.7 5979.4 6235.3 6253.7 6260.6 6269.1 06:13:40 INFO - PROCESS | 32696 | 06:13:40 INFO - PROCESS | 32696 | [#5] yui.html Cycles:180 Average:14880.02 Median:24945.08 stddev:16892.68 (67.7%) stddev-sans-first:16907.10 06:13:40 INFO - PROCESS | 32696 | Values: 827.8 848.3 849.5 856.9 864.3 13912.9 13941.4 13963.9 14024.3 14614.1 11516.0 13357.7 13369.7 13374.3 13380.9 783.2 813.4 814.4 814.8 818.7 793.7 802.0 802.4 802.5 807.6 856.3 857.7 857.8 858.0 859.4 840.4 845.8 847.5 848.6 849.7 617.3 624.5 627.3 629.2 630.2 14146.1 14179.9 14251.8 14287.3 14288.4 14206.7 14300.8 14381.9 14398.2 14431.8 11502.0 11587.5 11604.3 11666.8 11809.1 3844.3 3859.6 3933.3 3937.3 3972.5 56298.4 56919.7 58970.4 59069.7 59346.7 10925.9 11176.6 11176.9 11265.3 11291.4 20607.0 20625.4 20648.5 20654.9 20709.7 8269.3 8318.8 8432.2 8481.8 8607.0 4635.9 4653.3 4673.2 4911.8 5054.6 3054.5 3147.0 3151.5 3158.8 3166.3 642.1 643.7 651.9 652.6 653.0 693.1 696.6 721.7 747.4 779.2 9150.2 9426.6 9608.5 9628.4 9631.0 652.4 727.8 748.7 757.3 767.0 4106.6 4297.5 4319.8 4323.4 4450.2 53313.0 56026.7 66391.0 66434.7 66561.0 47521.0 47657.0 48530.0 48733.8 49796.5 49068.8 49180.0 49968.0 49974.8 50308.7 9382.6 9478.6 9611.0 9705.0 9707.2 32788.5 32932.2 33291.7 33722.7 34346.1 44160.8 45440.0 46196.0 46723.0 46736.3 11810.2 12324.0 12663.1 12796.3 12839.0 13800.2 13853.4 14104.6 14273.6 14380.4 12827.9 13127.8 13199.8 13757.3 14240.8 13132.9 13194.0 13244.3 13271.5 13403.4 12744.6 12930.5 13326.2 13727.6 13777.7 10782.5 10891.6 11061.4 11253.7 11506.9 10521.5 11128.2 11209.7 11263.9 11473.3 06:13:40 INFO - PROCESS | 32696 | -------- Summary: end -------- 06:13:40 INFO - PROCESS | 32696 | 06:13:40 INFO - TEST-INFO | 32696: exit 0 06:13:40 INFO - TEST-OK | dromaeo_css | took 1109083ms 06:13:40 INFO - TEST-START | kraken 06:13:40 INFO - operating with platform_type : linux_ 06:13:40 INFO - Initialising browser for kraken test... 06:13:40 INFO - TEST-INFO | started process 464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3g2Nsh/profile http://localhost:36568/getInfo.html) 06:13:44 INFO - PROCESS | 464 | 06:13:44 INFO - PROCESS | 464 | (process:534): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:13:45 INFO - PROCESS | 464 | __metrics Screen width/height:1600/1200 06:13:45 INFO - PROCESS | 464 | colorDepth:24 06:13:45 INFO - PROCESS | 464 | Browser inner width/height: 1024/697 06:13:45 INFO - PROCESS | 464 | __metrics 06:13:45 ERROR - PROCESS | 464 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:13:46 INFO - TEST-INFO | 464: exit 0 06:13:46 INFO - Browser initialized. 06:13:46 INFO - Running cycle 1/1 for kraken test... 06:13:46 INFO - TEST-INFO | started process 585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3g2Nsh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:48 INFO - PROCESS | 585 | 06:13:48 INFO - PROCESS | 585 | (process:649): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:13:58 INFO - PROCESS | 585 | RSS: Main: 164884480 06:13:58 INFO - PROCESS | 585 | 06:14:01 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36568/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:01 INFO - PROCESS | 585 | RSS: Main: 169365504 06:14:01 INFO - PROCESS | 585 | 06:14:04 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36568/tests/kraken/driver.html?testName=audio-dft) 06:14:05 INFO - PROCESS | 585 | RSS: Main: 172806144 06:14:05 INFO - PROCESS | 585 | 06:14:08 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36568/tests/kraken/driver.html?testName=audio-fft) 06:14:08 INFO - PROCESS | 585 | RSS: Main: 163229696 06:14:08 INFO - PROCESS | 585 | 06:14:10 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36568/tests/kraken/driver.html?testName=audio-oscillator) 06:14:11 INFO - PROCESS | 585 | RSS: Main: 163028992 06:14:11 INFO - PROCESS | 585 | 06:14:13 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36568/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:14 INFO - PROCESS | 585 | RSS: Main: 164708352 06:14:14 INFO - PROCESS | 585 | 06:14:17 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36568/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:17 INFO - PROCESS | 585 | RSS: Main: 165019648 06:14:17 INFO - PROCESS | 585 | 06:14:21 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36568/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:21 INFO - PROCESS | 585 | RSS: Main: 165281792 06:14:21 INFO - PROCESS | 585 | 06:14:24 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36568/tests/kraken/driver.html?testName=json-parse-financial) 06:14:25 INFO - PROCESS | 585 | RSS: Main: 167247872 06:14:25 INFO - PROCESS | 585 | 06:14:26 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36568/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:27 INFO - PROCESS | 585 | RSS: Main: 167202816 06:14:27 INFO - PROCESS | 585 | 06:14:29 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36568/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:30 INFO - PROCESS | 585 | RSS: Main: 167313408 06:14:30 INFO - PROCESS | 585 | 06:14:32 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36568/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:32 INFO - PROCESS | 585 | RSS: Main: 167583744 06:14:32 INFO - PROCESS | 585 | 06:14:35 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:35 INFO - PROCESS | 585 | RSS: Main: 168013824 06:14:35 INFO - PROCESS | 585 | 06:14:38 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:39 INFO - PROCESS | 585 | RSS: Main: 168300544 06:14:39 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | Cycle 1(1): loaded http://localhost:36568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36568/tests/kraken/driver.html?testName=ai-astar) 06:14:41 INFO - PROCESS | 585 | RSS: Main: 169885696 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | __start_tp_report 06:14:41 INFO - PROCESS | 585 | _x_x_mozilla_page_load 06:14:41 INFO - PROCESS | 585 | _x_x_mozilla_page_load_details 06:14:41 INFO - PROCESS | 585 | |i|pagename|runs| 06:14:41 INFO - PROCESS | 585 | |0;ai-astar;111;108;114;113;113;124;114;111;111;111 06:14:41 INFO - PROCESS | 585 | |1;audio-beat-detection;154;128;163;179;130;158;152;127;177;127 06:14:41 INFO - PROCESS | 585 | |2;audio-dft;162;161;162;160;161;164;174;163;166;162 06:14:41 INFO - PROCESS | 585 | |3;audio-fft;76;76;73;157;73;75;72;77;176;74 06:14:41 INFO - PROCESS | 585 | |4;audio-oscillator;93;93;150;93;92;92;149;92;91;146 06:14:41 INFO - PROCESS | 585 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;117;119;118 06:14:41 INFO - PROCESS | 585 | |6;imaging-darkroom;147;147;148;147;147;147;146;149;148;147 06:14:41 INFO - PROCESS | 585 | |7;imaging-desaturate;95;95;97;95;95;95;96;96;95;96 06:14:41 INFO - PROCESS | 585 | |8;json-parse-financial;60;60;59;60;60;60;60;75;62;58 06:14:41 INFO - PROCESS | 585 | |9;json-stringify-tinderbox;61;61;62;62;61;61;61;63;61;62 06:14:41 INFO - PROCESS | 585 | |10;stanford-crypto-aes;77;77;79;77;78;78;78;78;87;79 06:14:41 INFO - PROCESS | 585 | |11;stanford-crypto-ccm;135;124;126;126;127;134;128;154;156;130 06:14:41 INFO - PROCESS | 585 | |12;stanford-crypto-pbkdf2;176;167;166;174;170;169;169;170;165;169 06:14:41 INFO - PROCESS | 585 | |13;stanford-crypto-sha256-iterative;70;70;69;69;69;71;78;67;69;77 06:14:41 INFO - PROCESS | 585 | __end_tp_report 06:14:41 INFO - PROCESS | 585 | __start_cc_report 06:14:41 INFO - PROCESS | 585 | _x_x_mozilla_cycle_collect,853 06:14:41 INFO - PROCESS | 585 | __end_cc_report 06:14:41 INFO - PROCESS | 585 | __startTimestamp1461417281374__endTimestamp 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | ------- Summary: start ------- 06:14:41 INFO - PROCESS | 585 | Number of tests: 14 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:4.27 (3.8%) stddev-sans-first:4.47 06:14:41 INFO - PROCESS | 585 | Values: 111.0 108.0 114.0 113.0 113.0 124.0 114.0 111.0 111.0 111.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:156.00 stddev:20.45 (13.1%) stddev-sans-first:21.62 06:14:41 INFO - PROCESS | 585 | Values: 154.0 128.0 163.0 179.0 130.0 158.0 152.0 127.0 177.0 127.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#2] audio-dft Cycles:10 Average:163.50 Median:162.50 stddev:4.06 (2.5%) stddev-sans-first:4.27 06:14:41 INFO - PROCESS | 585 | Values: 162.0 161.0 162.0 160.0 161.0 164.0 174.0 163.0 166.0 162.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#3] audio-fft Cycles:10 Average:92.90 Median:74.50 stddev:39.08 (52.5%) stddev-sans-first:40.97 06:14:41 INFO - PROCESS | 585 | Values: 76.0 76.0 73.0 157.0 73.0 75.0 72.0 77.0 176.0 74.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:27.10 (29.5%) stddev-sans-first:28.11 06:14:41 INFO - PROCESS | 585 | Values: 93.0 93.0 150.0 93.0 92.0 92.0 149.0 92.0 91.0 146.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 06:14:41 INFO - PROCESS | 585 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 119.0 118.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 06:14:41 INFO - PROCESS | 585 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 146.0 149.0 148.0 147.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 06:14:41 INFO - PROCESS | 585 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:60.00 stddev:4.88 (8.1%) stddev-sans-first:5.15 06:14:41 INFO - PROCESS | 585 | Values: 60.0 60.0 59.0 60.0 60.0 60.0 60.0 75.0 62.0 58.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 06:14:41 INFO - PROCESS | 585 | Values: 61.0 61.0 62.0 62.0 61.0 61.0 61.0 63.0 61.0 62.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:2.97 (3.8%) stddev-sans-first:3.08 06:14:41 INFO - PROCESS | 585 | Values: 77.0 77.0 79.0 77.0 78.0 78.0 78.0 78.0 87.0 79.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:132.00 stddev:11.61 (8.8%) stddev-sans-first:12.31 06:14:41 INFO - PROCESS | 585 | Values: 135.0 124.0 126.0 126.0 127.0 134.0 128.0 154.0 156.0 130.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:169.50 stddev:3.37 (2.0%) stddev-sans-first:2.64 06:14:41 INFO - PROCESS | 585 | Values: 176.0 167.0 166.0 174.0 170.0 169.0 169.0 170.0 165.0 169.0 06:14:41 INFO - PROCESS | 585 | 06:14:41 INFO - PROCESS | 585 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.00 stddev:3.63 (5.2%) stddev-sans-first:3.84 06:14:41 INFO - PROCESS | 585 | Values: 70.0 70.0 69.0 69.0 69.0 71.0 78.0 67.0 69.0 77.0 06:14:41 INFO - PROCESS | 585 | -------- Summary: end -------- 06:14:41 INFO - PROCESS | 585 | 06:14:42 INFO - TEST-INFO | 585: exit 0 06:14:42 INFO - TEST-OK | kraken | took 61592ms 06:14:42 INFO - SUITE-END | took 1170s 06:14:42 INFO - Completed test suite (00:19:30) 06:14:42 INFO - javascript benchmark 06:14:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.4642510773165, 3201.1516948008775, 3204.7916885402433, 3234.85443155058, 3237.7733558650903, 5219.8695032624155, 5248.396434410044, 5271.393789714184, 5323.1749078892735, 5401.729913504324, 5277.788888444457, 5319.680819150844, 5426.538744206738, 5439.673619582818, 5505.119180931052, 4949.084419382417, 4994.850154495371, 5044.571211447032, 5052.418971818232, 5115.2327150927285, 616.5198612326615, 4925.926111108336, 5006.724630145341, 5034.0, 5052.823151189709, 4953.777080031389, 4957.405111386639, 4987.326710894019, 4988.8752781180765, 5001.724905130234, 4871.0, 5075.162598171334, 5084.694918304876, 5091.389033316026, 5096.311393517973, 4829.1307564638355, 4836.322914791932, 4846.030793841246, 4853.563179313844, 4882.853514394574, 5259.658122222043, 5282.498162674578, 5288.762005709752, 5291.391489978663, 5312.840614781563, 5677.886442271173, 5695.77216911323, 5701.4013528579735, 5708.800191993302, 5724.856878578027, 5731.254936858223, 5739.512141467981, 5744.540436765049, 5748.367679555246, 5808.8838223235725, 5356.303680521546, 5360.088784906575, 5367.624266301322, 5376.086065368897, 5378.865528361783, 5727.627704199213, 5828.94171058284, 5927.377625349276, 5965.612235204698, 6014.1580178775, 5721.742521586539, 5745.1382292656435, 5746.540276777848, 5761.452661997104, 5761.625494342854, 5794.072948328331, 5794.50746686528, 5806.767729290866, 5812.186293918855, 5815.9709201453725, 5608.831735047955, 5784.768609255582, 5802.303723553201, 5830.82507524775, 5873.471387575139, 5570.080936645408, 5757.971210143923, 5804.5356371491025, 5813.447722466443, 5834.387389324144, 4347.0, 4348.34774783785, 4403.9779801100785, 4426.84506042287, 4471.8434854779925, 3859.614038596118, 3860.0735823402183, 3898.863539776094, 3912.784796836201, 3946.960530394659, 5536.833894983157, 5550.583706221969, 5556.138798486241, 5562.610617256753, 5616.887662246814, 5707.74315155819, 5797.536197104221, 5850.23946886902, 5874.206982057368, 5894.911576326359, 5484.122540393598, 5505.779768809283, 5515.61390702655, 5550.16747487872, 5576.33084029919, 4986.576141027981, 4999.950000500021, 5001.7499125043605, 5004.549590536869, 5045.8738531537, 5861.970690146607, 5985.491233245136, 5988.101784732238, 5995.580309378389, 6023.247094113236, 5789.45000224978, 5821.825345239649, 5824.883502330014, 5825.271841019872, 5847.38602446737, 5916.112583112567, 5964.284285885721, 5964.314103877936, 5964.8807023860145, 5966.850828729316, 5589.441055894541, 5692.231548740867, 5703.800366987136, 5730.885382292414, 5770.740316685676, 5643.689597072201, 5681.914771278517, 5684.9431505684415, 5687.914681279867, 5750.0, 5551.278333816578, 5555.138953462219, 5558.221848941071, 5568.331800184003, 5571.860703482445, 5531.557475402039, 5558.694271814928, 5721.313442386774, 5770.711464426678, 5801.912971305349, 5475.863103422446, 5538.141588053858, 5547.306586676666, 5556.111022236423, 5569.888602228014, 5532.474414930575, 5739.282589676291, 5768.394318596487, 5804.1293805929445, 5831.387704291158, 5599.552035837205, 5600.411956744483, 5618.04493236159, 5626.971865140648, 5627.155926611041], "value": 5304.411371586723, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.4555263604846, 619.8853212155755, 636.2778246690007, 636.9712913644463, 655.606636018389, 38616.0, 39916.0, 39928.80035599825, 39983.99999999996, 40136.39795403071, 41932.58067419325, 42666.57333426665, 42757.358639620354, 42805.78597107018, 42846.357304640456, 8490.57547122646, 8748.650053997833, 8758.60586273616, 8759.386842920998, 8767.0, 8820.823583528325, 8932.0, 8976.057513961037, 8981.191692747652, 9000.59497322622, 8961.193492585666, 8987.640494380217, 8995.190432861042, 8996.235319997775, 9055.275577953747, 8908.064653211417, 8983.146601072887, 8987.37088403812, 8998.910010899905, 9003.324750643662, 8807.823843523158, 8884.511351875644, 8925.196732294125, 8933.0, 8956.507392093432, 41410.585894140975, 41664.375034374505, 41816.1636767266, 41962.37056444156, 41971.7901410494, 3382.238996225854, 3457.4468085106514, 3482.0, 3519.5424594802766, 3525.8589656413715, 31950.520742188884, 32597.0, 32685.0, 32891.83554082238, 32916.177095572566, 4216.156768646252, 4268.146370725867, 4295.871123866289, 4362.1275744851155, 4370.759608221547, 214872.0, 218643.0, 218674.0, 219491.0, 219728.0, 54627.72686136544, 54715.0, 55059.72470137624, 55096.44903550913, 55182.0, 64373.356266436735, 66510.33489665139, 66731.0, 66780.6660966692, 66805.0, 16829.41097061597, 17065.7440138398, 17121.743173852403, 17124.058176800394, 17125.14374281281, 11891.524339026342, 11939.582114625946, 11977.281363118242, 11988.580399686143, 12003.279803211835, 19179.257899043852, 19515.90242048809, 19693.704594431096, 20280.391588252376, 20314.492137696674, 7091.030669580918, 7246.239144889816, 7277.3086556777025, 7327.560346379234, 7463.776086717407, 1087.1302957633861, 1104.6741211342512, 1105.8949399807007, 1190.9523619055315, 1200.7058270723728, 31311.53032704511, 31516.527252091237, 31580.52629210564, 31690.207744806103, 32631.510527341634, 1081.5233116163897, 1136.3295954946216, 1187.9346635935105, 1294.8446186457686, 1299.9220046797034, 16745.916270418813, 16777.91611041937, 16916.577085572713, 17180.656386872193, 17395.636146258894, 471645.0, 479430.0, 479659.0, 480157.78974366555, 480750.0, 58190.0, 58611.0, 58849.0, 59021.0, 59061.70469147627, 1359.5309618181711, 1396.5670642100981, 1402.4530433131088, 1407.8310602727738, 1424.181095869879, 30344.241393964443, 30607.387852243275, 30840.0, 31230.687693123687, 32050.0, 51169.744151280494, 52212.477875220764, 52212.738936305075, 52312.738436307576, 52551.0, 422785.0, 425042.0, 425273.0, 426364.0, 426373.0, 28869.855650721613, 42415.0, 43422.34866476942, 43625.0, 44326.77836610797, 41776.58223417727, 43122.568774311854, 47945.0, 49675.50324496709, 50333.0, 38845.805770972096, 39398.21203575855, 39434.0, 39733.20533589254, 40012.799936000134, 37989.81005094957, 38903.80548097241, 38992.415113772746, 40160.0, 40373.798131009156, 40294.79852600718, 42402.575974239866, 42952.78523607362, 44028.559714403724, 44086.33870492009, 33033.66966330306, 36027.27945441129, 36277.0, 36421.0, 36577.81711091534, 27525.587116193674, 27880.58179127274, 27907.72092279051, 28007.299817504725, 28069.298267543476], "value": 20011.3981932261, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.351702106419, 385.5989770638537, 393.1841429034753, 397.58452417224, 403.26203048421394, 16751.748723769153, 18088.276468941225, 18243.270269189234, 18245.452636420894, 18245.54386140344, 17879.64240715185, 18375.44873653789, 18527.722084168716, 18772.53068673284, 18904.825945016328, 5441.347038355403, 5445.918311225335, 5642.633228840133, 5682.346530149044, 5685.715714214293, 5460.726963651821, 5522.834314970557, 5526.972365138168, 5542.63972841766, 5546.195801608765, 5265.341832270966, 5463.289772329592, 5472.370677372093, 5488.53347465466, 5492.505674489295, 5500.42245564218, 5515.586331025189, 5539.030669632818, 5541.362743284533, 5556.388797232301, 4847.466778654345, 4857.53853383928, 4898.706077635354, 4902.4362198346935, 4958.033183529214, 21684.78315216859, 21761.455963600878, 21982.0, 22058.779412205833, 22098.226562070413, 2140.3364956863265, 2273.8294627902974, 2324.0936034946385, 2611.6343711880354, 2632.736726327371, 14014.509492167725, 14179.078359906676, 14356.282185890665, 14445.0, 14473.710525789531, 1773.379317238969, 1812.7371531128044, 1834.8440382567499, 1841.686913224755, 1876.5777700017386, 50748.0, 69548.30451695519, 69653.0, 71933.28066719318, 72027.63986180088, 9615.807683846284, 10040.447775372424, 10136.746581335377, 10181.847272290921, 10300.536475858455, 14019.1588504688, 14157.433702651779, 14164.716705665829, 14215.644608884653, 14228.359723812453, 8055.476394034369, 8061.153578874251, 8270.627821748036, 8292.958535207285, 8330.750077497685, 8080.909077274493, 8125.4312198146745, 8173.182681731898, 8295.377846661524, 8313.501189928624, 6241.906371404432, 6274.090256912722, 6342.302346741854, 6397.392247736458, 6425.903611445832, 1874.7000479923147, 1877.9061046947597, 1911.3405874973112, 1942.7765806932384, 1944.0862794486568, 998.7203582996773, 1032.02989190161, 1065.3128731967993, 1135.5174051028446, 1176.9117316201318, 18388.540286492946, 18414.17136228873, 18806.153723082494, 18934.43196704101, 18979.90510047441, 1057.8836328003913, 1070.8500809886623, 1080.0819303591884, 1092.6940456671985, 1097.643265938557, 10447.68656940293, 10755.924407559338, 10883.129349652008, 10943.781124377469, 11027.889721102847, 501648.0, 509742.0, 511360.0, 516882.24676629883, 521403.0, 49982.75008624933, 58920.705396472746, 82225.17774822295, 83831.5808420954, 84261.15738842533, 1044.7805960748176, 1075.113031748826, 1079.8704155501391, 1093.1637297467444, 1099.8955099265556, 15992.680146396775, 16063.277152527931, 16086.43697470583, 16208.594785130466, 16408.589785255463, 35772.821135894155, 35867.82066089653, 35936.82031589825, 36104.819475902455, 36133.63866361303, 47049.52950470588, 48018.0, 49463.25805112854, 49491.0, 50880.0, 7878.251566101211, 7942.166072562298, 8063.798405039921, 8064.3548516119745, 8315.334773218248, 12279.815802762787, 12503.499860005499, 13008.089433739548, 13241.404136813673, 13260.867391325963, 10658.14734821228, 10931.617393391192, 11356.886431135583, 11537.423128843691, 11820.349880756641, 9341.392809467363, 11272.718182045515, 11350.978411942964, 11608.361540115036, 11620.954114129769, 10971.808755069944, 11626.186166968231, 12027.699307517381, 12052.397380130784, 12112.93943530312, 7943.165967573553, 8193.180681931759, 8313.168683131638, 8423.115572865006, 8489.95755021221, 10732.67801965911, 11275.548978040786, 11380.601678941197, 11562.421878906189, 11682.12384071181], "value": 9013.449249991338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.8931174817765, 1542.2982542942962, 1688.2909178145178, 1760.9647807043852, 1827.7167039108936, 7377.151627562832, 7889.5266284023, 7974.880376794353, 8204.794880128, 8223.58882055897, 7995.040595128578, 8005.839883202332, 8010.279074883259, 8015.118336982927, 8060.959695201515, 2265.275111964172, 2286.16554957441, 2286.6912966749524, 2294.7475777664527, 2294.9655755163685, 2236.2173239366252, 2243.55128974205, 2292.117534749117, 2302.8618282902994, 2303.0327262549768, 2270.2962081754627, 2270.704808374909, 2281.0, 2299.37916762474, 2319.5940710375703, 2246.764089770575, 2254.9887250563643, 2263.818894488437, 2264.1396269417596, 2264.626336654458, 2217.955640887173, 2219.145628932856, 2220.0897631970815, 2221.677856710768, 2222.0445208560313, 8219.671213151467, 8264.628091735887, 8270.875936860952, 8277.0, 8316.085230624627, 4928.531789479994, 5073.543381095719, 5097.337346144977, 5124.256982737482, 5129.9230511542355, 3137.654857965622, 3164.256399746058, 3198.424283628946, 3216.2120280531185, 3276.115448828803, 1048.4024106259435, 1055.145332280855, 1059.1156384419019, 1064.8562444070028, 1067.8344856547249, 11338.206325557214, 11338.773224535464, 11340.829887551694, 11349.0, 11354.545818167264, 4223.429836971969, 4247.384129301234, 4364.71629344098, 4388.429504164438, 4401.867943961686, 9690.806183876424, 9701.951490242503, 9738.805223895624, 9758.024197580186, 9786.608535658635, 5041.949580504222, 5059.241113832881, 5077.39071311445, 5086.262491938648, 5100.183970564766, 4092.3043082676018, 4454.420925279693, 4547.886302842389, 4581.5647513486165, 4638.350630911675, 3769.660730534265, 3794.867179648699, 3812.7712337259854, 3893.96106038936, 3896.220755848785, 1244.6452760963082, 1250.1249125612107, 1254.0970501239094, 1263.6524955637274, 1288.3043156695467, 950.6292545906964, 978.6379039755336, 985.4432245781111, 996.531630133836, 1003.8142943555465, 5479.917801232985, 5575.804846830341, 5629.859253518613, 5639.774409023676, 5667.773289068474, 405.65924623316556, 406.8392984771058, 408.31403242552204, 413.4542404026716, 426.3987777234085, 3909.081365879016, 3932.4691166692132, 3940.665043471337, 3945.743526670757, 3987.940180897289, 9899.0, 10206.183505319557, 10258.58965641381, 10335.534900929477, 10342.431166285927, 9990.250731195189, 10066.848997265048, 10238.18094552449, 10246.180305575535, 10253.282270241012, 7680.193579674054, 7706.07527096752, 7775.766726998199, 7840.33357164636, 7946.602669866484, 5511.807086751945, 5566.832995010156, 5568.888622227451, 5634.577406694432, 5777.595568310178, 9372.203362713974, 9385.15533601979, 9421.670241541513, 9437.528123593656, 9490.335676502578, 9071.637134514545, 9299.86050209261, 9356.532173391439, 9365.391249568756, 9479.526023698925, 6664.400203981665, 7094.148702155774, 7107.609081500567, 7305.050343455317, 7336.156342020736, 7892.881606776018, 7937.801554961172, 7944.165862584577, 7993.72021979228, 7998.680052798056, 7071.893921591078, 7286.271372862671, 7310.451716121206, 7418.591977441292, 7422.665980030803, 7125.5368401053765, 7185.065941427581, 7238.472486240498, 7339.339459448675, 7411.295926886937, 6862.759803406857, 6885.311468853075, 6921.653917304216, 6921.930780692129, 6928.515003949675, 5036.395632523974, 5052.898942021213, 5054.140796064605, 5056.595472362275, 5092.516210959953, 5045.4450010498085, 5073.0, 5099.719515426687, 5125.666831655931, 5127.46161653021], "value": 4340.598940337262, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.5864434879006, 328.2155648001277, 332.89347408829167, 335.03342855860836, 335.15707994394086, 5902.173695682608, 5973.475649366873, 5985.533544281657, 6072.939270607299, 6080.908786368208, 5752.309722833266, 5824.534037277018, 5887.145549152014, 5973.074173503103, 5995.310539287983, 4512.052468981517, 4524.886877828048, 4526.6831321807485, 4534.798278456212, 4554.3168524721395, 4409.647228221735, 4552.494579174034, 4558.544145585432, 4564.589186973171, 4569.314602809589, 4496.685232033759, 4509.143262780078, 4521.615662668677, 4525.683202175849, 4556.817727290921, 4531.909361812762, 4541.931871021938, 4549.727016379012, 4562.292844609091, 4569.543045695437, 3698.14942563212, 3893.1045859452483, 3920.4318272690866, 3952.940705889414, 3981.292720949753, 5746.482816546531, 5787.247657804459, 5797.188393624896, 5807.680577568232, 5826.155207494932, 5205.427402985669, 5206.062908676437, 5245.973770131125, 5247.2159465781815, 5249.973750131263, 6023.728932198062, 6294.70958453516, 6318.494520438354, 6324.3043265240785, 6332.303446620868, 4294.355846623001, 4311.547287534827, 4311.82752689892, 4323.135372925428, 4332.3068309070395, 6276.278228003838, 6497.350264973512, 6583.506237032242, 6584.8024559263295, 6590.637514936677, 4359.782010899442, 4372.3878656988045, 4392.363107349416, 4398.186335527937, 4402.625776809007, 4431.379606855043, 4449.57729015743, 4453.42105526286, 4458.9331160032625, 4467.5532446755715, 5007.298978143063, 5178.8964220716125, 5184.688918664892, 5199.688018718889, 5206.344764170301, 6111.480524155497, 6330.024888302491, 6347.96826015867, 6358.904616430757, 6412.583182093243, 1487.8363380028188, 1515.4923100761368, 1521.254585253218, 1524.4283393727353, 1536.784850120984, 1011.2668315471371, 1013.7769690668041, 1027.1577306608658, 1029.156092004564, 1036.2953191829477, 6077.604955677867, 6116.296625887991, 6122.0, 6126.479249263773, 6130.693465326716, 6518.41487182048, 6525.771597994048, 6527.902081468782, 6528.608283503005, 6566.409023187936, 5990.610610310403, 6079.908801367983, 6129.295131059896, 6130.540209484307, 6164.599301045418, 3509.298140371885, 3515.7187425005936, 3537.752357335013, 3577.35607590631, 3584.8566057357934, 6544.312847151075, 6761.290064543152, 6766.966165169143, 6809.829754256183, 6839.2818754031105, 6715.414565392359, 6727.899081513781, 6739.865202695919, 6743.752405804942, 6751.459883209332, 6512.34876512345, 6721.764738234237, 6774.898376524257, 6794.592324460548, 6816.079829222991, 6538.215414150332, 6550.639714815731, 6552.63960482178, 6556.18047744032, 6586.50601204902, 6183.876322473615, 6460.289368169404, 6465.612063276219, 6494.7077381517, 6535.934640653722, 6765.864682706417, 6823.249442561215, 6832.521723479309, 6844.28135045813, 6844.59685764427, 4383.802728877145, 4403.867883963486, 4435.223835828781, 4441.822327107009, 4442.888927776831, 6245.500359971283, 6398.808035758934, 6597.340265973557, 6623.172103487064, 6651.600903945779, 6329.90505142414, 6381.744730210739, 6384.585001974857, 6403.423691867754, 6427.228732552124, 6157.476614487639, 6387.233531976192, 6393.392627700361, 6401.423871851555, 6411.102445657519, 6263.185785847811, 6283.277423096402, 6284.622922624657, 6295.842603934938, 6332.240131184103, 6365.3316401779, 6450.161928751334, 6455.903161452488, 6464.935350646621, 6478.676066196577, 5979.402059793986, 6235.314115447207, 6253.6560489173535, 6260.591366942402, 6269.122322874892], "value": 4747.1303266291925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.7889138269742, 848.3171047306918, 849.5370023337281, 856.901456332522, 864.278327596457, 13912.860871391284, 13941.442342306322, 13963.930180349096, 14024.298785060731, 14614.123152610851, 11516.0, 13357.666058348546, 13369.665758356046, 13374.331283435813, 13380.866191338084, 783.1698399696326, 813.446856137826, 814.4258297899967, 814.8085199978001, 818.7216346442209, 793.7182300283403, 802.0495712580581, 802.4423025996934, 802.4743792815685, 807.648672827319, 856.3021137772727, 857.7212405968054, 857.8027053777635, 857.9914200857974, 859.3511898516642, 840.4495055738502, 845.7716416567554, 847.4830353484369, 848.5587494502855, 849.6856163219586, 617.290116366178, 624.5378419969236, 627.3444250757968, 629.2071989293523, 630.2311180359953, 14146.080504767157, 14179.858201417957, 14251.78622320666, 14287.285635718172, 14288.428462861473, 14206.715865682629, 14300.785488217685, 14381.856181438156, 14398.208098554574, 14431.783523247159, 11502.0, 11587.47856346458, 11604.30374177552, 11666.824997625043, 11809.114316426216, 3844.2695887781233, 3859.59474255202, 3933.3116704576582, 3937.251922134785, 3972.523297204354, 56298.43701562973, 56919.71540142273, 58970.41029589735, 59069.704651476466, 59346.703266483826, 10925.945370273097, 11176.552937882556, 11176.888231117748, 11265.324080555192, 11291.435428228555, 20607.0, 20625.381238562866, 20648.483787905123, 20654.896725516275, 20709.68935465969, 8269.29710974562, 8318.750437486764, 8432.156784321642, 8481.787955301043, 8607.0, 4635.930461043087, 4653.325267836212, 4673.205555055649, 4911.8280860170435, 5054.595632349403, 3054.465468542996, 3147.0, 3151.5115157150676, 3158.842057897096, 3166.2875852933366, 642.1170890026214, 643.6942452335103, 651.9380658837498, 652.5725649699455, 653.0498125227782, 693.0505207865257, 696.5611664651237, 721.7473884140509, 747.3834086878347, 779.2402407652494, 9150.176484116462, 9426.628278886954, 9608.471534065693, 9628.374155679858, 9630.951845240728, 652.393274254938, 727.7743899391099, 748.7229725001675, 757.2843662738659, 767.0, 4106.630403263721, 4297.505786834554, 4319.827206911688, 4323.3947247385395, 4450.154470650631, 53313.0, 56026.71986640041, 66391.0, 66434.66782666152, 66561.0, 47521.04957900892, 47657.0, 48530.0, 48733.756331218116, 49796.50203497991, 49068.75465622649, 49180.0, 49968.0, 49974.750126249135, 50308.74845625748, 9382.624695012397, 9478.573464194265, 9610.95194524023, 9704.951475242578, 9707.174890134418, 32788.50817237791, 32932.1766955828, 33291.66708332886, 33722.66277337195, 34346.14134646654, 44160.77919610382, 45440.0, 46196.0, 46723.0, 46736.29895551501, 11810.17328787011, 12324.0, 12663.050271229511, 12796.296203708886, 12839.0, 13800.240986745424, 13853.37659805291, 14104.647383815487, 14273.57179284623, 14380.35288412003, 12827.871721282667, 13127.803082953955, 13199.802002970155, 13757.31213439344, 14240.786388203978, 13132.868671313165, 13194.0, 13244.337783110614, 13271.535496257584, 13403.396847141707, 12744.61766147017, 12930.482780688668, 13326.200427974352, 13727.588172354845, 13777.655558610713, 10782.514786834454, 10891.618793342195, 11061.446927653424, 11253.66239012831, 11506.94246528762, 10521.4739263035, 11128.221024528206, 11209.663710088711, 11263.943680281545, 11473.311601303949], "value": 6838.892805482096, "unit": "score"}], "name": "dromaeo_css", "value": 7160.926138256981, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 114.0, 113.0, 113.0, 124.0, 114.0, 111.0, 111.0, 111.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 163.0, 179.0, 130.0, 158.0, 152.0, 127.0, 177.0, 127.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 164.0, 174.0, 163.0, 166.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 73.0, 157.0, 73.0, 75.0, 72.0, 77.0, 176.0, 74.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 150.0, 93.0, 92.0, 92.0, 149.0, 92.0, 91.0, 146.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 149.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 75.0, 62.0, 58.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 63.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 79.0, 77.0, 78.0, 78.0, 78.0, 78.0, 87.0, 79.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 124.0, 126.0, 126.0, 127.0, 134.0, 128.0, 154.0, 156.0, 130.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 167.0, 166.0, 174.0, 170.0, 169.0, 169.0, 170.0, 165.0, 169.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 69.0, 69.0, 71.0, 78.0, 67.0, 69.0, 77.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1564.4, "alertThreshold": 2.0}]} 06:14:42 INFO - Return code: 0 06:14:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:14:42 ERROR - # TBPL SUCCESS # 06:14:42 INFO - Running post-action listener: _resource_record_post_action 06:14:42 INFO - Running post-run listener: _resource_record_post_run 06:14:43 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547762176; Read time: 12; Write time: 647228 06:14:43 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244600832; Read time: 0; Write time: 354280 06:14:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291205120; Read time: 12; Write time: 289196 06:14:43 INFO - Running post-run listener: _upload_blobber_files 06:14:43 INFO - Blob upload gear active. 06:14:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:43 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 06:14:43 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:14:43 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:14:44 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:14:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:44 INFO - (blobuploader) - INFO - Done attempting. 06:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:45 INFO - (blobuploader) - INFO - Done attempting. 06:14:45 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:45 INFO - Return code: 0 06:14:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9670d76e078b1d08ac9486e419a741458100c75d9acdff75e88f74616b2bbf190d643f4fd946e121889a1f74ff6aae7efd531a03da1ed847c71631e331cfed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/902f718c7025ee64528e50944dc3adfa40c7616d315d78dcb9f438e55d1913892a165a8b1a04c590420375e3515251cea861b1ed6ec5dc98bc2b3acb3862b7ce"} 06:14:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:45 INFO - Contents: 06:14:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9670d76e078b1d08ac9486e419a741458100c75d9acdff75e88f74616b2bbf190d643f4fd946e121889a1f74ff6aae7efd531a03da1ed847c71631e331cfed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/902f718c7025ee64528e50944dc3adfa40c7616d315d78dcb9f438e55d1913892a165a8b1a04c590420375e3515251cea861b1ed6ec5dc98bc2b3acb3862b7ce"} 06:14:45 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:45 INFO - Copying logs to upload dir... 06:14:45 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.485388 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-23 06:14:45.426122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 06:14:45.430278) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9670d76e078b1d08ac9486e419a741458100c75d9acdff75e88f74616b2bbf190d643f4fd946e121889a1f74ff6aae7efd531a03da1ed847c71631e331cfed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/902f718c7025ee64528e50944dc3adfa40c7616d315d78dcb9f438e55d1913892a165a8b1a04c590420375e3515251cea861b1ed6ec5dc98bc2b3acb3862b7ce"} build_url:https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/WH1NwIJaQniUaK54IX-jBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9670d76e078b1d08ac9486e419a741458100c75d9acdff75e88f74616b2bbf190d643f4fd946e121889a1f74ff6aae7efd531a03da1ed847c71631e331cfed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/902f718c7025ee64528e50944dc3adfa40c7616d315d78dcb9f438e55d1913892a165a8b1a04c590420375e3515251cea861b1ed6ec5dc98bc2b3acb3862b7ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 06:14:45.455138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:14:45.455464) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1461413601.123114-347926522 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:14:45.539019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 06:14:45.539365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 06:14:45.539679) ========= ========= Total master_lag: 0.17 =========