builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1463686126.43 results: success (0) buildid: 20160519093556 builduid: 8f0a6e4e1d5a45a1bf658c2f5a7a1d89 revision: adb760b8a144c049070c876dccbf228de868a953 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:46.432600) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:46.433063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:46.433343) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:46.446586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:46.446899) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 12:28:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 27.9M=0s 2016-05-19 12:28:46 (27.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121406 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:46.579357) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:46.579671) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017829 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:46.629494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:46.629862) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev adb760b8a144c049070c876dccbf228de868a953 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev adb760b8a144c049070c876dccbf228de868a953 --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=652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 12:28:46,764 truncating revision to first 12 chars 2016-05-19 12:28:46,764 Setting DEBUG logging. 2016-05-19 12:28:46,764 attempt 1/10 2016-05-19 12:28:46,764 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/adb760b8a144?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 12:28:47,072 unpacking tar archive at: mozilla-aurora-adb760b8a144/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586296 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:47.229116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:47.229444) ========= script_repo_revision: adb760b8a144c049070c876dccbf228de868a953 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:47.229850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:47.230118) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 12:28:47.239305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-05-19 12:28:47.239568) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:28:47 INFO - MultiFileLogger online at 20160519 12:28:47 in /builds/slave/test 12:28:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:28:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:28:47 INFO - {'append_to_log': False, 12:28:47 INFO - 'base_work_dir': '/builds/slave/test', 12:28:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:28:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:28:47 INFO - 'branch': 'Mozilla-Aurora', 12:28:47 INFO - 'buildbot_json_path': 'buildprops.json', 12:28:47 INFO - 'config_files': ('talos/linux_config.py',), 12:28:47 INFO - 'default_actions': ('clobber', 12:28:47 INFO - 'read-buildbot-config', 12:28:47 INFO - 'download-and-extract', 12:28:47 INFO - 'populate-webroot', 12:28:47 INFO - 'create-virtualenv', 12:28:47 INFO - 'install', 12:28:47 INFO - 'run-tests'), 12:28:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:28:47 INFO - 'download_minidump_stackwalk': True, 12:28:47 INFO - 'download_symbols': 'ondemand', 12:28:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:28:47 INFO - 'tooltool.py': '/tools/tooltool.py', 12:28:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:28:47 INFO - '/tools/misc-python/virtualenv.py')}, 12:28:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:28:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:28:47 INFO - 'installer_path': 'installer.exe', 12:28:47 INFO - 'log_level': 'info', 12:28:47 INFO - 'log_name': 'talos', 12:28:47 INFO - 'log_to_console': True, 12:28:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:28:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:28:47 INFO - 'opt_config_files': (), 12:28:47 INFO - 'pip_index': False, 12:28:47 INFO - 'sps_profile': False, 12:28:47 INFO - 'sps_profile_interval': 0, 12:28:47 INFO - 'suite': 'dromaeojs', 12:28:47 INFO - 'system_bits': '32', 12:28:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:28:47 INFO - 'title': 'talos-linux64-ix-046', 12:28:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:28:47 INFO - 'use_talos_json': True, 12:28:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:28:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:28:47 INFO - 'work_dir': 'build'} 12:28:47 INFO - ##### 12:28:47 INFO - ##### Running clobber step. 12:28:47 INFO - ##### 12:28:47 INFO - Running pre-action listener: _resource_record_pre_action 12:28:47 INFO - Running main action method: clobber 12:28:47 INFO - rmtree: /builds/slave/test/build 12:28:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:28:48 INFO - Running post-action listener: _resource_record_post_action 12:28:48 INFO - ##### 12:28:48 INFO - ##### Running read-buildbot-config step. 12:28:48 INFO - ##### 12:28:48 INFO - Running pre-action listener: _resource_record_pre_action 12:28:48 INFO - Running main action method: read_buildbot_config 12:28:48 INFO - Using buildbot properties: 12:28:48 INFO - { 12:28:48 INFO - "project": "", 12:28:48 INFO - "product": "firefox", 12:28:48 INFO - "script_repo_revision": "production", 12:28:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:28:48 INFO - "repository": "", 12:28:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:28:48 INFO - "buildid": "20160519093556", 12:28:48 INFO - "pgo_build": "True", 12:28:48 INFO - "basedir": "/builds/slave/test", 12:28:48 INFO - "buildnumber": 512, 12:28:48 INFO - "slavename": "talos-linux64-ix-046", 12:28:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:28:48 INFO - "platform": "ubuntu64_hw", 12:28:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:28:48 INFO - "branch": "mozilla-aurora", 12:28:48 INFO - "repo_path": "releases/mozilla-aurora", 12:28:48 INFO - "revision": "adb760b8a144c049070c876dccbf228de868a953", 12:28:48 INFO - "stage_platform": "linux64-pgo", 12:28:48 INFO - "builduid": "8f0a6e4e1d5a45a1bf658c2f5a7a1d89", 12:28:48 INFO - "slavebuilddir": "test" 12:28:48 INFO - } 12:28:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 12:28:48 INFO - Running post-action listener: _resource_record_post_action 12:28:48 INFO - ##### 12:28:48 INFO - ##### Running download-and-extract step. 12:28:48 INFO - ##### 12:28:48 INFO - Running pre-action listener: _resource_record_pre_action 12:28:48 INFO - Running main action method: download_and_extract 12:28:48 INFO - mkdir: /builds/slave/test/build/tests 12:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:48 INFO - https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:28:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:28:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:28:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:28:49 INFO - Downloaded 1361 bytes. 12:28:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:28:49 INFO - Using the following test package requirements: 12:28:49 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 12:28:49 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:28:49 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:28:49 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:49 INFO - u'jsshell-linux-x86_64.zip'], 12:28:49 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:28:49 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 12:28:49 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:28:49 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:28:49 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:28:49 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:49 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:28:49 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:28:49 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')]} 12:28:49 INFO - https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:28:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:28:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:28:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:28:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:36:04 INFO - Downloaded 23812152 bytes. 12:36:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:36:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:36:06 INFO - Return code: 0 12:36:06 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:06 INFO - https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:36:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:36:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:36:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:36:08 INFO - Downloaded 23812152 bytes. 12:36:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:36:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:36:09 INFO - Return code: 0 12:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:09 INFO - https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:36:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:36:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:36:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:36:10 INFO - Downloaded 10840145 bytes. 12:36:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:36:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:36:10 INFO - Return code: 0 12:36: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')]} 12:36:10 INFO - https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:36:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:36:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:36:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:36:22 INFO - Downloaded 62723233 bytes. 12:36:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:36:22 INFO - mkdir: /builds/slave/test/properties 12:36:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:36:22 INFO - Writing to file /builds/slave/test/properties/build_url 12:36:22 INFO - Contents: 12:36:22 INFO - build_url:https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:36:23 INFO - Running post-action listener: _resource_record_post_action 12:36:23 INFO - Running post-action listener: set_extra_try_arguments 12:36:23 INFO - ##### 12:36:23 INFO - ##### Running populate-webroot step. 12:36:23 INFO - ##### 12:36:23 INFO - Running pre-action listener: _resource_record_pre_action 12:36:23 INFO - Running main action method: populate_webroot 12:36:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:36:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:36:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:36:23 INFO - '--tppagecycles', 12:36:23 INFO - '7'], 12:36:23 INFO - 'tests': ['tsvgm']}}, 12:36:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:36:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:36:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:36:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:36:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:23 INFO - 'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:36:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:36:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:23 INFO - 'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['damp', 'tps']}, 12:36:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:23 INFO - 'tests': ['damp', 'tps']}, 12:36:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['dromaeo_dom']}, 12:36:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:36:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['a11yr', 12:36:23 INFO - 'ts_paint', 12:36:23 INFO - 'tpaint', 12:36:23 INFO - 'sessionrestore', 12:36:23 INFO - 'sessionrestore_no_auto_restore', 12:36:23 INFO - 'tabpaint']}, 12:36:23 INFO - 'other-e10s': {'tests': ['a11yr', 12:36:23 INFO - 'ts_paint', 12:36:23 INFO - 'tpaint', 12:36:23 INFO - 'sessionrestore', 12:36:23 INFO - 'sessionrestore_no_auto_restore', 12:36:23 INFO - 'tabpaint']}, 12:36:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:36:23 INFO - 'ts_paint', 12:36:23 INFO - 'tpaint', 12:36:23 INFO - 'sessionrestore', 12:36:23 INFO - 'sessionrestore_no_auto_restore', 12:36:23 INFO - 'tabpaint']}, 12:36:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:36:23 INFO - 'ts_paint', 12:36:23 INFO - 'tpaint', 12:36:23 INFO - 'sessionrestore', 12:36:23 INFO - 'sessionrestore_no_auto_restore', 12:36:23 INFO - 'tabpaint']}, 12:36:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['a11yr', 12:36:23 INFO - 'ts_paint', 12:36:23 INFO - 'tpaint', 12:36:23 INFO - 'sessionrestore', 12:36:23 INFO - 'sessionrestore_no_auto_restore', 12:36:23 INFO - 'tabpaint']}, 12:36:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['a11yr', 12:36:23 INFO - 'ts_paint', 12:36:23 INFO - 'tpaint', 12:36:23 INFO - 'sessionrestore', 12:36:23 INFO - 'sessionrestore_no_auto_restore', 12:36:23 INFO - 'tabpaint']}, 12:36:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['tsvgx', 12:36:23 INFO - 'tsvgr_opacity', 12:36:23 INFO - 'tart', 12:36:23 INFO - 'tscrollx', 12:36:23 INFO - 'cart']}, 12:36:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:36:23 INFO - 'tsvgr_opacity', 12:36:23 INFO - 'tart', 12:36:23 INFO - 'tscrollx', 12:36:23 INFO - 'cart']}, 12:36:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:23 INFO - 'talos_options': ['--disable-e10s'], 12:36:23 INFO - 'tests': ['tp5o']}, 12:36:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:23 INFO - 'tests': ['tp5o']}, 12:36:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:23 INFO - 'talos_options': ['--disable-e10s', 12:36:23 INFO - '--xperf_path', 12:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:36:23 INFO - 'tests': ['tp5n']}, 12:36:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:23 INFO - 'talos_options': ['--xperf_path', 12:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:36:23 INFO - 'tests': ['tp5n']}}, 12:36:23 INFO - 'talos.zip': {'path': '', 12:36:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:36:23 INFO - Running post-action listener: _resource_record_post_action 12:36:23 INFO - ##### 12:36:23 INFO - ##### Running create-virtualenv step. 12:36:23 INFO - ##### 12:36:23 INFO - Running pre-action listener: _resource_record_pre_action 12:36:23 INFO - Running main action method: create_virtualenv 12:36:23 INFO - Creating virtualenv /builds/slave/test/build/venv 12:36:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:36:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:36:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:36:23 INFO - Using real prefix '/usr' 12:36:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:36:24 INFO - Installing distribute.............................................................................................................................................................................................done. 12:36:26 INFO - Installing pip.................done. 12:36:26 INFO - Return code: 0 12:36:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:36: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')]} 12:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36: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')]} 12:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bb2e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', '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 12:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:36:26 INFO - Using env: {'DISPLAY': ':0', 12:36:26 INFO - 'HOME': '/home/cltbld', 12:36:26 INFO - 'LANG': 'en_US.UTF-8', 12:36:26 INFO - 'LANGUAGE': 'en_US:en', 12:36:26 INFO - 'LOGNAME': 'cltbld', 12:36:26 INFO - 'MAIL': '/var/mail/cltbld', 12:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:26 INFO - 'MOZ_NO_REMOTE': '1', 12:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:26 INFO - 'NO_EM_RESTART': '1', 12:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:26 INFO - 'PWD': '/builds/slave/test', 12:36:26 INFO - 'SHELL': '/bin/bash', 12:36:26 INFO - 'SHLVL': '1', 12:36:26 INFO - 'TERM': 'linux', 12:36:26 INFO - 'TMOUT': '86400', 12:36:26 INFO - 'USER': 'cltbld', 12:36:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:26 INFO - '_': '/tools/buildbot/bin/python'} 12:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:36:26 INFO - Cleaning up... 12:36:26 INFO - Return code: 0 12:36:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:36: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')]} 12:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36: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')]} 12:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bb2e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', '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 12:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:36:26 INFO - Using env: {'DISPLAY': ':0', 12:36:26 INFO - 'HOME': '/home/cltbld', 12:36:26 INFO - 'LANG': 'en_US.UTF-8', 12:36:26 INFO - 'LANGUAGE': 'en_US:en', 12:36:26 INFO - 'LOGNAME': 'cltbld', 12:36:26 INFO - 'MAIL': '/var/mail/cltbld', 12:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:26 INFO - 'MOZ_NO_REMOTE': '1', 12:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:26 INFO - 'NO_EM_RESTART': '1', 12:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:26 INFO - 'PWD': '/builds/slave/test', 12:36:26 INFO - 'SHELL': '/bin/bash', 12:36:26 INFO - 'SHLVL': '1', 12:36:26 INFO - 'TERM': 'linux', 12:36:26 INFO - 'TMOUT': '86400', 12:36:26 INFO - 'USER': 'cltbld', 12:36:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:26 INFO - '_': '/tools/buildbot/bin/python'} 12:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:26 INFO - Downloading/unpacking psutil>=0.7.1 12:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:36:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:36:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:36:28 INFO - Installing collected packages: psutil 12:36:28 INFO - Running setup.py install for psutil 12:36:28 INFO - building 'psutil._psutil_linux' extension 12:36:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:36:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:36:28 INFO - building 'psutil._psutil_posix' extension 12:36:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:36:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:36:29 INFO - Successfully installed psutil 12:36:29 INFO - Cleaning up... 12:36:29 INFO - Return code: 0 12:36:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bb2e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', '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 12:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:36:29 INFO - Using env: {'DISPLAY': ':0', 12:36:29 INFO - 'HOME': '/home/cltbld', 12:36:29 INFO - 'LANG': 'en_US.UTF-8', 12:36:29 INFO - 'LANGUAGE': 'en_US:en', 12:36:29 INFO - 'LOGNAME': 'cltbld', 12:36:29 INFO - 'MAIL': '/var/mail/cltbld', 12:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:29 INFO - 'MOZ_NO_REMOTE': '1', 12:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:29 INFO - 'NO_EM_RESTART': '1', 12:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:29 INFO - 'PWD': '/builds/slave/test', 12:36:29 INFO - 'SHELL': '/bin/bash', 12:36:29 INFO - 'SHLVL': '1', 12:36:29 INFO - 'TERM': 'linux', 12:36:29 INFO - 'TMOUT': '86400', 12:36:29 INFO - 'USER': 'cltbld', 12:36:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:29 INFO - '_': '/tools/buildbot/bin/python'} 12:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:36:31 INFO - Installing collected packages: mozsystemmonitor 12:36:31 INFO - Running setup.py install for mozsystemmonitor 12:36:31 INFO - Successfully installed mozsystemmonitor 12:36:31 INFO - Cleaning up... 12:36:31 INFO - Return code: 0 12:36:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:36: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')]} 12:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36: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')]} 12:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bb2e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', '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 12:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:36:31 INFO - Using env: {'DISPLAY': ':0', 12:36:31 INFO - 'HOME': '/home/cltbld', 12:36:31 INFO - 'LANG': 'en_US.UTF-8', 12:36:31 INFO - 'LANGUAGE': 'en_US:en', 12:36:31 INFO - 'LOGNAME': 'cltbld', 12:36:31 INFO - 'MAIL': '/var/mail/cltbld', 12:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:31 INFO - 'MOZ_NO_REMOTE': '1', 12:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:31 INFO - 'NO_EM_RESTART': '1', 12:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:31 INFO - 'PWD': '/builds/slave/test', 12:36:31 INFO - 'SHELL': '/bin/bash', 12:36:31 INFO - 'SHLVL': '1', 12:36:31 INFO - 'TERM': 'linux', 12:36:31 INFO - 'TMOUT': '86400', 12:36:31 INFO - 'USER': 'cltbld', 12:36:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:31 INFO - '_': '/tools/buildbot/bin/python'} 12:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:31 INFO - Downloading/unpacking blobuploader==1.2.4 12:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:33 INFO - Downloading blobuploader-1.2.4.tar.gz 12:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:36:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:36:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:34 INFO - Downloading docopt-0.6.1.tar.gz 12:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:36:34 INFO - Installing collected packages: blobuploader, requests, docopt 12:36:34 INFO - Running setup.py install for blobuploader 12:36:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:36:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:36:34 INFO - Running setup.py install for requests 12:36:34 INFO - Running setup.py install for docopt 12:36:34 INFO - Successfully installed blobuploader requests docopt 12:36:34 INFO - Cleaning up... 12:36:34 INFO - Return code: 0 12:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:36: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')]} 12:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36: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')]} 12:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bb2e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', '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 12:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:36:34 INFO - Using env: {'DISPLAY': ':0', 12:36:34 INFO - 'HOME': '/home/cltbld', 12:36:34 INFO - 'LANG': 'en_US.UTF-8', 12:36:34 INFO - 'LANGUAGE': 'en_US:en', 12:36:34 INFO - 'LOGNAME': 'cltbld', 12:36:34 INFO - 'MAIL': '/var/mail/cltbld', 12:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:34 INFO - 'MOZ_NO_REMOTE': '1', 12:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:34 INFO - 'NO_EM_RESTART': '1', 12:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:34 INFO - 'PWD': '/builds/slave/test', 12:36:34 INFO - 'SHELL': '/bin/bash', 12:36:34 INFO - 'SHLVL': '1', 12:36:34 INFO - 'TERM': 'linux', 12:36:34 INFO - 'TMOUT': '86400', 12:36:34 INFO - 'USER': 'cltbld', 12:36:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:34 INFO - '_': '/tools/buildbot/bin/python'} 12:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:36:35 INFO - Running setup.py (path:/tmp/pip-JpTVim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:36:35 INFO - Running setup.py (path:/tmp/pip-SzU7WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:36:35 INFO - Running setup.py (path:/tmp/pip-yPbK1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:36:35 INFO - Running setup.py (path:/tmp/pip-47xCG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:36:35 INFO - Running setup.py (path:/tmp/pip-fspVLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:36:35 INFO - Running setup.py (path:/tmp/pip-9gU8CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:36:35 INFO - Running setup.py (path:/tmp/pip-QV600O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:36:35 INFO - Running setup.py (path:/tmp/pip-lHGhsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:36:35 INFO - Running setup.py (path:/tmp/pip-ZVEaxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:36:35 INFO - Running setup.py (path:/tmp/pip-jYJ24w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:36:35 INFO - Running setup.py (path:/tmp/pip-GuDb5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:36:35 INFO - Running setup.py (path:/tmp/pip-sdQ46z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:36:35 INFO - Running setup.py (path:/tmp/pip-FspjfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:36:36 INFO - Running setup.py (path:/tmp/pip-ha5GGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:36:36 INFO - Running setup.py (path:/tmp/pip-sYvd5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:36:36 INFO - Running setup.py (path:/tmp/pip-xSgWBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:36:36 INFO - Running setup.py (path:/tmp/pip-I3JhWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:36:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:36:36 INFO - Running setup.py install for manifestparser 12:36:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:36:36 INFO - Running setup.py install for mozcrash 12:36:36 INFO - Running setup.py install for mozdebug 12:36:36 INFO - Running setup.py install for mozdevice 12:36:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:36:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:36:36 INFO - Running setup.py install for mozfile 12:36:36 INFO - Running setup.py install for mozhttpd 12:36:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:36:36 INFO - Running setup.py install for mozinfo 12:36:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:36:36 INFO - Running setup.py install for mozInstall 12:36:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Running setup.py install for mozleak 12:36:37 INFO - Running setup.py install for mozlog 12:36:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Running setup.py install for moznetwork 12:36:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Running setup.py install for mozprocess 12:36:37 INFO - Running setup.py install for mozprofile 12:36:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Running setup.py install for mozrunner 12:36:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:36:37 INFO - Running setup.py install for mozscreenshot 12:36:37 INFO - Running setup.py install for moztest 12:36:37 INFO - Running setup.py install for mozversion 12:36:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:36:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:36:38 INFO - Cleaning up... 12:36:38 INFO - Return code: 0 12:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bb2e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', '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 12:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:36:38 INFO - Using env: {'DISPLAY': ':0', 12:36:38 INFO - 'HOME': '/home/cltbld', 12:36:38 INFO - 'LANG': 'en_US.UTF-8', 12:36:38 INFO - 'LANGUAGE': 'en_US:en', 12:36:38 INFO - 'LOGNAME': 'cltbld', 12:36:38 INFO - 'MAIL': '/var/mail/cltbld', 12:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:38 INFO - 'MOZ_NO_REMOTE': '1', 12:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:38 INFO - 'NO_EM_RESTART': '1', 12:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:38 INFO - 'PWD': '/builds/slave/test', 12:36:38 INFO - 'SHELL': '/bin/bash', 12:36:38 INFO - 'SHLVL': '1', 12:36:38 INFO - 'TERM': 'linux', 12:36:38 INFO - 'TMOUT': '86400', 12:36:38 INFO - 'USER': 'cltbld', 12:36:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:38 INFO - '_': '/tools/buildbot/bin/python'} 12:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:36:38 INFO - Running setup.py (path:/tmp/pip-vwEntD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:36:38 INFO - Running setup.py (path:/tmp/pip-CyGYtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:36:38 INFO - Running setup.py (path:/tmp/pip-yv2mhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:36:38 INFO - Running setup.py (path:/tmp/pip-ZGkzVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:36:38 INFO - Running setup.py (path:/tmp/pip-Jr0vXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:36:38 INFO - Running setup.py (path:/tmp/pip-fBa7so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:36:38 INFO - Running setup.py (path:/tmp/pip-eVkNJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:36:38 INFO - Running setup.py (path:/tmp/pip-Sp3yod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:36:38 INFO - Running setup.py (path:/tmp/pip-B9pDXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:36:38 INFO - Running setup.py (path:/tmp/pip-a7qtAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:36:39 INFO - Running setup.py (path:/tmp/pip-aiEGX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:36:39 INFO - Running setup.py (path:/tmp/pip-ZaeIpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:36:39 INFO - Running setup.py (path:/tmp/pip-gllfDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:36:39 INFO - Running setup.py (path:/tmp/pip-6pfALQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:36:39 INFO - Running setup.py (path:/tmp/pip-CP5IhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:36:39 INFO - Running setup.py (path:/tmp/pip-qYpwtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:36:39 INFO - Running setup.py (path:/tmp/pip-tRRq7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:36:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36:42 INFO - Downloading blessings-1.6.tar.gz 12:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:36:42 INFO - Installing collected packages: blessings 12:36:42 INFO - Running setup.py install for blessings 12:36:42 INFO - Successfully installed blessings 12:36:42 INFO - Cleaning up... 12:36:42 INFO - Return code: 0 12:36:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:36:42 INFO - Reading from file tmpfile_stdout 12:36:42 INFO - Current package versions: 12:36:42 INFO - argparse == 1.2.1 12:36:42 INFO - blessings == 1.6 12:36:42 INFO - blobuploader == 1.2.4 12:36:42 INFO - docopt == 0.6.1 12:36:42 INFO - manifestparser == 1.1 12:36:42 INFO - mozInstall == 1.12 12:36:42 INFO - mozcrash == 0.17 12:36:42 INFO - mozdebug == 0.1 12:36:42 INFO - mozdevice == 0.48 12:36:42 INFO - mozfile == 1.2 12:36:42 INFO - mozhttpd == 0.7 12:36:42 INFO - mozinfo == 0.9 12:36:42 INFO - mozleak == 0.1 12:36:42 INFO - mozlog == 3.1 12:36:42 INFO - moznetwork == 0.27 12:36:42 INFO - mozprocess == 0.22 12:36:42 INFO - mozprofile == 0.28 12:36:42 INFO - mozrunner == 6.11 12:36:42 INFO - mozscreenshot == 0.1 12:36:42 INFO - mozsystemmonitor == 0.0 12:36:42 INFO - moztest == 0.7 12:36:42 INFO - mozversion == 1.4 12:36:42 INFO - psutil == 3.1.1 12:36:42 INFO - requests == 1.2.3 12:36:42 INFO - wsgiref == 0.1.2 12:36:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:42 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 0x7f6bb2e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', '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 12:36:42 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 12:36:42 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 12:36:42 INFO - Using env: {'DISPLAY': ':0', 12:36:42 INFO - 'HOME': '/home/cltbld', 12:36:42 INFO - 'LANG': 'en_US.UTF-8', 12:36:42 INFO - 'LANGUAGE': 'en_US:en', 12:36:42 INFO - 'LOGNAME': 'cltbld', 12:36:42 INFO - 'MAIL': '/var/mail/cltbld', 12:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:42 INFO - 'MOZ_NO_REMOTE': '1', 12:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:42 INFO - 'NO_EM_RESTART': '1', 12:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:42 INFO - 'PWD': '/builds/slave/test', 12:36:42 INFO - 'SHELL': '/bin/bash', 12:36:42 INFO - 'SHLVL': '1', 12:36:42 INFO - 'TERM': 'linux', 12:36:42 INFO - 'TMOUT': '86400', 12:36:42 INFO - 'USER': 'cltbld', 12:36:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:42 INFO - '_': '/tools/buildbot/bin/python'} 12:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:36:42 INFO - Cleaning up... 12:36:42 INFO - Return code: 0 12:36:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bb2e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', '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 12:36:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:36:42 INFO - Using env: {'DISPLAY': ':0', 12:36:42 INFO - 'HOME': '/home/cltbld', 12:36:42 INFO - 'LANG': 'en_US.UTF-8', 12:36:42 INFO - 'LANGUAGE': 'en_US:en', 12:36:42 INFO - 'LOGNAME': 'cltbld', 12:36:42 INFO - 'MAIL': '/var/mail/cltbld', 12:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:42 INFO - 'MOZ_NO_REMOTE': '1', 12:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:42 INFO - 'NO_EM_RESTART': '1', 12:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:42 INFO - 'PWD': '/builds/slave/test', 12:36:42 INFO - 'SHELL': '/bin/bash', 12:36:42 INFO - 'SHLVL': '1', 12:36:42 INFO - 'TERM': 'linux', 12:36:42 INFO - 'TMOUT': '86400', 12:36:42 INFO - 'USER': 'cltbld', 12:36:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:42 INFO - '_': '/tools/buildbot/bin/python'} 12:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:43 INFO - Downloading/unpacking jsonschema 12:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:36:45 INFO - Downloading/unpacking functools32 (from jsonschema) 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36:45 INFO - Downloading functools32-3.2.3-2.tar.gz 12:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:36:45 INFO - warning: no files found matching '*.txt' 12:36:45 INFO - no previously-included directories found matching 'build' 12:36:45 INFO - no previously-included directories found matching 'dist' 12:36:45 INFO - no previously-included directories found matching '.git*' 12:36:45 INFO - Installing collected packages: jsonschema, functools32 12:36:45 INFO - Running setup.py install for functools32 12:36:45 INFO - warning: no files found matching '*.txt' 12:36:45 INFO - no previously-included directories found matching 'build' 12:36:45 INFO - no previously-included directories found matching 'dist' 12:36:45 INFO - no previously-included directories found matching '.git*' 12:36:45 INFO - Successfully installed jsonschema functools32 12:36:45 INFO - Cleaning up... 12:36:45 INFO - Return code: 0 12:36:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:36:45 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')]} 12:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:45 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')]} 12:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:45 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 0x7f6bb2e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', '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 12:36:45 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 12:36:45 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 12:36:45 INFO - Using env: {'DISPLAY': ':0', 12:36:45 INFO - 'HOME': '/home/cltbld', 12:36:45 INFO - 'LANG': 'en_US.UTF-8', 12:36:45 INFO - 'LANGUAGE': 'en_US:en', 12:36:45 INFO - 'LOGNAME': 'cltbld', 12:36:45 INFO - 'MAIL': '/var/mail/cltbld', 12:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:45 INFO - 'MOZ_NO_REMOTE': '1', 12:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:45 INFO - 'NO_EM_RESTART': '1', 12:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:36:45 INFO - 'PWD': '/builds/slave/test', 12:36:45 INFO - 'SHELL': '/bin/bash', 12:36:45 INFO - 'SHLVL': '1', 12:36:45 INFO - 'TERM': 'linux', 12:36:45 INFO - 'TMOUT': '86400', 12:36:45 INFO - 'USER': 'cltbld', 12:36:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:45 INFO - '_': '/tools/buildbot/bin/python'} 12:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:45 INFO - Downloading/unpacking flake8 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:36:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:36:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36: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 12:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:36:48 INFO - no previously-included directories found matching 'docs/_build' 12:36:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:36:48 INFO - Running setup.py install for pep8 12:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:36:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:36:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:36:48 INFO - no previously-included directories found matching 'docs/_build' 12:36:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:36:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:36:48 INFO - Cleaning up... 12:36:48 INFO - Return code: 0 12:36:48 INFO - Running post-action listener: _resource_record_post_action 12:36:48 INFO - Running post-action listener: _start_resource_monitoring 12:36:48 INFO - Starting resource monitoring. 12:36:48 INFO - ##### 12:36:48 INFO - ##### Running install step. 12:36:48 INFO - ##### 12:36:48 INFO - Running pre-action listener: _resource_record_pre_action 12:36:48 INFO - Running main action method: install 12:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:36:49 INFO - Reading from file tmpfile_stdout 12:36:49 INFO - Detecting whether we're running mozinstall >=1.0... 12:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:36:49 INFO - Reading from file tmpfile_stdout 12:36:49 INFO - Output received: 12:36:49 INFO - Usage: mozinstall [options] installer 12:36:49 INFO - Options: 12:36:49 INFO - -h, --help show this help message and exit 12:36:49 INFO - -d DEST, --destination=DEST 12:36:49 INFO - Directory to install application into. [default: 12:36:49 INFO - "/builds/slave/test"] 12:36:49 INFO - --app=APP Application being installed. [default: firefox] 12:36:49 INFO - mkdir: /builds/slave/test/build/application 12:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:37:04 INFO - Reading from file tmpfile_stdout 12:37:04 INFO - Output received: 12:37:04 INFO - /builds/slave/test/build/application/firefox/firefox 12:37:04 INFO - Running post-action listener: _resource_record_post_action 12:37:04 INFO - ##### 12:37:04 INFO - ##### Running run-tests step. 12:37:04 INFO - ##### 12:37:04 INFO - Running pre-action listener: _resource_record_pre_action 12:37:04 INFO - Running main action method: run_tests 12:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:37:04 INFO - Python 2.7.3 12:37:04 INFO - Return code: 0 12:37:04 INFO - grabbing minidump binary from tooltool 12:37:04 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')]} 12:37:04 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 0x1189410>, '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 0x118a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:37:04 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 12:37:04 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 12:37:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:37:04 INFO - Return code: 0 12:37:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:37:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:37:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:37:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:37:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:37:05 INFO - Return code: 0 12:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:37:05 INFO - Using env: {'DISPLAY': ':0', 12:37:05 INFO - 'HOME': '/home/cltbld', 12:37:05 INFO - 'LANG': 'en_US.UTF-8', 12:37:05 INFO - 'LANGUAGE': 'en_US:en', 12:37:05 INFO - 'LOGNAME': 'cltbld', 12:37:05 INFO - 'MAIL': '/var/mail/cltbld', 12:37:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:37:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:05 INFO - 'MOZ_NO_REMOTE': '1', 12:37:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:05 INFO - 'NO_EM_RESTART': '1', 12:37:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:05 INFO - 'PWD': '/builds/slave/test', 12:37:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:37:05 INFO - 'SHELL': '/bin/bash', 12:37:05 INFO - 'SHLVL': '1', 12:37:05 INFO - 'TERM': 'linux', 12:37:05 INFO - 'TMOUT': '86400', 12:37:05 INFO - 'USER': 'cltbld', 12:37:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226', 12:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:05 INFO - '_': '/tools/buildbot/bin/python'} 12:37:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:37:06 INFO - mozversion application_buildid: 20160519093556 12:37:06 INFO - mozversion application_changeset: adb760b8a144c049070c876dccbf228de868a953 12:37:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:37:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:37:06 INFO - mozversion application_name: Firefox 12:37:06 INFO - mozversion application_remotingname: firefox-dev 12:37:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:37:06 INFO - mozversion application_vendor: Mozilla 12:37:06 INFO - mozversion application_version: 48.0a2 12:37:06 INFO - mozversion platform_buildid: 20160519093556 12:37:06 INFO - mozversion platform_changeset: adb760b8a144c049070c876dccbf228de868a953 12:37:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:37:06 INFO - mozversion platform_version: 48.0a2 12:37:06 INFO - using testdate: 1463686626 12:37:06 INFO - actual date: 1463686626 12:37:06 INFO - starting webserver on 'localhost:35984' 12:37:06 INFO - SUITE-START | Running 2 tests 12:37:06 INFO - TEST-START | dromaeo_css 12:37:06 INFO - operating with platform_type : linux_ 12:37:06 INFO - Initialising browser for dromaeo_css test... 12:37:06 INFO - TEST-INFO | started process 503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOdHeJM/profile http://localhost:35984/getInfo.html) 12:37:10 INFO - PROCESS | 503 | __metrics Screen width/height:1600/1200 12:37:10 INFO - PROCESS | 503 | colorDepth:24 12:37:10 INFO - PROCESS | 503 | Browser inner width/height: 1024/697 12:37:10 INFO - PROCESS | 503 | __metrics 12:37:11 ERROR - PROCESS | 503 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:37:11 INFO - TEST-INFO | 503: exit 0 12:37:11 INFO - Browser initialized. 12:37:11 INFO - Running cycle 1/1 for dromaeo_css test... 12:37:11 INFO - TEST-INFO | started process 595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOdHeJM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:37:23 INFO - PROCESS | 595 | RSS: Main: 141746176 12:37:23 INFO - PROCESS | 595 | 12:38:15 INFO - PROCESS | 595 | 1463686695256 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] 12:40:22 INFO - PROCESS | 595 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35984/tests/dromaeo/cssquery-ext.html) 12:40:23 INFO - PROCESS | 595 | RSS: Main: 250327040 12:40:23 INFO - PROCESS | 595 | 12:43:25 INFO - PROCESS | 595 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-ext.html (next: http://localhost:35984/tests/dromaeo/cssquery-jquery.html) 12:43:25 INFO - PROCESS | 595 | RSS: Main: 224935936 12:43:25 INFO - PROCESS | 595 | 12:46:27 INFO - PROCESS | 595 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35984/tests/dromaeo/cssquery-mootools.html) 12:46:28 INFO - PROCESS | 595 | RSS: Main: 220262400 12:46:28 INFO - PROCESS | 595 | 12:49:30 INFO - PROCESS | 595 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35984/tests/dromaeo/cssquery-prototype.html) 12:49:30 INFO - PROCESS | 595 | RSS: Main: 213901312 12:49:30 INFO - PROCESS | 595 | 12:52:33 INFO - PROCESS | 595 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35984/tests/dromaeo/cssquery-yui.html) 12:52:33 INFO - PROCESS | 595 | RSS: Main: 211820544 12:52:33 INFO - PROCESS | 595 | 12:55:36 INFO - PROCESS | 595 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-yui.html (next: http://localhost:35984/tests/dromaeo/cssquery-dojo.html) 12:55:36 INFO - PROCESS | 595 | RSS: Main: 256282624 12:55:36 INFO - PROCESS | 595 | 12:55:36 INFO - PROCESS | 595 | __start_tp_report 12:55:36 INFO - PROCESS | 595 | _x_x_mozilla_page_load 12:55:36 INFO - PROCESS | 595 | _x_x_mozilla_page_load_details 12:55:36 INFO - PROCESS | 595 | |i|pagename|runs| 12:55:36 INFO - PROCESS | 595 | |0;dojo.html;3295.9340813183735;3345.1302661308055;3353.664633536646;3367.5285460035616;3379.442392005319;5459.754311056002;5493.725313734312;5499.91750123748;5512.779488820443;5554.666719996798;5458.972705136479;5467.261919640857;5480.26016487775;5485.424030476803;5507.697076660782;4884.780184891689;4944.085344211323;5015.398152221738;5066.873328166788;5096.8470945871495;4929.4824043475455;4948.554630083292;5009.899802003958;5105.055564720538;5106.361704786902;5057.949420505803;5081.644284900059;5119.718415487147;5121;5136.332276804011;5076.746162691869;5094.235864620299;5099.694018358873;5114.590832733373;5141.614378921596;4909.091818013679;4925.458199598042;4985.975070124626;5001.674891132101;5014.473480284554;5337;5343.572514198855;5346.251524786533;5353.170258609922;5382.865428364283;5783.8554036149435;5815.592908496407;5819.447152520504;5823.330317013555;5829.067349224146;5723.399043100498;5796.594238403271;5842.649441033509;5975.1037344398255;5993.190919225893;5595.300587426572;5598.552115830724;5600.1599760035915;5601.60788744788;5606.383297837276;6104.389561043949;6106.45041946227;6108.114323423168;6110.511159107261;6118.724657390339;5672.517835983987;5771.365149833515;5854.356020837705;5876.177335173079;5880.588358814927;5922.052471604523;5937.762489500372;5941.940580594225;5943.55423343251;5953.047512397996;5769.278840144982;5917.082852157922;5923.526117910556;5926.555508336805;5929.229200203946;5848.502877255396;5924.7333869975955;5930.377310382434;5962.880742385215;5968.880622387528;4519.525449827721;4521.412216411845;4534.659900507475;4543.863684089482;4578.267477203632;3968.761874287552;3986.0832008638176;4054.2702313583836;4084.9387259191135;4116.382542618631;5574.219609254707;5604.579656525777;5611.438856114438;5639.661620302795;5639.943600564024;5804.448577385142;5841.883162336814;5844.9415505845245;5864.853378665567;5866.501347385435;5608.46719561641;5639.210510528529;5641.717914104278;5651.2935883014625;5738.454846789548;5026.924596131061;5029.421616514148;5031.647784655112;5034.697918124851;5036.992601479646;6032.8793424132145;6036.728347224385;6038.728257228435;6043.909341359795;6046.969765151146;5808.215890854681;5835.44563266489;5899.646021238826;5933.821985340447;5935.940640593539;6077.969610151921;6090.786822461193;6098.63408195492;6098.786542470993;6105.389461053859;5777.191193233035;5778.364379918122;5782.826515204551;5784.305883294031;5786.594938354443;5811.476967072984;5835.56233282497;5898.056310990221;5902.2622172228475;5943.702814859326;5705.7432415542235;5747.798827041033;5750.856228594152;5756.856078598069;5769.365369809234;5675.517581005661;5705.115707065412;5736.4550367715;5737.885242295214;5744.856378590569;5662.150677398258;5727.398623144676;5729.226554415267;5736.856578585569;5757.193992840922;5831.446012628793;5841.591088623755;5845.503132233808;5860.824175274749;5866.911996320144;5516.503514683698;5738.68437235956;5738.8278351649515;5742.770289188553;5770.192173095686 12:55:36 INFO - PROCESS | 595 | |1;ext.html;602.7347966894566;657.7073202424921;675.5676367125039;683.6581709145428;686.8969654551813;33435.66564334356;40189.19621607566;41041;41100;41140.79429602855;44190;44709.32936005962;44769.1046179077;44800.55199448005;44872.3269150963;8209.096999330099;8728.869066963985;8903.554822258893;8908.643654253854;10342.120919721796;10304.433256170907;10431.68704938853;10432.582696692123;10433.42616156111;10434.16526677864;10508.474576271194;10585.523651435704;10586.311889727182;10592.576296948113;10594.41730704811;10368.948155259213;10401.895981040168;10437.112845408074;10441.112505437048;10442.32124911882;10743.946280268627;10852.348859068481;10855.837162442569;10895.291806032661;10904.037273290805;35055;35395.938121856125;43794.56205437968;44233;44447.77776111131;3497.24809166028;3661.6887564557046;3747.2692824899154;3930.3711406174875;4107.54816970136;30249.09252722422;30598.235044123852;30619.2345191372;30699.386012279854;32235.838820805748;4400.867973960786;4481.977590112061;4490.259107247301;4491.6855820092605;4575.062112267011;239165.80417097977;240191;240202;241434;242316;41190.58809411868;42273;58716;59131;59236;39807.80096099501;39831.60168398337;39886.60113398887;40002.399964000564;40021.1995760089;15505.302261398265;16532.83467165337;16665.666686666198;16692.666146677;16695.33218671264;13687.11033782801;13975.580732578039;14003.089799163023;14010.85989140116;14044.016918815585;8327.084020757711;8363.121872203452;8367.456115352483;8421.4947103174;8429.831403371898;3507.5790905091553;3514.3147086318436;3523.594786599574;3571.982140089283;3599.9280014399565;1142.1034487926938;1153.2330999884982;1172.6130376975577;1199.8121859359171;1253.8871501564904;33010.8349458256;33278.50082248768;33689.663103369145;34579;35497.290054199286;1178.393127539318;1228.8955438787625;1232.433080782832;1247.108317552936;1253.035162924543;16241.675166496603;16250.837491625169;16350.264238109314;16356.188674198766;16603.16984150812;512399;518566;518776;519484;520505;60062.099068514006;60627;60811.39188608146;60830;60887.39112608906;1397.3851505337618;1439.043036380795;1477.7413952558259;1509.2076659753718;1596.8243493215737;31390.843045784626;31693.366132676758;33781.903940407676;34156.487652685726;34338.82830585931;50766.238506421694;51387.48612513827;51675.74162129165;51715.482845171064;51753.22370164526;374689;375489;376382;377020;378300;29543;29882.402351952405;46901.951373160635;47580;48500.51499485101;48054.5194548064;51734.482655172964;52160.21759673532;52207.47792522178;52985.735071324394;43047.56952430436;43183.78408107939;43852.780736096116;43872;44021.11544640741;36969;37057.629423706494;37289.44065839069;37328.44007339838;37982.240355193295;43082.78458607687;43590.78204608957;43942.780286099645;44354.77822610866;44474.332885007396;35670.64329356777;37610.247795044495;38350.61649383471;38566.614333857426;38967.415488767125;29281.85359073276;29507;29827.263889927293;29972.70027299699;30169.396612068074 12:55:36 INFO - PROCESS | 595 | |2;jquery.html;416.21335675573164;428.9378040184171;430.1161113910916;432.70143600915367;441.63785695729496;18697.813021869777;18732.4380268592;19037.360561883983;19418.51453713656;19543.21827126917;18520.259189632434;18610.81389186108;19719.802801971975;19746.407607771755;19751.802481975177;5712.11462223356;5718.59969802114;5903.734331955051;5910;5942.524598032169;5758.971205143968;5831.387704291052;5845.152452894327;5851.76592936282;5875.353711091777;5527.309086364205;5719.399463056381;5762.654240745569;5805.274340707411;5811.796587119452;5770.134479828017;5793.71031448428;5811.476967072984;5823.388544202882;5852.619579727326;5157.535821776059;5226.033183860998;5246.344206974129;5264.7367631618645;5284.365876094855;23471.178508752113;23659.053637854464;23753.7624623755;23966.76033239663;24027.15904943336;2636.2882021854184;2742.835429874194;2780.8331500110057;2799.0343331550584;3013.8191708497343;14205.928970355186;14967.503249675054;15051.172185529791;15402.46091386796;15623.296951637203;2102.5899949509853;2133.5946170227608;2141.1970511058353;2160.7299087614047;2210.4805370737863;59872.40127598712;61823.69088154576;73846.0491853467;79900.20099799044;79954.60022699849;9881.75295617601;10494.947525262478;10548.683539493828;10770.892291076989;10783.46082695862;14790.334434950239;14792.408303667733;14949.40202391914;14956;14965.925170374296;8694.739157825275;8751.824963500694;8786.648534058566;8791.384603077851;8988.865167022499;9159.587818548049;9161.908380916238;9185.448873067637;9281.48951807657;9287.349885507949;6560.147180866456;6611.371919667624;6635.6350400728425;6681.129283800544;6703.798886033427;1823.6899727046434;1854.573448106943;1870.083659007104;1878.079740926936;1913.1868955693774;988.4514094677379;998.7153661206521;1009.016209196028;1026.8499280805545;1042.6663467690266;17505.212265448085;18127.72808407875;18250.452486425427;18494.51421215687;18768.71846922297;960.2174228004294;976.1214906583989;984.247051005981;988.9456079915674;990.153418826907;10136.594536218616;10400.791984160425;10410.167186625053;10455.21585881062;10631.255812093079;529241;546544;552608;553347.6997845036;558042;92029;93405.53297233471;94667;95644.52177739066;95694.52152739331;1042.1142029275206;1081.1566977757361;1097.7914196302677;1160.4661855546542;1164.7204670878928;17106.230219639896;17653.646927061644;17756.20097095608;17776.377826776;18062.819371806112;41347;41366.37950430806;41415.171696566504;41712.1657566853;41762.58237417587;61285.38714612797;61870.38129618646;62324.065139022045;62328;62533.68733156305;8572.3999320047;8640.222379985831;8691.608877600396;8839.46963182211;9023.323250756352;13331.400086995915;13353.53262635803;13506.864931350561;13609.183448993092;13823.86176138266;12120.878791212328;12634.178778379744;12661.177023493443;12815.359232038174;12826.166299190523;12275.570355037531;12277.877221227673;12413.379331033593;12651.304178269915;12689.048321376118;12636.620901372973;12703.682407939506;12877.742445150858;12935.741285174056;13130.343482825629;9092.272618190662;9114.453132812052;9271.582778774837;9295.395799273025;9376.29677774156;12208.694782630506;12351.444185011876;12686.619401417973;12688.111832171659;12742.68143296425 12:55:36 INFO - PROCESS | 595 | |3;mootools.html;1222.2055663818523;1491.6121808329835;1500.6023403797992;1659.5602165426158;1794.9371771987976;7723.150453450123;7911.446198766089;7931.960340198299;7932.286094251516;7935.92064079359;8247.752567422987;8500.064992850797;8509.617067231973;8514.318854491641;8529.53087580183;2086.926957556486;2131.79747923947;2338.5790557699606;2339.1929784224417;2374.964375534368;2399.4601214726636;2411.1560953666253;2413.79482743967;2416.3717433467336;2418.51629674065;2305.8501197422197;2332.591796435617;2395.0659242895285;2395.7484464131276;2395.9161429349974;2078.906449209782;2336.836421450499;2377.7978871795917;2391.593429117037;2431.914882979096;2301.746807851135;2321.97678023221;2364.9763502364926;2367.5028244068767;2368.4907744834945;8441.409101362908;8470.322374210049;8489.74530764078;8492.405531612789;8500.617472213766;5195.792168313263;5281.313429254211;5301.231321458406;5313.6014798889855;5316.415194328621;3503.7722548034294;3547.7693949893433;3574.2136729919375;3670.0457880950876;3711.6102809205186;1203.5967950736513;1214.6659668591208;1219.5914368686501;1227.4967263422043;1247.5009996001581;11593.536258549648;11691.064714822794;11783.94108029463;11795.351255680935;11829.585964491287;4531.909361812745;4557.658175636774;4626.953730462719;4662.370579971661;4668.6965347253;9756.170725488413;9765.707028789147;9770.560324785401;9779.070988256104;9791;5149.922751158736;5160.40655324635;5192.350956130484;5195.610329225323;5198.090334191501;4132.070284186034;4655.185342565038;4697.976510117427;4699.036697477009;4708.340832283483;4219.493660760667;4225.19721252961;4245.766482843412;4246.8513602024395;4279.443672322578;1341.7718987771907;1366.132505858767;1372.6019454358125;1374.9175049497062;1375.8280214973129;1007;1020.6529779874729;1023.242800327767;1031.0153803118005;1032.7573020340214;5507.256520369699;5598.4961353477565;5656.943430565724;5683.744231509592;5727.169560413717;979.0405402705246;1010.5351538292468;1027.6660085472251;1029.330934892326;1046.827273499864;3879.2823327683905;3925.097227637659;3925.3326934421216;3946.8421263149153;3966.5438474575794;10094;10346.37921724699;10502.264841461178;10506.212034097472;10553.102986246255;10372.170226381872;10409.271351005356;10585.364878107339;10606.204534659932;10615.734606634742;7871.567063811431;7964.084130324971;8073.999999999883;8080.676772929017;8082.636281367352;5624.550035997192;5644.8024319148635;5699.088145896802;5723.713814309352;5875.353711091862;9340.579673914826;9491.477968711511;9687.70936871895;9860.950695246765;9890.456024918698;9303.76740581491;9833.262505311986;9843.409395436296;10004;10010.299279050689;6268.623882567061;6403.711832967434;7016.859662806613;7273.745418910313;7451.515651482637;7691.2308769124875;7692.9615351922885;7699.15309315986;7745.380369570308;7755.806104847424;6793.592384456949;6961.582305061713;7002.334778196063;7021;7169.175544812413;6802.6258555779905;6828.965855170891;6885.483588730765;6911.997760324825;7103.25415831351;6613.2394774601535;6629.801105966829;6715.26132125456;6785.830354240986;6802.965985170043;4914.8771280718265;4934.383202099738;4964;4973.278874563096;5003.874903127451;4978.651494395358;5051.621128415457;5080.7205603692155;5101.719405432588;5145.871353216199 12:55:36 INFO - PROCESS | 595 | |4;prototype.html;336.9679880411361;339.8759452799728;342.88247900091136;354.9503069570259;356.55786824337827;6168.013117901137;6173.104899789533;6184.536159788017;6229.940910045292;6404.071409645599;6207.813765587029;6227.937720622804;6253.656048917308;6270.122182894398;6270.49836013119;4737.313089602006;4739.360186374838;4740.146773580754;4741.525847415265;4747.881302967419;4477.888052798689;4523.208438523262;4622.052479241747;4643.2802915548145;4684.601808846252;4607.769611519428;4614.123316569858;4625.468071171825;4633.6524760642915;4637;4415.911681766379;4610.861674149781;4612.584867361937;4614.100250451163;4624.352590637313;3906.121122747359;3929.2337994091163;3953;3963.4054891766177;3983.4423180754716;6006.429389208019;6006.969965150146;6012.068129439944;6020.759169633209;6025.548083893682;5378.193271009341;5383.650062745909;5391.73041347931;5393.676379417208;5397.568194544427;6468.191476065492;6513.478921686254;6524.314946930599;6532.248791389004;6536.248331441898;4416.757078360689;4428.867133985986;4434.822607095713;4437.090396468749;4447.3996010538485;6617.106690596756;6837.863242735167;6848.863022739517;6902.171739391305;6908.205556361033;4549.772511374418;4586.954130458719;4594.471635761864;4596.448426188878;4612.123696497655;4649.442066951988;4657.04530571232;4662.0209755950955;4668.463126740468;4674.322223277673;5418.268533747893;5430.13117901134;5431.321084864392;5437.211604317431;5438.972805135949;6615.966920165369;6616.338366163345;6624.6025238485845;6631.171103612049;6632.701528431232;1559.1892216047593;1564.3038847712887;1564.820045694737;1574.8424907692836;1580.7707882356995;1054.5728979763207;1057.6721216422934;1062.574970011986;1071.614218881202;1071.8177909755361;6232.345603711636;6290.087937249074;6342.23893132827;6380.266269378988;6434.74261029563;6846.075779769767;6852.931470685229;6870;6879.2432832388395;6885.139357580302;6486.805395838132;6493.610383377012;6494.740210391626;6500.804975850638;6501.577397469149;3652.908677283036;3688.262347530451;3689.870854520079;3692.778433294011;3694.168812017275;6796.796096117125;7071.151461824614;7113.110861142357;7113.466490013269;7126.750563730348;7000.579965202104;7031.980362847358;7033.964830175816;7036.542624729376;7044.753433629799;7067.399271062018;7078.610676412847;7080.716771329089;7095.716171353191;7098.077249957576;6803.829904252433;6839.726410943506;6851.07510486078;6854.2117656470145;6857.348551887762;6562.146920900253;6748.628825414649;6749.223839258548;6757.797266082025;6796.422304104207;7088.291170883077;7100.289971002859;7113.786586402416;7114.359707626339;7114.395276401564;4663.300504924153;4703.529647035269;4706.952930470651;4717;4719.74041427711;6774;6789.796306110825;6815.773160831098;6836.077129587641;6905.896411553931;6469.967650161719;6668.866622667422;6674.599524028379;6681.432078273401;6684.429159147499;6641.468682505291;6665.166854143232;6673.532852700265;6675.666216689049;6675.7997260082275;6535.705893234721;6539.378759017885;6540.247871494648;6541.771038013647;6554.14796076507;6704.262531121475;6709.664516774044;6711.530192886647;6715.328467153441;6716.093327400934;6409.9038514423255;6535.019747037983;6539.836504087436;6546.934530654823;6550 12:55:36 INFO - PROCESS | 595 | |5;yui.html;762.1996903251585;795.5266616363261;820.8112134209132;824.6618886256636;840.2269911681254;14352.497662581798;14628.780568291484;14653.92673036636;14670.119792812426;14698.779518307234;13244;13686.794698079537;13762.58712238632;13772.173669579832;13786.17282963023;756.5385115079797;870.29071306885;876.0538618292229;877.5305211711735;891.9821603567925;895.5746020640177;896.8834051573319;897.0401670212875;897.6499165325496;898.3756289378852;933.4446004627235;935.1256575102267;935.5930170375874;936.8032713130251;937.9015203403646;791.2404092071589;932.9253659707207;933.4352716606492;946.342292106986;948.4830767231875;697.5779653309776;698.4656737595743;698.4901022253783;699.7830672491493;699.8775214337521;13872.306384680725;13930.442782288696;13934.512292069729;13967.231802250872;13983.091099078527;13111.278879661615;13660.931695341558;13687.863121368759;13857;13902.860971390359;10600.840987385196;10866.565337386495;10926.125909927187;10936.726581835439;10984.670459886136;3903.512060992376;3914.471546341236;3939.5075615548058;3974.7615143091216;4043.110515686544;60647;60809.6959515204;60922;61049;61919.690401547705;10757.139428845674;10764.569417223223;10995.360586366196;11097.83353249702;11226.494807733672;19819.207231710858;19988.60022799565;19997.800021999592;20013;20035.29876454317;8649.048604653482;8691.478511289342;8718.476891386537;8858.15847494487;8949;4821.975890120527;4890.24201248807;4938.629602779734;4957.132501812169;5160.587153027749;3460.307938412277;3481.234128491728;3509.1578021275222;3515.33208690348;3520.6831385174946;610.7709608896664;651.3096118114719;654.7413771560302;657.6317262333013;661.153723234261;664.8534300392803;681.9352161544646;694.9478789090839;710.3571268002363;713.6752777486336;9096.862892138482;9175.70607348163;9358.251339892928;9358.532073396304;9531;668.7358493395179;674.6222115615271;687.6802286936598;691.4226620771713;698.9091418115612;4409.382686423904;4447.043885564619;4453.153900758845;4494.460664720189;4564.931526027112;68634.65682671555;70257;70769.64615176892;70772;70813;60482.39517604856;60949.39050609526;61445;62367.37632623615;62535.06197407043;54693.179602305994;55175;55414.72292638511;55572.44427555754;56558.43441565614;8622.353323500636;8823.382363234512;8994.55027248648;9052.683156089506;9079.364444489087;38978;38987.80506097451;40107.59892401155;40160.59839401569;40563.594364057164;52456.475435246684;52495.73752131215;53190.4680953201;53428;53719.46280537301;12009;12118.818217726564;12138.514459421523;12356.25862448256;12427.813582796085;13092.672683182996;13593.252371119683;13620.523281685093;13632.65918352049;14029.368678409292;12616.432260548481;12670.87329126697;12967.870321296667;13037.674058148623;13324.333783310989;12249.755004899675;12350.505979760708;12564.246145231315;12647.620571382873;13134.671633209246;12531.561395351118;12600.936995314965;12641.557545486232;12697.80953285683;12698.174618649758;10788.568457261621;10860.348379096964;10962.342259464138;11055.115590752559;11149.498272577592;10218.38689678592;10365.792684146425;10389.84415233757;10460;10469.842952355873 12:55:36 INFO - PROCESS | 595 | __end_tp_report 12:55:36 INFO - PROCESS | 595 | __start_cc_report 12:55:36 INFO - PROCESS | 595 | _x_x_mozilla_cycle_collect,799 12:55:36 INFO - PROCESS | 595 | __end_cc_report 12:55:36 INFO - PROCESS | 595 | __startTimestamp1463687736335__endTimestamp 12:55:36 INFO - PROCESS | 595 | 12:55:36 INFO - PROCESS | 595 | ------- Summary: start ------- 12:55:36 INFO - PROCESS | 595 | Number of tests: 6 12:55:36 INFO - PROCESS | 595 | 12:55:36 INFO - PROCESS | 595 | [#0] dojo.html Cycles:165 Average:5484.48 Median:5729.23 stddev:599.34 (10.5%) stddev-sans-first:576.06 12:55:36 INFO - PROCESS | 595 | Values: 3295.9 3345.1 3353.7 3367.5 3379.4 5459.8 5493.7 5499.9 5512.8 5554.7 5459.0 5467.3 5480.3 5485.4 5507.7 4884.8 4944.1 5015.4 5066.9 5096.8 4929.5 4948.6 5009.9 5105.1 5106.4 5057.9 5081.6 5119.7 5121.0 5136.3 5076.7 5094.2 5099.7 5114.6 5141.6 4909.1 4925.5 4986.0 5001.7 5014.5 5337.0 5343.6 5346.3 5353.2 5382.9 5783.9 5815.6 5819.4 5823.3 5829.1 5723.4 5796.6 5842.6 5975.1 5993.2 5595.3 5598.6 5600.2 5601.6 5606.4 6104.4 6106.5 6108.1 6110.5 6118.7 5672.5 5771.4 5854.4 5876.2 5880.6 5922.1 5937.8 5941.9 5943.6 5953.0 5769.3 5917.1 5923.5 5926.6 5929.2 5848.5 5924.7 5930.4 5962.9 5968.9 4519.5 4521.4 4534.7 4543.9 4578.3 3968.8 3986.1 4054.3 4084.9 4116.4 5574.2 5604.6 5611.4 5639.7 5639.9 5804.4 5841.9 5844.9 5864.9 5866.5 5608.5 5639.2 5641.7 5651.3 5738.5 5026.9 5029.4 5031.6 5034.7 5037.0 6032.9 6036.7 6038.7 6043.9 6047.0 5808.2 5835.4 5899.6 5933.8 5935.9 6078.0 6090.8 6098.6 6098.8 6105.4 5777.2 5778.4 5782.8 5784.3 5786.6 5811.5 5835.6 5898.1 5902.3 5943.7 5705.7 5747.8 5750.9 5756.9 5769.4 5675.5 5705.1 5736.5 5737.9 5744.9 5662.2 5727.4 5729.2 5736.9 5757.2 5831.4 5841.6 5845.5 5860.8 5866.9 5516.5 5738.7 5738.8 5742.8 5770.2 12:55:36 INFO - PROCESS | 595 | 12:55:36 INFO - PROCESS | 595 | [#1] ext.html Cycles:180 Average:54687.77 Median:37173.54 stddev:104722.21 (281.7%) stddev-sans-first:104937.25 12:55:36 INFO - PROCESS | 595 | Values: 602.7 657.7 675.6 683.7 686.9 33435.7 40189.2 41041.0 41100.0 41140.8 44190.0 44709.3 44769.1 44800.6 44872.3 8209.1 8728.9 8903.6 8908.6 10342.1 10304.4 10431.7 10432.6 10433.4 10434.2 10508.5 10585.5 10586.3 10592.6 10594.4 10368.9 10401.9 10437.1 10441.1 10442.3 10743.9 10852.3 10855.8 10895.3 10904.0 35055.0 35395.9 43794.6 44233.0 44447.8 3497.2 3661.7 3747.3 3930.4 4107.5 30249.1 30598.2 30619.2 30699.4 32235.8 4400.9 4482.0 4490.3 4491.7 4575.1 239165.8 240191.0 240202.0 241434.0 242316.0 41190.6 42273.0 58716.0 59131.0 59236.0 39807.8 39831.6 39886.6 40002.4 40021.2 15505.3 16532.8 16665.7 16692.7 16695.3 13687.1 13975.6 14003.1 14010.9 14044.0 8327.1 8363.1 8367.5 8421.5 8429.8 3507.6 3514.3 3523.6 3572.0 3599.9 1142.1 1153.2 1172.6 1199.8 1253.9 33010.8 33278.5 33689.7 34579.0 35497.3 1178.4 1228.9 1232.4 1247.1 1253.0 16241.7 16250.8 16350.3 16356.2 16603.2 512399.0 518566.0 518776.0 519484.0 520505.0 60062.1 60627.0 60811.4 60830.0 60887.4 1397.4 1439.0 1477.7 1509.2 1596.8 31390.8 31693.4 33781.9 34156.5 34338.8 50766.2 51387.5 51675.7 51715.5 51753.2 374689.0 375489.0 376382.0 377020.0 378300.0 29543.0 29882.4 46902.0 47580.0 48500.5 48054.5 51734.5 52160.2 52207.5 52985.7 43047.6 43183.8 43852.8 43872.0 44021.1 36969.0 37057.6 37289.4 37328.4 37982.2 43082.8 43590.8 43942.8 44354.8 44474.3 35670.6 37610.2 38350.6 38566.6 38967.4 29281.9 29507.0 29827.3 29972.7 30169.4 12:55:36 INFO - PROCESS | 595 | 12:55:36 INFO - PROCESS | 595 | [#2] jquery.html Cycles:180 Average:30866.78 Median:2906.43 stddev:89946.80 (3094.8%) stddev-sans-first:90170.06 12:55:36 INFO - PROCESS | 595 | Values: 416.2 428.9 430.1 432.7 441.6 18697.8 18732.4 19037.4 19418.5 19543.2 18520.3 18610.8 19719.8 19746.4 19751.8 5712.1 5718.6 5903.7 5910.0 5942.5 5759.0 5831.4 5845.2 5851.8 5875.4 5527.3 5719.4 5762.7 5805.3 5811.8 5770.1 5793.7 5811.5 5823.4 5852.6 5157.5 5226.0 5246.3 5264.7 5284.4 23471.2 23659.1 23753.8 23966.8 24027.2 2636.3 2742.8 2780.8 2799.0 3013.8 14205.9 14967.5 15051.2 15402.5 15623.3 2102.6 2133.6 2141.2 2160.7 2210.5 59872.4 61823.7 73846.0 79900.2 79954.6 9881.8 10494.9 10548.7 10770.9 10783.5 14790.3 14792.4 14949.4 14956.0 14965.9 8694.7 8751.8 8786.6 8791.4 8988.9 9159.6 9161.9 9185.4 9281.5 9287.3 6560.1 6611.4 6635.6 6681.1 6703.8 1823.7 1854.6 1870.1 1878.1 1913.2 988.5 998.7 1009.0 1026.8 1042.7 17505.2 18127.7 18250.5 18494.5 18768.7 960.2 976.1 984.2 988.9 990.2 10136.6 10400.8 10410.2 10455.2 10631.3 529241.0 546544.0 552608.0 553347.7 558042.0 92029.0 93405.5 94667.0 95644.5 95694.5 1042.1 1081.2 1097.8 1160.5 1164.7 17106.2 17653.6 17756.2 17776.4 18062.8 41347.0 41366.4 41415.2 41712.2 41762.6 61285.4 61870.4 62324.1 62328.0 62533.7 8572.4 8640.2 8691.6 8839.5 9023.3 13331.4 13353.5 13506.9 13609.2 13823.9 12120.9 12634.2 12661.2 12815.4 12826.2 12275.6 12277.9 12413.4 12651.3 12689.0 12636.6 12703.7 12877.7 12935.7 13130.3 9092.3 9114.5 9271.6 9295.4 9376.3 12208.7 12351.4 12686.6 12688.1 12742.7 12:55:36 INFO - PROCESS | 595 | 12:55:36 INFO - PROCESS | 595 | [#3] mootools.html Cycles:180 Average:5572.02 Median:4811.61 stddev:3062.77 (63.7%) stddev-sans-first:3053.91 12:55:36 INFO - PROCESS | 595 | Values: 1222.2 1491.6 1500.6 1659.6 1794.9 7723.2 7911.4 7932.0 7932.3 7935.9 8247.8 8500.1 8509.6 8514.3 8529.5 2086.9 2131.8 2338.6 2339.2 2375.0 2399.5 2411.2 2413.8 2416.4 2418.5 2305.9 2332.6 2395.1 2395.7 2395.9 2078.9 2336.8 2377.8 2391.6 2431.9 2301.7 2322.0 2365.0 2367.5 2368.5 8441.4 8470.3 8489.7 8492.4 8500.6 5195.8 5281.3 5301.2 5313.6 5316.4 3503.8 3547.8 3574.2 3670.0 3711.6 1203.6 1214.7 1219.6 1227.5 1247.5 11593.5 11691.1 11783.9 11795.4 11829.6 4531.9 4557.7 4627.0 4662.4 4668.7 9756.2 9765.7 9770.6 9779.1 9791.0 5149.9 5160.4 5192.4 5195.6 5198.1 4132.1 4655.2 4698.0 4699.0 4708.3 4219.5 4225.2 4245.8 4246.9 4279.4 1341.8 1366.1 1372.6 1374.9 1375.8 1007.0 1020.7 1023.2 1031.0 1032.8 5507.3 5598.5 5656.9 5683.7 5727.2 979.0 1010.5 1027.7 1029.3 1046.8 3879.3 3925.1 3925.3 3946.8 3966.5 10094.0 10346.4 10502.3 10506.2 10553.1 10372.2 10409.3 10585.4 10606.2 10615.7 7871.6 7964.1 8074.0 8080.7 8082.6 5624.6 5644.8 5699.1 5723.7 5875.4 9340.6 9491.5 9687.7 9861.0 9890.5 9303.8 9833.3 9843.4 10004.0 10010.3 6268.6 6403.7 7016.9 7273.7 7451.5 7691.2 7693.0 7699.2 7745.4 7755.8 6793.6 6961.6 7002.3 7021.0 7169.2 6802.6 6829.0 6885.5 6912.0 7103.3 6613.2 6629.8 6715.3 6785.8 6803.0 4914.9 4934.4 4964.0 4973.3 5003.9 4978.7 5051.6 5080.7 5101.7 5145.9 12:55:36 INFO - PROCESS | 595 | 12:55:36 INFO - PROCESS | 595 | [#4] prototype.html Cycles:180 Average:5506.18 Median:6316.16 stddev:1703.52 (27.0%) stddev-sans-first:1663.53 12:55:36 INFO - PROCESS | 595 | Values: 337.0 339.9 342.9 355.0 356.6 6168.0 6173.1 6184.5 6229.9 6404.1 6207.8 6227.9 6253.7 6270.1 6270.5 4737.3 4739.4 4740.1 4741.5 4747.9 4477.9 4523.2 4622.1 4643.3 4684.6 4607.8 4614.1 4625.5 4633.7 4637.0 4415.9 4610.9 4612.6 4614.1 4624.4 3906.1 3929.2 3953.0 3963.4 3983.4 6006.4 6007.0 6012.1 6020.8 6025.5 5378.2 5383.7 5391.7 5393.7 5397.6 6468.2 6513.5 6524.3 6532.2 6536.2 4416.8 4428.9 4434.8 4437.1 4447.4 6617.1 6837.9 6848.9 6902.2 6908.2 4549.8 4587.0 4594.5 4596.4 4612.1 4649.4 4657.0 4662.0 4668.5 4674.3 5418.3 5430.1 5431.3 5437.2 5439.0 6616.0 6616.3 6624.6 6631.2 6632.7 1559.2 1564.3 1564.8 1574.8 1580.8 1054.6 1057.7 1062.6 1071.6 1071.8 6232.3 6290.1 6342.2 6380.3 6434.7 6846.1 6852.9 6870.0 6879.2 6885.1 6486.8 6493.6 6494.7 6500.8 6501.6 3652.9 3688.3 3689.9 3692.8 3694.2 6796.8 7071.2 7113.1 7113.5 7126.8 7000.6 7032.0 7034.0 7036.5 7044.8 7067.4 7078.6 7080.7 7095.7 7098.1 6803.8 6839.7 6851.1 6854.2 6857.3 6562.1 6748.6 6749.2 6757.8 6796.4 7088.3 7100.3 7113.8 7114.4 7114.4 4663.3 4703.5 4707.0 4717.0 4719.7 6774.0 6789.8 6815.8 6836.1 6905.9 6470.0 6668.9 6674.6 6681.4 6684.4 6641.5 6665.2 6673.5 6675.7 6675.8 6535.7 6539.4 6540.2 6541.8 6554.1 6704.3 6709.7 6711.5 6715.3 6716.1 6409.9 6535.0 6539.8 6546.9 6550.0 12:55:36 INFO - PROCESS | 595 | 12:55:36 INFO - PROCESS | 595 | [#5] yui.html Cycles:180 Average:15975.16 Median:4856.11 stddev:19439.66 (400.3%) stddev-sans-first:19460.63 12:55:36 INFO - PROCESS | 595 | Values: 762.2 795.5 820.8 824.7 840.2 14352.5 14628.8 14653.9 14670.1 14698.8 13244.0 13686.8 13762.6 13772.2 13786.2 756.5 870.3 876.1 877.5 892.0 895.6 896.9 897.0 897.6 898.4 933.4 935.1 935.6 936.8 937.9 791.2 932.9 933.4 946.3 948.5 697.6 698.5 698.5 699.8 699.9 13872.3 13930.4 13934.5 13967.2 13983.1 13111.3 13660.9 13687.9 13857.0 13902.9 10600.8 10866.6 10926.1 10936.7 10984.7 3903.5 3914.5 3939.5 3974.8 4043.1 60647.0 60809.7 60922.0 61049.0 61919.7 10757.1 10764.6 10995.4 11097.8 11226.5 19819.2 19988.6 19997.8 20013.0 20035.3 8649.0 8691.5 8718.5 8858.2 8949.0 4822.0 4890.2 4938.6 4957.1 5160.6 3460.3 3481.2 3509.2 3515.3 3520.7 610.8 651.3 654.7 657.6 661.2 664.9 681.9 694.9 710.4 713.7 9096.9 9175.7 9358.3 9358.5 9531.0 668.7 674.6 687.7 691.4 698.9 4409.4 4447.0 4453.2 4494.5 4564.9 68634.7 70257.0 70769.6 70772.0 70813.0 60482.4 60949.4 61445.0 62367.4 62535.1 54693.2 55175.0 55414.7 55572.4 56558.4 8622.4 8823.4 8994.6 9052.7 9079.4 38978.0 38987.8 40107.6 40160.6 40563.6 52456.5 52495.7 53190.5 53428.0 53719.5 12009.0 12118.8 12138.5 12356.3 12427.8 13092.7 13593.3 13620.5 13632.7 14029.4 12616.4 12670.9 12967.9 13037.7 13324.3 12249.8 12350.5 12564.2 12647.6 13134.7 12531.6 12600.9 12641.6 12697.8 12698.2 10788.6 10860.3 10962.3 11055.1 11149.5 10218.4 10365.8 10389.8 10460.0 10469.8 12:55:36 INFO - PROCESS | 595 | -------- Summary: end -------- 12:55:36 INFO - PROCESS | 595 | 12:55:36 INFO - TEST-INFO | 595: exit 0 12:55:36 INFO - TEST-OK | dromaeo_css | took 1110913ms 12:55:36 INFO - TEST-START | kraken 12:55:36 INFO - operating with platform_type : linux_ 12:55:36 INFO - Initialising browser for kraken test... 12:55:36 INFO - TEST-INFO | started process 787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKd5JIc/profile http://localhost:35984/getInfo.html) 12:55:40 INFO - PROCESS | 787 | __metrics Screen width/height:1600/1200 12:55:40 INFO - PROCESS | 787 | colorDepth:24 12:55:40 INFO - PROCESS | 787 | Browser inner width/height: 1024/697 12:55:40 INFO - PROCESS | 787 | __metrics 12:55:41 ERROR - PROCESS | 787 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:55:42 INFO - TEST-INFO | 787: exit 0 12:55:42 INFO - Browser initialized. 12:55:42 INFO - Running cycle 1/1 for kraken test... 12:55:42 INFO - TEST-INFO | started process 882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKd5JIc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:54 INFO - PROCESS | 882 | RSS: Main: 141959168 12:55:54 INFO - PROCESS | 882 | 12:55:56 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35984/tests/kraken/driver.html?testName=audio-beat-detection) 12:55:57 INFO - PROCESS | 882 | RSS: Main: 197029888 12:55:57 INFO - PROCESS | 882 | 12:56:00 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35984/tests/kraken/driver.html?testName=audio-dft) 12:56:01 INFO - PROCESS | 882 | RSS: Main: 182136832 12:56:01 INFO - PROCESS | 882 | 12:56:03 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35984/tests/kraken/driver.html?testName=audio-fft) 12:56:04 INFO - PROCESS | 882 | RSS: Main: 272605184 12:56:04 INFO - PROCESS | 882 | 12:56:06 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35984/tests/kraken/driver.html?testName=audio-oscillator) 12:56:07 INFO - PROCESS | 882 | RSS: Main: 178642944 12:56:07 INFO - PROCESS | 882 | 12:56:09 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35984/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:56:09 INFO - PROCESS | 882 | RSS: Main: 176177152 12:56:09 INFO - PROCESS | 882 | 12:56:12 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35984/tests/kraken/driver.html?testName=imaging-darkroom) 12:56:13 INFO - PROCESS | 882 | RSS: Main: 211959808 12:56:13 INFO - PROCESS | 882 | 12:56:16 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35984/tests/kraken/driver.html?testName=imaging-desaturate) 12:56:17 INFO - PROCESS | 882 | RSS: Main: 211443712 12:56:17 INFO - PROCESS | 882 | 12:56:20 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35984/tests/kraken/driver.html?testName=json-parse-financial) 12:56:20 INFO - PROCESS | 882 | RSS: Main: 212008960 12:56:20 INFO - PROCESS | 882 | 12:56:22 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35984/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:56:22 INFO - PROCESS | 882 | RSS: Main: 191209472 12:56:22 INFO - PROCESS | 882 | 12:56:24 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:56:25 INFO - PROCESS | 882 | RSS: Main: 194514944 12:56:25 INFO - PROCESS | 882 | 12:56:27 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:56:27 INFO - PROCESS | 882 | RSS: Main: 209547264 12:56:27 INFO - PROCESS | 882 | 12:56:30 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:56:30 INFO - PROCESS | 882 | RSS: Main: 213823488 12:56:30 INFO - PROCESS | 882 | 12:56:33 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:56:33 INFO - PROCESS | 882 | RSS: Main: 210677760 12:56:33 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35984/tests/kraken/driver.html?testName=ai-astar) 12:56:35 INFO - PROCESS | 882 | RSS: Main: 274415616 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | __start_tp_report 12:56:35 INFO - PROCESS | 882 | _x_x_mozilla_page_load 12:56:35 INFO - PROCESS | 882 | _x_x_mozilla_page_load_details 12:56:35 INFO - PROCESS | 882 | |i|pagename|runs| 12:56:35 INFO - PROCESS | 882 | |0;ai-astar;111;111;112;111;110;111;106;108;109;110 12:56:35 INFO - PROCESS | 882 | |1;audio-beat-detection;161;139;155;175;131;160;157;128;201;126 12:56:35 INFO - PROCESS | 882 | |2;audio-dft;164;160;160;160;162;162;160;161;161;161 12:56:35 INFO - PROCESS | 882 | |3;audio-fft;76;78;76;168;75;74;73;74;171;76 12:56:35 INFO - PROCESS | 882 | |4;audio-oscillator;92;91;159;91;92;93;149;92;92;140 12:56:35 INFO - PROCESS | 882 | |5;imaging-gaussian-blur;117;117;117;116;117;117;118;117;116;118 12:56:35 INFO - PROCESS | 882 | |6;imaging-darkroom;145;146;146;145;146;145;145;146;146;144 12:56:35 INFO - PROCESS | 882 | |7;imaging-desaturate;94;94;94;94;95;94;94;95;95;94 12:56:35 INFO - PROCESS | 882 | |8;json-parse-financial;52;55;54;55;55;53;53;75;53;54 12:56:35 INFO - PROCESS | 882 | |9;json-stringify-tinderbox;56;58;56;57;57;58;58;57;57;57 12:56:35 INFO - PROCESS | 882 | |10;stanford-crypto-aes;72;71;80;73;73;73;73;72;83;73 12:56:35 INFO - PROCESS | 882 | |11;stanford-crypto-ccm;121;130;119;113;113;114;111;111;129;127 12:56:35 INFO - PROCESS | 882 | |12;stanford-crypto-pbkdf2;156;157;155;160;154;158;153;156;156;155 12:56:35 INFO - PROCESS | 882 | |13;stanford-crypto-sha256-iterative;67;65;65;65;67;67;66;65;65;62 12:56:35 INFO - PROCESS | 882 | __end_tp_report 12:56:35 INFO - PROCESS | 882 | __start_cc_report 12:56:35 INFO - PROCESS | 882 | _x_x_mozilla_cycle_collect,1577 12:56:35 INFO - PROCESS | 882 | __end_cc_report 12:56:35 INFO - PROCESS | 882 | __startTimestamp1463687795884__endTimestamp 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | ------- Summary: start ------- 12:56:35 INFO - PROCESS | 882 | Number of tests: 14 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:1.79 (1.6%) stddev-sans-first:1.86 12:56:35 INFO - PROCESS | 882 | Values: 111.0 111.0 112.0 111.0 110.0 111.0 106.0 108.0 109.0 110.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:158.50 stddev:23.46 (14.8%) stddev-sans-first:24.72 12:56:35 INFO - PROCESS | 882 | Values: 161.0 139.0 155.0 175.0 131.0 160.0 157.0 128.0 201.0 126.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:0.83 12:56:35 INFO - PROCESS | 882 | Values: 164.0 160.0 160.0 160.0 162.0 162.0 160.0 161.0 161.0 161.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.77 (52.7%) stddev-sans-first:41.64 12:56:35 INFO - PROCESS | 882 | Values: 76.0 78.0 76.0 168.0 75.0 74.0 73.0 74.0 171.0 76.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:28.13 (30.6%) stddev-sans-first:29.15 12:56:35 INFO - PROCESS | 882 | Values: 92.0 91.0 159.0 91.0 92.0 93.0 149.0 92.0 92.0 140.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 12:56:35 INFO - PROCESS | 882 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 116.0 118.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 12:56:35 INFO - PROCESS | 882 | Values: 145.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 144.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:56:35 INFO - PROCESS | 882 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:54.50 stddev:6.79 (12.5%) stddev-sans-first:7.05 12:56:35 INFO - PROCESS | 882 | Values: 52.0 55.0 54.0 55.0 55.0 53.0 53.0 75.0 53.0 54.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 12:56:35 INFO - PROCESS | 882 | Values: 56.0 58.0 56.0 57.0 57.0 58.0 58.0 57.0 57.0 57.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:73.00 stddev:3.92 (5.4%) stddev-sans-first:4.07 12:56:35 INFO - PROCESS | 882 | Values: 72.0 71.0 80.0 73.0 73.0 73.0 73.0 72.0 83.0 73.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:120.00 stddev:7.55 (6.3%) stddev-sans-first:7.97 12:56:35 INFO - PROCESS | 882 | Values: 121.0 130.0 119.0 113.0 113.0 114.0 111.0 111.0 129.0 127.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.00 stddev:2.00 (1.3%) stddev-sans-first:2.12 12:56:35 INFO - PROCESS | 882 | Values: 156.0 157.0 155.0 160.0 154.0 158.0 153.0 156.0 156.0 155.0 12:56:35 INFO - PROCESS | 882 | 12:56:35 INFO - PROCESS | 882 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:1.51 (2.3%) stddev-sans-first:1.48 12:56:35 INFO - PROCESS | 882 | Values: 67.0 65.0 65.0 65.0 67.0 67.0 66.0 65.0 65.0 62.0 12:56:35 INFO - PROCESS | 882 | -------- Summary: end -------- 12:56:35 INFO - PROCESS | 882 | 12:56:36 INFO - TEST-INFO | 882: exit 0 12:56:36 INFO - TEST-OK | kraken | took 59982ms 12:56:36 INFO - SUITE-END | took 1170s 12:56:37 INFO - Completed test suite (00:19:30) 12:56:37 INFO - javascript benchmark 12:56:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.9340813183735, 3345.1302661308055, 3353.664633536646, 3367.5285460035616, 3379.442392005319, 5459.754311056002, 5493.725313734312, 5499.91750123748, 5512.779488820443, 5554.666719996798, 5458.972705136479, 5467.261919640857, 5480.26016487775, 5485.424030476803, 5507.697076660782, 4884.780184891689, 4944.085344211323, 5015.398152221738, 5066.873328166788, 5096.8470945871495, 4929.4824043475455, 4948.554630083292, 5009.899802003958, 5105.055564720538, 5106.361704786902, 5057.949420505803, 5081.644284900059, 5119.718415487147, 5121.0, 5136.332276804011, 5076.746162691869, 5094.235864620299, 5099.694018358873, 5114.590832733373, 5141.614378921596, 4909.091818013679, 4925.458199598042, 4985.975070124626, 5001.674891132101, 5014.473480284554, 5337.0, 5343.572514198855, 5346.251524786533, 5353.170258609922, 5382.865428364283, 5783.8554036149435, 5815.592908496407, 5819.447152520504, 5823.330317013555, 5829.067349224146, 5723.399043100498, 5796.594238403271, 5842.649441033509, 5975.1037344398255, 5993.190919225893, 5595.300587426572, 5598.552115830724, 5600.1599760035915, 5601.60788744788, 5606.383297837276, 6104.389561043949, 6106.45041946227, 6108.114323423168, 6110.511159107261, 6118.724657390339, 5672.517835983987, 5771.365149833515, 5854.356020837705, 5876.177335173079, 5880.588358814927, 5922.052471604523, 5937.762489500372, 5941.940580594225, 5943.55423343251, 5953.047512397996, 5769.278840144982, 5917.082852157922, 5923.526117910556, 5926.555508336805, 5929.229200203946, 5848.502877255396, 5924.7333869975955, 5930.377310382434, 5962.880742385215, 5968.880622387528, 4519.525449827721, 4521.412216411845, 4534.659900507475, 4543.863684089482, 4578.267477203632, 3968.761874287552, 3986.0832008638176, 4054.2702313583836, 4084.9387259191135, 4116.382542618631, 5574.219609254707, 5604.579656525777, 5611.438856114438, 5639.661620302795, 5639.943600564024, 5804.448577385142, 5841.883162336814, 5844.9415505845245, 5864.853378665567, 5866.501347385435, 5608.46719561641, 5639.210510528529, 5641.717914104278, 5651.2935883014625, 5738.454846789548, 5026.924596131061, 5029.421616514148, 5031.647784655112, 5034.697918124851, 5036.992601479646, 6032.8793424132145, 6036.728347224385, 6038.728257228435, 6043.909341359795, 6046.969765151146, 5808.215890854681, 5835.44563266489, 5899.646021238826, 5933.821985340447, 5935.940640593539, 6077.969610151921, 6090.786822461193, 6098.63408195492, 6098.786542470993, 6105.389461053859, 5777.191193233035, 5778.364379918122, 5782.826515204551, 5784.305883294031, 5786.594938354443, 5811.476967072984, 5835.56233282497, 5898.056310990221, 5902.2622172228475, 5943.702814859326, 5705.7432415542235, 5747.798827041033, 5750.856228594152, 5756.856078598069, 5769.365369809234, 5675.517581005661, 5705.115707065412, 5736.4550367715, 5737.885242295214, 5744.856378590569, 5662.150677398258, 5727.398623144676, 5729.226554415267, 5736.856578585569, 5757.193992840922, 5831.446012628793, 5841.591088623755, 5845.503132233808, 5860.824175274749, 5866.911996320144, 5516.503514683698, 5738.68437235956, 5738.8278351649515, 5742.770289188553, 5770.192173095686], "value": 5446.20998521489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.7347966894566, 657.7073202424921, 675.5676367125039, 683.6581709145428, 686.8969654551813, 33435.66564334356, 40189.19621607566, 41041.0, 41100.0, 41140.79429602855, 44190.0, 44709.32936005962, 44769.1046179077, 44800.55199448005, 44872.3269150963, 8209.096999330099, 8728.869066963985, 8903.554822258893, 8908.643654253854, 10342.120919721796, 10304.433256170907, 10431.68704938853, 10432.582696692123, 10433.42616156111, 10434.16526677864, 10508.474576271194, 10585.523651435704, 10586.311889727182, 10592.576296948113, 10594.41730704811, 10368.948155259213, 10401.895981040168, 10437.112845408074, 10441.112505437048, 10442.32124911882, 10743.946280268627, 10852.348859068481, 10855.837162442569, 10895.291806032661, 10904.037273290805, 35055.0, 35395.938121856125, 43794.56205437968, 44233.0, 44447.77776111131, 3497.24809166028, 3661.6887564557046, 3747.2692824899154, 3930.3711406174875, 4107.54816970136, 30249.09252722422, 30598.235044123852, 30619.2345191372, 30699.386012279854, 32235.838820805748, 4400.867973960786, 4481.977590112061, 4490.259107247301, 4491.6855820092605, 4575.062112267011, 239165.80417097977, 240191.0, 240202.0, 241434.0, 242316.0, 41190.58809411868, 42273.0, 58716.0, 59131.0, 59236.0, 39807.80096099501, 39831.60168398337, 39886.60113398887, 40002.399964000564, 40021.1995760089, 15505.302261398265, 16532.83467165337, 16665.666686666198, 16692.666146677, 16695.33218671264, 13687.11033782801, 13975.580732578039, 14003.089799163023, 14010.85989140116, 14044.016918815585, 8327.084020757711, 8363.121872203452, 8367.456115352483, 8421.4947103174, 8429.831403371898, 3507.5790905091553, 3514.3147086318436, 3523.594786599574, 3571.982140089283, 3599.9280014399565, 1142.1034487926938, 1153.2330999884982, 1172.6130376975577, 1199.8121859359171, 1253.8871501564904, 33010.8349458256, 33278.50082248768, 33689.663103369145, 34579.0, 35497.290054199286, 1178.393127539318, 1228.8955438787625, 1232.433080782832, 1247.108317552936, 1253.035162924543, 16241.675166496603, 16250.837491625169, 16350.264238109314, 16356.188674198766, 16603.16984150812, 512399.0, 518566.0, 518776.0, 519484.0, 520505.0, 60062.099068514006, 60627.0, 60811.39188608146, 60830.0, 60887.39112608906, 1397.3851505337618, 1439.043036380795, 1477.7413952558259, 1509.2076659753718, 1596.8243493215737, 31390.843045784626, 31693.366132676758, 33781.903940407676, 34156.487652685726, 34338.82830585931, 50766.238506421694, 51387.48612513827, 51675.74162129165, 51715.482845171064, 51753.22370164526, 374689.0, 375489.0, 376382.0, 377020.0, 378300.0, 29543.0, 29882.402351952405, 46901.951373160635, 47580.0, 48500.51499485101, 48054.5194548064, 51734.482655172964, 52160.21759673532, 52207.47792522178, 52985.735071324394, 43047.56952430436, 43183.78408107939, 43852.780736096116, 43872.0, 44021.11544640741, 36969.0, 37057.629423706494, 37289.44065839069, 37328.44007339838, 37982.240355193295, 43082.78458607687, 43590.78204608957, 43942.780286099645, 44354.77822610866, 44474.332885007396, 35670.64329356777, 37610.247795044495, 38350.61649383471, 38566.614333857426, 38967.415488767125, 29281.85359073276, 29507.0, 29827.263889927293, 29972.70027299699, 30169.396612068074], "value": 19679.681098163266, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.21335675573164, 428.9378040184171, 430.1161113910916, 432.70143600915367, 441.63785695729496, 18697.813021869777, 18732.4380268592, 19037.360561883983, 19418.51453713656, 19543.21827126917, 18520.259189632434, 18610.81389186108, 19719.802801971975, 19746.407607771755, 19751.802481975177, 5712.11462223356, 5718.59969802114, 5903.734331955051, 5910.0, 5942.524598032169, 5758.971205143968, 5831.387704291052, 5845.152452894327, 5851.76592936282, 5875.353711091777, 5527.309086364205, 5719.399463056381, 5762.654240745569, 5805.274340707411, 5811.796587119452, 5770.134479828017, 5793.71031448428, 5811.476967072984, 5823.388544202882, 5852.619579727326, 5157.535821776059, 5226.033183860998, 5246.344206974129, 5264.7367631618645, 5284.365876094855, 23471.178508752113, 23659.053637854464, 23753.7624623755, 23966.76033239663, 24027.15904943336, 2636.2882021854184, 2742.835429874194, 2780.8331500110057, 2799.0343331550584, 3013.8191708497343, 14205.928970355186, 14967.503249675054, 15051.172185529791, 15402.46091386796, 15623.296951637203, 2102.5899949509853, 2133.5946170227608, 2141.1970511058353, 2160.7299087614047, 2210.4805370737863, 59872.40127598712, 61823.69088154576, 73846.0491853467, 79900.20099799044, 79954.60022699849, 9881.75295617601, 10494.947525262478, 10548.683539493828, 10770.892291076989, 10783.46082695862, 14790.334434950239, 14792.408303667733, 14949.40202391914, 14956.0, 14965.925170374296, 8694.739157825275, 8751.824963500694, 8786.648534058566, 8791.384603077851, 8988.865167022499, 9159.587818548049, 9161.908380916238, 9185.448873067637, 9281.48951807657, 9287.349885507949, 6560.147180866456, 6611.371919667624, 6635.6350400728425, 6681.129283800544, 6703.798886033427, 1823.6899727046434, 1854.573448106943, 1870.083659007104, 1878.079740926936, 1913.1868955693774, 988.4514094677379, 998.7153661206521, 1009.016209196028, 1026.8499280805545, 1042.6663467690266, 17505.212265448085, 18127.72808407875, 18250.452486425427, 18494.51421215687, 18768.71846922297, 960.2174228004294, 976.1214906583989, 984.247051005981, 988.9456079915674, 990.153418826907, 10136.594536218616, 10400.791984160425, 10410.167186625053, 10455.21585881062, 10631.255812093079, 529241.0, 546544.0, 552608.0, 553347.6997845036, 558042.0, 92029.0, 93405.53297233471, 94667.0, 95644.52177739066, 95694.52152739331, 1042.1142029275206, 1081.1566977757361, 1097.7914196302677, 1160.4661855546542, 1164.7204670878928, 17106.230219639896, 17653.646927061644, 17756.20097095608, 17776.377826776, 18062.819371806112, 41347.0, 41366.37950430806, 41415.171696566504, 41712.1657566853, 41762.58237417587, 61285.38714612797, 61870.38129618646, 62324.065139022045, 62328.0, 62533.68733156305, 8572.3999320047, 8640.222379985831, 8691.608877600396, 8839.46963182211, 9023.323250756352, 13331.400086995915, 13353.53262635803, 13506.864931350561, 13609.183448993092, 13823.86176138266, 12120.878791212328, 12634.178778379744, 12661.177023493443, 12815.359232038174, 12826.166299190523, 12275.570355037531, 12277.877221227673, 12413.379331033593, 12651.304178269915, 12689.048321376118, 12636.620901372973, 12703.682407939506, 12877.742445150858, 12935.741285174056, 13130.343482825629, 9092.272618190662, 9114.453132812052, 9271.582778774837, 9295.395799273025, 9376.29677774156, 12208.694782630506, 12351.444185011876, 12686.619401417973, 12688.111832171659, 12742.68143296425], "value": 9678.241473921214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.2055663818523, 1491.6121808329835, 1500.6023403797992, 1659.5602165426158, 1794.9371771987976, 7723.150453450123, 7911.446198766089, 7931.960340198299, 7932.286094251516, 7935.92064079359, 8247.752567422987, 8500.064992850797, 8509.617067231973, 8514.318854491641, 8529.53087580183, 2086.926957556486, 2131.79747923947, 2338.5790557699606, 2339.1929784224417, 2374.964375534368, 2399.4601214726636, 2411.1560953666253, 2413.79482743967, 2416.3717433467336, 2418.51629674065, 2305.8501197422197, 2332.591796435617, 2395.0659242895285, 2395.7484464131276, 2395.9161429349974, 2078.906449209782, 2336.836421450499, 2377.7978871795917, 2391.593429117037, 2431.914882979096, 2301.746807851135, 2321.97678023221, 2364.9763502364926, 2367.5028244068767, 2368.4907744834945, 8441.409101362908, 8470.322374210049, 8489.74530764078, 8492.405531612789, 8500.617472213766, 5195.792168313263, 5281.313429254211, 5301.231321458406, 5313.6014798889855, 5316.415194328621, 3503.7722548034294, 3547.7693949893433, 3574.2136729919375, 3670.0457880950876, 3711.6102809205186, 1203.5967950736513, 1214.6659668591208, 1219.5914368686501, 1227.4967263422043, 1247.5009996001581, 11593.536258549648, 11691.064714822794, 11783.94108029463, 11795.351255680935, 11829.585964491287, 4531.909361812745, 4557.658175636774, 4626.953730462719, 4662.370579971661, 4668.6965347253, 9756.170725488413, 9765.707028789147, 9770.560324785401, 9779.070988256104, 9791.0, 5149.922751158736, 5160.40655324635, 5192.350956130484, 5195.610329225323, 5198.090334191501, 4132.070284186034, 4655.185342565038, 4697.976510117427, 4699.036697477009, 4708.340832283483, 4219.493660760667, 4225.19721252961, 4245.766482843412, 4246.8513602024395, 4279.443672322578, 1341.7718987771907, 1366.132505858767, 1372.6019454358125, 1374.9175049497062, 1375.8280214973129, 1007.0, 1020.6529779874729, 1023.242800327767, 1031.0153803118005, 1032.7573020340214, 5507.256520369699, 5598.4961353477565, 5656.943430565724, 5683.744231509592, 5727.169560413717, 979.0405402705246, 1010.5351538292468, 1027.6660085472251, 1029.330934892326, 1046.827273499864, 3879.2823327683905, 3925.097227637659, 3925.3326934421216, 3946.8421263149153, 3966.5438474575794, 10094.0, 10346.37921724699, 10502.264841461178, 10506.212034097472, 10553.102986246255, 10372.170226381872, 10409.271351005356, 10585.364878107339, 10606.204534659932, 10615.734606634742, 7871.567063811431, 7964.084130324971, 8073.999999999883, 8080.676772929017, 8082.636281367352, 5624.550035997192, 5644.8024319148635, 5699.088145896802, 5723.713814309352, 5875.353711091862, 9340.579673914826, 9491.477968711511, 9687.70936871895, 9860.950695246765, 9890.456024918698, 9303.76740581491, 9833.262505311986, 9843.409395436296, 10004.0, 10010.299279050689, 6268.623882567061, 6403.711832967434, 7016.859662806613, 7273.745418910313, 7451.515651482637, 7691.2308769124875, 7692.9615351922885, 7699.15309315986, 7745.380369570308, 7755.806104847424, 6793.592384456949, 6961.582305061713, 7002.334778196063, 7021.0, 7169.175544812413, 6802.6258555779905, 6828.965855170891, 6885.483588730765, 6911.997760324825, 7103.25415831351, 6613.2394774601535, 6629.801105966829, 6715.26132125456, 6785.830354240986, 6802.965985170043, 4914.8771280718265, 4934.383202099738, 4964.0, 4973.278874563096, 5003.874903127451, 4978.651494395358, 5051.621128415457, 5080.7205603692155, 5101.719405432588, 5145.871353216199], "value": 4549.795112810331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.9679880411361, 339.8759452799728, 342.88247900091136, 354.9503069570259, 356.55786824337827, 6168.013117901137, 6173.104899789533, 6184.536159788017, 6229.940910045292, 6404.071409645599, 6207.813765587029, 6227.937720622804, 6253.656048917308, 6270.122182894398, 6270.49836013119, 4737.313089602006, 4739.360186374838, 4740.146773580754, 4741.525847415265, 4747.881302967419, 4477.888052798689, 4523.208438523262, 4622.052479241747, 4643.2802915548145, 4684.601808846252, 4607.769611519428, 4614.123316569858, 4625.468071171825, 4633.6524760642915, 4637.0, 4415.911681766379, 4610.861674149781, 4612.584867361937, 4614.100250451163, 4624.352590637313, 3906.121122747359, 3929.2337994091163, 3953.0, 3963.4054891766177, 3983.4423180754716, 6006.429389208019, 6006.969965150146, 6012.068129439944, 6020.759169633209, 6025.548083893682, 5378.193271009341, 5383.650062745909, 5391.73041347931, 5393.676379417208, 5397.568194544427, 6468.191476065492, 6513.478921686254, 6524.314946930599, 6532.248791389004, 6536.248331441898, 4416.757078360689, 4428.867133985986, 4434.822607095713, 4437.090396468749, 4447.3996010538485, 6617.106690596756, 6837.863242735167, 6848.863022739517, 6902.171739391305, 6908.205556361033, 4549.772511374418, 4586.954130458719, 4594.471635761864, 4596.448426188878, 4612.123696497655, 4649.442066951988, 4657.04530571232, 4662.0209755950955, 4668.463126740468, 4674.322223277673, 5418.268533747893, 5430.13117901134, 5431.321084864392, 5437.211604317431, 5438.972805135949, 6615.966920165369, 6616.338366163345, 6624.6025238485845, 6631.171103612049, 6632.701528431232, 1559.1892216047593, 1564.3038847712887, 1564.820045694737, 1574.8424907692836, 1580.7707882356995, 1054.5728979763207, 1057.6721216422934, 1062.574970011986, 1071.614218881202, 1071.8177909755361, 6232.345603711636, 6290.087937249074, 6342.23893132827, 6380.266269378988, 6434.74261029563, 6846.075779769767, 6852.931470685229, 6870.0, 6879.2432832388395, 6885.139357580302, 6486.805395838132, 6493.610383377012, 6494.740210391626, 6500.804975850638, 6501.577397469149, 3652.908677283036, 3688.262347530451, 3689.870854520079, 3692.778433294011, 3694.168812017275, 6796.796096117125, 7071.151461824614, 7113.110861142357, 7113.466490013269, 7126.750563730348, 7000.579965202104, 7031.980362847358, 7033.964830175816, 7036.542624729376, 7044.753433629799, 7067.399271062018, 7078.610676412847, 7080.716771329089, 7095.716171353191, 7098.077249957576, 6803.829904252433, 6839.726410943506, 6851.07510486078, 6854.2117656470145, 6857.348551887762, 6562.146920900253, 6748.628825414649, 6749.223839258548, 6757.797266082025, 6796.422304104207, 7088.291170883077, 7100.289971002859, 7113.786586402416, 7114.359707626339, 7114.395276401564, 4663.300504924153, 4703.529647035269, 4706.952930470651, 4717.0, 4719.74041427711, 6774.0, 6789.796306110825, 6815.773160831098, 6836.077129587641, 6905.896411553931, 6469.967650161719, 6668.866622667422, 6674.599524028379, 6681.432078273401, 6684.429159147499, 6641.468682505291, 6665.166854143232, 6673.532852700265, 6675.666216689049, 6675.7997260082275, 6535.705893234721, 6539.378759017885, 6540.247871494648, 6541.771038013647, 6554.14796076507, 6704.262531121475, 6709.664516774044, 6711.530192886647, 6715.328467153441, 6716.093327400934, 6409.9038514423255, 6535.019747037983, 6539.836504087436, 6546.934530654823, 6550.0], "value": 4944.903891440614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.1996903251585, 795.5266616363261, 820.8112134209132, 824.6618886256636, 840.2269911681254, 14352.497662581798, 14628.780568291484, 14653.92673036636, 14670.119792812426, 14698.779518307234, 13244.0, 13686.794698079537, 13762.58712238632, 13772.173669579832, 13786.17282963023, 756.5385115079797, 870.29071306885, 876.0538618292229, 877.5305211711735, 891.9821603567925, 895.5746020640177, 896.8834051573319, 897.0401670212875, 897.6499165325496, 898.3756289378852, 933.4446004627235, 935.1256575102267, 935.5930170375874, 936.8032713130251, 937.9015203403646, 791.2404092071589, 932.9253659707207, 933.4352716606492, 946.342292106986, 948.4830767231875, 697.5779653309776, 698.4656737595743, 698.4901022253783, 699.7830672491493, 699.8775214337521, 13872.306384680725, 13930.442782288696, 13934.512292069729, 13967.231802250872, 13983.091099078527, 13111.278879661615, 13660.931695341558, 13687.863121368759, 13857.0, 13902.860971390359, 10600.840987385196, 10866.565337386495, 10926.125909927187, 10936.726581835439, 10984.670459886136, 3903.512060992376, 3914.471546341236, 3939.5075615548058, 3974.7615143091216, 4043.110515686544, 60647.0, 60809.6959515204, 60922.0, 61049.0, 61919.690401547705, 10757.139428845674, 10764.569417223223, 10995.360586366196, 11097.83353249702, 11226.494807733672, 19819.207231710858, 19988.60022799565, 19997.800021999592, 20013.0, 20035.29876454317, 8649.048604653482, 8691.478511289342, 8718.476891386537, 8858.15847494487, 8949.0, 4821.975890120527, 4890.24201248807, 4938.629602779734, 4957.132501812169, 5160.587153027749, 3460.307938412277, 3481.234128491728, 3509.1578021275222, 3515.33208690348, 3520.6831385174946, 610.7709608896664, 651.3096118114719, 654.7413771560302, 657.6317262333013, 661.153723234261, 664.8534300392803, 681.9352161544646, 694.9478789090839, 710.3571268002363, 713.6752777486336, 9096.862892138482, 9175.70607348163, 9358.251339892928, 9358.532073396304, 9531.0, 668.7358493395179, 674.6222115615271, 687.6802286936598, 691.4226620771713, 698.9091418115612, 4409.382686423904, 4447.043885564619, 4453.153900758845, 4494.460664720189, 4564.931526027112, 68634.65682671555, 70257.0, 70769.64615176892, 70772.0, 70813.0, 60482.39517604856, 60949.39050609526, 61445.0, 62367.37632623615, 62535.06197407043, 54693.179602305994, 55175.0, 55414.72292638511, 55572.44427555754, 56558.43441565614, 8622.353323500636, 8823.382363234512, 8994.55027248648, 9052.683156089506, 9079.364444489087, 38978.0, 38987.80506097451, 40107.59892401155, 40160.59839401569, 40563.594364057164, 52456.475435246684, 52495.73752131215, 53190.4680953201, 53428.0, 53719.46280537301, 12009.0, 12118.818217726564, 12138.514459421523, 12356.25862448256, 12427.813582796085, 13092.672683182996, 13593.252371119683, 13620.523281685093, 13632.65918352049, 14029.368678409292, 12616.432260548481, 12670.87329126697, 12967.870321296667, 13037.674058148623, 13324.333783310989, 12249.755004899675, 12350.505979760708, 12564.246145231315, 12647.620571382873, 13134.671633209246, 12531.561395351118, 12600.936995314965, 12641.557545486232, 12697.80953285683, 12698.174618649758, 10788.568457261621, 10860.348379096964, 10962.342259464138, 11055.115590752559, 11149.498272577592, 10218.38689678592, 10365.792684146425, 10389.84415233757, 10460.0, 10469.842952355873], "value": 7007.762344448776, "unit": "score"}], "name": "dromaeo_css", "value": 7395.137492587206, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 112.0, 111.0, 110.0, 111.0, 106.0, 108.0, 109.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 139.0, 155.0, 175.0, 131.0, 160.0, 157.0, 128.0, 201.0, 126.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 160.0, 160.0, 162.0, 162.0, 160.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 168.0, 75.0, 74.0, 73.0, 74.0, 171.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 159.0, 91.0, 92.0, 93.0, 149.0, 92.0, 92.0, 140.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 144.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 54.0, 55.0, 55.0, 53.0, 53.0, 75.0, 53.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 57.0, 57.0, 58.0, 58.0, 57.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 80.0, 73.0, 73.0, 73.0, 73.0, 72.0, 83.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 130.0, 119.0, 113.0, 113.0, 114.0, 111.0, 111.0, 129.0, 127.0], "value": 118.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 155.0, 160.0, 154.0, 158.0, 153.0, 156.0, 156.0, 155.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 65.0, 67.0, 67.0, 66.0, 65.0, 65.0, 62.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1511.7, "alertThreshold": 2.0}]} 12:56:37 INFO - Return code: 0 12:56:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:56:37 ERROR - # TBPL SUCCESS # 12:56:37 INFO - Running post-action listener: _resource_record_post_action 12:56:37 INFO - Running post-run listener: _resource_record_post_run 12:56:38 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 266448896; Read time: 36; Write time: 238588 12:56:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20066304; Read time: 0; Write time: 14492 12:56:38 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246382592; Read time: 36; Write time: 224096 12:56:38 INFO - Running post-run listener: _upload_blobber_files 12:56:38 INFO - Blob upload gear active. 12:56:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:56:38 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 12:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:56:38 INFO - (blobuploader) - INFO - Open directory for files ... 12:56:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:56:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:56:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:56:39 INFO - (blobuploader) - INFO - Done attempting. 12:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:56:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:56:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:56:40 INFO - (blobuploader) - INFO - Done attempting. 12:56:40 INFO - (blobuploader) - INFO - Iteration through files over. 12:56:40 INFO - Return code: 0 12:56:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:56:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:56:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/208ec872696e094ccb90a3155e0237a14c436079b72969b17d1f68b6e1eee6764a0c35fcedd732235ddc2b98e7ca7ec2e2ff0112a28797aa17decb3efd82b78c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a14268412d5fc1a55ae6d0b14e31b66d725f9eb5e0b59eeefe8c37b4b4246f2f2902400ece72c4ee8159e59055b2305fd0ae1caa819ec867d67fe28eb690c4"} 12:56:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:56:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:56:40 INFO - Contents: 12:56:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/208ec872696e094ccb90a3155e0237a14c436079b72969b17d1f68b6e1eee6764a0c35fcedd732235ddc2b98e7ca7ec2e2ff0112a28797aa17decb3efd82b78c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a14268412d5fc1a55ae6d0b14e31b66d725f9eb5e0b59eeefe8c37b4b4246f2f2902400ece72c4ee8159e59055b2305fd0ae1caa819ec867d67fe28eb690c4"} 12:56:40 INFO - Running post-run listener: copy_logs_to_upload_dir 12:56:40 INFO - Copying logs to upload dir... 12:56:40 INFO - mkdir: /builds/slave/test/build/upload/logs 12:56:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.048013 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-05-19 12:56:40.380597) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 12:56:40.384043) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/208ec872696e094ccb90a3155e0237a14c436079b72969b17d1f68b6e1eee6764a0c35fcedd732235ddc2b98e7ca7ec2e2ff0112a28797aa17decb3efd82b78c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a14268412d5fc1a55ae6d0b14e31b66d725f9eb5e0b59eeefe8c37b4b4246f2f2902400ece72c4ee8159e59055b2305fd0ae1caa819ec867d67fe28eb690c4"} build_url:https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/EQYzjkjlRVGQ_YT0Fm6c3Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/208ec872696e094ccb90a3155e0237a14c436079b72969b17d1f68b6e1eee6764a0c35fcedd732235ddc2b98e7ca7ec2e2ff0112a28797aa17decb3efd82b78c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a14268412d5fc1a55ae6d0b14e31b66d725f9eb5e0b59eeefe8c37b4b4246f2f2902400ece72c4ee8159e59055b2305fd0ae1caa819ec867d67fe28eb690c4"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 12:56:40.458835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:56:40.459187) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463686125.580330-801077226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:56:40.475079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 12:56:40.475369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 12:56:40.475660) ========= ========= Total master_lag: 0.22 =========