builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1462800065.36 results: success (0) buildid: 20160509005049 builduid: 41dbd660830c4270b4520649f25740b3 revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.360292) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.360676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.360941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.377902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.378152) ========= 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=32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 06:21:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.4M=0s 2016-05-09 06:21:05 (67.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151020 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.542097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.542427) ========= 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=32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020993 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.590928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:21:05.591240) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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=32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:21:06,093 truncating revision to first 12 chars 2016-05-09 06:21:06,093 Setting DEBUG logging. 2016-05-09 06:21:06,093 attempt 1/10 2016-05-09 06:21:06,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307b5eca8726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 06:21:06,777 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=0.990033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:21:06.593829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.594133) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.594541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.594806) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.600846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-09 06:21:06.601108) ========= /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=32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:21:07 INFO - MultiFileLogger online at 20160509 06:21:07 in /builds/slave/test 06:21:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:21:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:21:07 INFO - {'append_to_log': False, 06:21:07 INFO - 'base_work_dir': '/builds/slave/test', 06:21:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:21:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:21:07 INFO - 'branch': 'Mozilla-Aurora', 06:21:07 INFO - 'buildbot_json_path': 'buildprops.json', 06:21:07 INFO - 'config_files': ('talos/linux_config.py',), 06:21:07 INFO - 'default_actions': ('clobber', 06:21:07 INFO - 'read-buildbot-config', 06:21:07 INFO - 'download-and-extract', 06:21:07 INFO - 'populate-webroot', 06:21:07 INFO - 'create-virtualenv', 06:21:07 INFO - 'install', 06:21:07 INFO - 'run-tests'), 06:21:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:21:07 INFO - 'download_minidump_stackwalk': True, 06:21:07 INFO - 'download_symbols': 'ondemand', 06:21:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:21:07 INFO - 'tooltool.py': '/tools/tooltool.py', 06:21:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:21:07 INFO - '/tools/misc-python/virtualenv.py')}, 06:21:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:21:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:21:07 INFO - 'installer_path': 'installer.exe', 06:21:07 INFO - 'log_level': 'info', 06:21:07 INFO - 'log_name': 'talos', 06:21:07 INFO - 'log_to_console': True, 06:21:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:21:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:21:07 INFO - 'opt_config_files': (), 06:21:07 INFO - 'pip_index': False, 06:21:07 INFO - 'sps_profile': False, 06:21:07 INFO - 'sps_profile_interval': 0, 06:21:07 INFO - 'suite': 'dromaeojs', 06:21:07 INFO - 'system_bits': '32', 06:21:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:21:07 INFO - 'title': 'talos-linux64-ix-008', 06:21:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:21:07 INFO - 'use_talos_json': True, 06:21:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:21:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:21:07 INFO - 'work_dir': 'build'} 06:21:07 INFO - ##### 06:21:07 INFO - ##### Running clobber step. 06:21:07 INFO - ##### 06:21:07 INFO - Running pre-action listener: _resource_record_pre_action 06:21:07 INFO - Running main action method: clobber 06:21:07 INFO - rmtree: /builds/slave/test/build 06:21:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:21:07 INFO - Running post-action listener: _resource_record_post_action 06:21:07 INFO - ##### 06:21:07 INFO - ##### Running read-buildbot-config step. 06:21:07 INFO - ##### 06:21:07 INFO - Running pre-action listener: _resource_record_pre_action 06:21:07 INFO - Running main action method: read_buildbot_config 06:21:07 INFO - Using buildbot properties: 06:21:07 INFO - { 06:21:07 INFO - "project": "", 06:21:07 INFO - "product": "firefox", 06:21:07 INFO - "script_repo_revision": "production", 06:21:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:21:07 INFO - "repository": "", 06:21:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:21:07 INFO - "buildid": "20160509005049", 06:21:07 INFO - "pgo_build": "True", 06:21:07 INFO - "basedir": "/builds/slave/test", 06:21:07 INFO - "buildnumber": 318, 06:21:07 INFO - "slavename": "talos-linux64-ix-008", 06:21:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:21:07 INFO - "platform": "ubuntu64_hw", 06:21:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:21:07 INFO - "branch": "mozilla-aurora", 06:21:07 INFO - "repo_path": "releases/mozilla-aurora", 06:21:07 INFO - "revision": "307b5eca8726f6a72a1d69ba76630a6dbf402477", 06:21:07 INFO - "stage_platform": "linux64-pgo", 06:21:07 INFO - "builduid": "41dbd660830c4270b4520649f25740b3", 06:21:07 INFO - "slavebuilddir": "test" 06:21:07 INFO - } 06:21:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 06:21:07 INFO - Running post-action listener: _resource_record_post_action 06:21:07 INFO - ##### 06:21:07 INFO - ##### Running download-and-extract step. 06:21:07 INFO - ##### 06:21:07 INFO - Running pre-action listener: _resource_record_pre_action 06:21:07 INFO - Running main action method: download_and_extract 06:21:07 INFO - mkdir: /builds/slave/test/build/tests 06:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:07 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:21:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:21:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:21:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:11 INFO - Downloaded 1361 bytes. 06:21:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:21:11 INFO - Using the following test package requirements: 06:21:11 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:21:11 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:21:11 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:21:11 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:11 INFO - u'jsshell-linux-x86_64.zip'], 06:21:11 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:21:11 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:21:11 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:21:11 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:21:11 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:21:11 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:21:11 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:11 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:21:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:21:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:21:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:13 INFO - Downloaded 23798585 bytes. 06:21:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:21:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:21:14 INFO - Return code: 0 06:21:14 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:14 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:15 INFO - Downloaded 23798585 bytes. 06:21:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:21:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:21:17 INFO - Return code: 0 06:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:17 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:18 INFO - Downloaded 10840145 bytes. 06:21:18 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'] 06:21:18 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 06:21:18 INFO - Return code: 0 06:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:18 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:21:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:21:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:21:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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 06:21:19 INFO - Downloaded 62704189 bytes. 06:21:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:21:19 INFO - mkdir: /builds/slave/test/properties 06:21:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:19 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:19 INFO - Contents: 06:21:19 INFO - build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:21:21 INFO - Running post-action listener: _resource_record_post_action 06:21:21 INFO - Running post-action listener: set_extra_try_arguments 06:21:21 INFO - ##### 06:21:21 INFO - ##### Running populate-webroot step. 06:21:21 INFO - ##### 06:21:21 INFO - Running pre-action listener: _resource_record_pre_action 06:21:21 INFO - Running main action method: populate_webroot 06:21:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:21 INFO - '--tppagecycles', 06:21:21 INFO - '7'], 06:21:21 INFO - 'tests': ['tsvgm']}}, 06:21:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:21:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:21:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:21 INFO - 'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:21 INFO - 'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['damp', 'tps']}, 06:21:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:21 INFO - 'tests': ['damp', 'tps']}, 06:21:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['dromaeo_dom']}, 06:21:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['a11yr', 06:21:21 INFO - 'ts_paint', 06:21:21 INFO - 'tpaint', 06:21:21 INFO - 'sessionrestore', 06:21:21 INFO - 'sessionrestore_no_auto_restore', 06:21:21 INFO - 'tabpaint']}, 06:21:21 INFO - 'other-e10s': {'tests': ['a11yr', 06:21:21 INFO - 'ts_paint', 06:21:21 INFO - 'tpaint', 06:21:21 INFO - 'sessionrestore', 06:21:21 INFO - 'sessionrestore_no_auto_restore', 06:21:21 INFO - 'tabpaint']}, 06:21:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:21:21 INFO - 'ts_paint', 06:21:21 INFO - 'tpaint', 06:21:21 INFO - 'sessionrestore', 06:21:21 INFO - 'sessionrestore_no_auto_restore', 06:21:21 INFO - 'tabpaint']}, 06:21:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:21:21 INFO - 'ts_paint', 06:21:21 INFO - 'tpaint', 06:21:21 INFO - 'sessionrestore', 06:21:21 INFO - 'sessionrestore_no_auto_restore', 06:21:21 INFO - 'tabpaint']}, 06:21:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['a11yr', 06:21:21 INFO - 'ts_paint', 06:21:21 INFO - 'tpaint', 06:21:21 INFO - 'sessionrestore', 06:21:21 INFO - 'sessionrestore_no_auto_restore', 06:21:21 INFO - 'tabpaint']}, 06:21:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['a11yr', 06:21:21 INFO - 'ts_paint', 06:21:21 INFO - 'tpaint', 06:21:21 INFO - 'sessionrestore', 06:21:21 INFO - 'sessionrestore_no_auto_restore', 06:21:21 INFO - 'tabpaint']}, 06:21:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['tsvgx', 06:21:21 INFO - 'tsvgr_opacity', 06:21:21 INFO - 'tart', 06:21:21 INFO - 'tscrollx', 06:21:21 INFO - 'cart']}, 06:21:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:21:21 INFO - 'tsvgr_opacity', 06:21:21 INFO - 'tart', 06:21:21 INFO - 'tscrollx', 06:21:21 INFO - 'cart']}, 06:21:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:21 INFO - 'talos_options': ['--disable-e10s'], 06:21:21 INFO - 'tests': ['tp5o']}, 06:21:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:21 INFO - 'tests': ['tp5o']}, 06:21:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:21 INFO - 'talos_options': ['--disable-e10s', 06:21:21 INFO - '--xperf_path', 06:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:21 INFO - 'tests': ['tp5n']}, 06:21:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:21 INFO - 'talos_options': ['--xperf_path', 06:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:21 INFO - 'tests': ['tp5n']}}, 06:21:21 INFO - 'talos.zip': {'path': '', 06:21:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:21 INFO - Running post-action listener: _resource_record_post_action 06:21:21 INFO - ##### 06:21:21 INFO - ##### Running create-virtualenv step. 06:21:21 INFO - ##### 06:21:21 INFO - Running pre-action listener: _resource_record_pre_action 06:21:21 INFO - Running main action method: create_virtualenv 06:21:21 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:21:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:21 INFO - Using real prefix '/usr' 06:21:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:22 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:24 INFO - Installing pip.................done. 06:21:24 INFO - Return code: 0 06:21:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24bbe4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b67d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, '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': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:21:24 INFO - Using env: {'DISPLAY': ':0', 06:21:24 INFO - 'HOME': '/home/cltbld', 06:21:24 INFO - 'LANG': 'en_US.UTF-8', 06:21:24 INFO - 'LANGUAGE': 'en_US:en', 06:21:24 INFO - 'LOGNAME': 'cltbld', 06:21:24 INFO - 'MAIL': '/var/mail/cltbld', 06:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:24 INFO - 'MOZ_NO_REMOTE': '1', 06:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:24 INFO - 'NO_EM_RESTART': '1', 06:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:24 INFO - 'PWD': '/builds/slave/test', 06:21:24 INFO - 'SHELL': '/bin/bash', 06:21:24 INFO - 'SHLVL': '1', 06:21:24 INFO - 'TERM': 'linux', 06:21:24 INFO - 'TMOUT': '86400', 06:21:24 INFO - 'USER': 'cltbld', 06:21:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:24 INFO - '_': '/tools/buildbot/bin/python'} 06:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:21:24 INFO - Cleaning up... 06:21:24 INFO - Return code: 0 06:21:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f24bbe4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b67d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, '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': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:21:24 INFO - Using env: {'DISPLAY': ':0', 06:21:24 INFO - 'HOME': '/home/cltbld', 06:21:24 INFO - 'LANG': 'en_US.UTF-8', 06:21:24 INFO - 'LANGUAGE': 'en_US:en', 06:21:24 INFO - 'LOGNAME': 'cltbld', 06:21:24 INFO - 'MAIL': '/var/mail/cltbld', 06:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:24 INFO - 'MOZ_NO_REMOTE': '1', 06:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:24 INFO - 'NO_EM_RESTART': '1', 06:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:24 INFO - 'PWD': '/builds/slave/test', 06:21:24 INFO - 'SHELL': '/bin/bash', 06:21:24 INFO - 'SHLVL': '1', 06:21:24 INFO - 'TERM': 'linux', 06:21:24 INFO - 'TMOUT': '86400', 06:21:24 INFO - 'USER': 'cltbld', 06:21:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:24 INFO - '_': '/tools/buildbot/bin/python'} 06:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:24 INFO - Downloading/unpacking psutil>=0.7.1 06:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:26 INFO - Installing collected packages: psutil 06:21:26 INFO - Running setup.py install for psutil 06:21:26 INFO - building 'psutil._psutil_linux' extension 06:21:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:21:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:21:26 INFO - building 'psutil._psutil_posix' extension 06:21:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:21:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:21:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:26 INFO - Successfully installed psutil 06:21:26 INFO - Cleaning up... 06:21:27 INFO - Return code: 0 06:21:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:27 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 0x7f24bbe4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b67d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, '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': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:21:27 INFO - Using env: {'DISPLAY': ':0', 06:21:27 INFO - 'HOME': '/home/cltbld', 06:21:27 INFO - 'LANG': 'en_US.UTF-8', 06:21:27 INFO - 'LANGUAGE': 'en_US:en', 06:21:27 INFO - 'LOGNAME': 'cltbld', 06:21:27 INFO - 'MAIL': '/var/mail/cltbld', 06:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:27 INFO - 'MOZ_NO_REMOTE': '1', 06:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:27 INFO - 'NO_EM_RESTART': '1', 06:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:27 INFO - 'PWD': '/builds/slave/test', 06:21:27 INFO - 'SHELL': '/bin/bash', 06:21:27 INFO - 'SHLVL': '1', 06:21:27 INFO - 'TERM': 'linux', 06:21:27 INFO - 'TMOUT': '86400', 06:21:27 INFO - 'USER': 'cltbld', 06:21:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:27 INFO - '_': '/tools/buildbot/bin/python'} 06:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:21:29 INFO - Installing collected packages: mozsystemmonitor 06:21:29 INFO - Running setup.py install for mozsystemmonitor 06:21:29 INFO - Successfully installed mozsystemmonitor 06:21:29 INFO - Cleaning up... 06:21:29 INFO - Return code: 0 06:21:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:21: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')]} 06:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21: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')]} 06:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21: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', '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 0x7f24bbe4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b67d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, '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': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:21: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 blobuploader==1.2.4 06:21:29 INFO - Using env: {'DISPLAY': ':0', 06:21:29 INFO - 'HOME': '/home/cltbld', 06:21:29 INFO - 'LANG': 'en_US.UTF-8', 06:21:29 INFO - 'LANGUAGE': 'en_US:en', 06:21:29 INFO - 'LOGNAME': 'cltbld', 06:21:29 INFO - 'MAIL': '/var/mail/cltbld', 06:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:29 INFO - 'MOZ_NO_REMOTE': '1', 06:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:29 INFO - 'NO_EM_RESTART': '1', 06:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:29 INFO - 'PWD': '/builds/slave/test', 06:21:29 INFO - 'SHELL': '/bin/bash', 06:21:29 INFO - 'SHLVL': '1', 06:21:29 INFO - 'TERM': 'linux', 06:21:29 INFO - 'TMOUT': '86400', 06:21:29 INFO - 'USER': 'cltbld', 06:21:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:29 INFO - '_': '/tools/buildbot/bin/python'} 06:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:29 INFO - Downloading/unpacking blobuploader==1.2.4 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:21:31 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:21: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 06:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:32 INFO - Downloading docopt-0.6.1.tar.gz 06:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:32 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:32 INFO - Running setup.py install for blobuploader 06:21:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:32 INFO - Running setup.py install for requests 06:21:32 INFO - Running setup.py install for docopt 06:21:32 INFO - Successfully installed blobuploader requests docopt 06:21:32 INFO - Cleaning up... 06:21:32 INFO - Return code: 0 06:21:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:32 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 0x7f24bbe4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b67d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, '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': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:21:32 INFO - Using env: {'DISPLAY': ':0', 06:21:32 INFO - 'HOME': '/home/cltbld', 06:21:32 INFO - 'LANG': 'en_US.UTF-8', 06:21:32 INFO - 'LANGUAGE': 'en_US:en', 06:21:32 INFO - 'LOGNAME': 'cltbld', 06:21:32 INFO - 'MAIL': '/var/mail/cltbld', 06:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:32 INFO - 'MOZ_NO_REMOTE': '1', 06:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:32 INFO - 'NO_EM_RESTART': '1', 06:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:32 INFO - 'PWD': '/builds/slave/test', 06:21:32 INFO - 'SHELL': '/bin/bash', 06:21:32 INFO - 'SHLVL': '1', 06:21:32 INFO - 'TERM': 'linux', 06:21:32 INFO - 'TMOUT': '86400', 06:21:32 INFO - 'USER': 'cltbld', 06:21:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:32 INFO - '_': '/tools/buildbot/bin/python'} 06:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:33 INFO - Running setup.py (path:/tmp/pip-Mn66TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:33 INFO - Running setup.py (path:/tmp/pip-b6v3dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:33 INFO - Running setup.py (path:/tmp/pip-e58PSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:33 INFO - Running setup.py (path:/tmp/pip-PCVkyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:33 INFO - Running setup.py (path:/tmp/pip-EPgKnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:33 INFO - Running setup.py (path:/tmp/pip-_YMkJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:33 INFO - Running setup.py (path:/tmp/pip-MLEh72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:33 INFO - Running setup.py (path:/tmp/pip-9MGrak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:33 INFO - Running setup.py (path:/tmp/pip-76e5sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:33 INFO - Running setup.py (path:/tmp/pip-0aBKwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:33 INFO - Running setup.py (path:/tmp/pip-bR9IuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:33 INFO - Running setup.py (path:/tmp/pip-NGXvRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:34 INFO - Running setup.py (path:/tmp/pip-Pd2JpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:34 INFO - Running setup.py (path:/tmp/pip-ezY4tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:34 INFO - Running setup.py (path:/tmp/pip-dyiZY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:34 INFO - Running setup.py (path:/tmp/pip-A2Rmfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:34 INFO - Running setup.py (path:/tmp/pip-xHczRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:34 INFO - Running setup.py install for manifestparser 06:21:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:34 INFO - Running setup.py install for mozcrash 06:21:34 INFO - Running setup.py install for mozdebug 06:21:34 INFO - Running setup.py install for mozdevice 06:21:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:21:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:34 INFO - Running setup.py install for mozfile 06:21:34 INFO - Running setup.py install for mozhttpd 06:21:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:34 INFO - Running setup.py install for mozinfo 06:21:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Running setup.py install for mozInstall 06:21:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Running setup.py install for mozleak 06:21:35 INFO - Running setup.py install for mozlog 06:21:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Running setup.py install for moznetwork 06:21:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Running setup.py install for mozprocess 06:21:35 INFO - Running setup.py install for mozprofile 06:21:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Running setup.py install for mozrunner 06:21:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:35 INFO - Running setup.py install for mozscreenshot 06:21:35 INFO - Running setup.py install for moztest 06:21:36 INFO - Running setup.py install for mozversion 06:21:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:36 INFO - Cleaning up... 06:21:36 INFO - Return code: 0 06:21:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 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 0x7f24bbe4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b67d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, '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': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:21:36 INFO - Using env: {'DISPLAY': ':0', 06:21:36 INFO - 'HOME': '/home/cltbld', 06:21:36 INFO - 'LANG': 'en_US.UTF-8', 06:21:36 INFO - 'LANGUAGE': 'en_US:en', 06:21:36 INFO - 'LOGNAME': 'cltbld', 06:21:36 INFO - 'MAIL': '/var/mail/cltbld', 06:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:36 INFO - 'MOZ_NO_REMOTE': '1', 06:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:36 INFO - 'NO_EM_RESTART': '1', 06:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:36 INFO - 'PWD': '/builds/slave/test', 06:21:36 INFO - 'SHELL': '/bin/bash', 06:21:36 INFO - 'SHLVL': '1', 06:21:36 INFO - 'TERM': 'linux', 06:21:36 INFO - 'TMOUT': '86400', 06:21:36 INFO - 'USER': 'cltbld', 06:21:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:36 INFO - '_': '/tools/buildbot/bin/python'} 06:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:36 INFO - Running setup.py (path:/tmp/pip-1qrzli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:36 INFO - Running setup.py (path:/tmp/pip-c8tAZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:36 INFO - Running setup.py (path:/tmp/pip-GjhIaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:36 INFO - Running setup.py (path:/tmp/pip-ZqOXbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:36 INFO - Running setup.py (path:/tmp/pip-Q34IiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:36 INFO - Running setup.py (path:/tmp/pip-Ol8xvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:36 INFO - Running setup.py (path:/tmp/pip-8ZU97s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:36 INFO - Running setup.py (path:/tmp/pip-e0TADV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:36 INFO - Running setup.py (path:/tmp/pip-whaL08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:37 INFO - Running setup.py (path:/tmp/pip-cg8TeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:37 INFO - Running setup.py (path:/tmp/pip-FD4dqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:37 INFO - Running setup.py (path:/tmp/pip-gdymCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:37 INFO - Running setup.py (path:/tmp/pip-zXxfN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:37 INFO - Running setup.py (path:/tmp/pip-jMxG5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:37 INFO - Running setup.py (path:/tmp/pip-Qi4MtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:37 INFO - Running setup.py (path:/tmp/pip-GHC7gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:37 INFO - Running setup.py (path:/tmp/pip-VMrSpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:21:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:39 INFO - Downloading blessings-1.6.tar.gz 06:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:39 INFO - Installing collected packages: blessings 06:21:39 INFO - Running setup.py install for blessings 06:21:39 INFO - Successfully installed blessings 06:21:39 INFO - Cleaning up... 06:21:39 INFO - Return code: 0 06:21:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:39 INFO - Reading from file tmpfile_stdout 06:21:39 INFO - Current package versions: 06:21:39 INFO - argparse == 1.2.1 06:21:39 INFO - blessings == 1.6 06:21:39 INFO - blobuploader == 1.2.4 06:21:39 INFO - docopt == 0.6.1 06:21:39 INFO - manifestparser == 1.1 06:21:39 INFO - mozInstall == 1.12 06:21:39 INFO - mozcrash == 0.17 06:21:39 INFO - mozdebug == 0.1 06:21:39 INFO - mozdevice == 0.48 06:21:39 INFO - mozfile == 1.2 06:21:39 INFO - mozhttpd == 0.7 06:21:39 INFO - mozinfo == 0.9 06:21:39 INFO - mozleak == 0.1 06:21:39 INFO - mozlog == 3.1 06:21:39 INFO - moznetwork == 0.27 06:21:39 INFO - mozprocess == 0.22 06:21:39 INFO - mozprofile == 0.28 06:21:39 INFO - mozrunner == 6.11 06:21:39 INFO - mozscreenshot == 0.1 06:21:39 INFO - mozsystemmonitor == 0.0 06:21:39 INFO - moztest == 0.7 06:21:39 INFO - mozversion == 1.4 06:21:39 INFO - psutil == 3.1.1 06:21:39 INFO - requests == 1.2.3 06:21:39 INFO - wsgiref == 0.1.2 06:21:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:39 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 0x7f24bbe4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b67d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, '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': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:21:39 INFO - Using env: {'DISPLAY': ':0', 06:21:39 INFO - 'HOME': '/home/cltbld', 06:21:39 INFO - 'LANG': 'en_US.UTF-8', 06:21:39 INFO - 'LANGUAGE': 'en_US:en', 06:21:39 INFO - 'LOGNAME': 'cltbld', 06:21:39 INFO - 'MAIL': '/var/mail/cltbld', 06:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:39 INFO - 'MOZ_NO_REMOTE': '1', 06:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:39 INFO - 'NO_EM_RESTART': '1', 06:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:39 INFO - 'PWD': '/builds/slave/test', 06:21:39 INFO - 'SHELL': '/bin/bash', 06:21:39 INFO - 'SHLVL': '1', 06:21:39 INFO - 'TERM': 'linux', 06:21:39 INFO - 'TMOUT': '86400', 06:21:39 INFO - 'USER': 'cltbld', 06:21:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:39 INFO - '_': '/tools/buildbot/bin/python'} 06:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:21:40 INFO - Cleaning up... 06:21:40 INFO - Return code: 0 06:21:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:40 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 0x7f24bbe4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b67d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, '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': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:21:40 INFO - Using env: {'DISPLAY': ':0', 06:21:40 INFO - 'HOME': '/home/cltbld', 06:21:40 INFO - 'LANG': 'en_US.UTF-8', 06:21:40 INFO - 'LANGUAGE': 'en_US:en', 06:21:40 INFO - 'LOGNAME': 'cltbld', 06:21:40 INFO - 'MAIL': '/var/mail/cltbld', 06:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:40 INFO - 'MOZ_NO_REMOTE': '1', 06:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:40 INFO - 'NO_EM_RESTART': '1', 06:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:40 INFO - 'PWD': '/builds/slave/test', 06:21:40 INFO - 'SHELL': '/bin/bash', 06:21:40 INFO - 'SHLVL': '1', 06:21:40 INFO - 'TERM': 'linux', 06:21:40 INFO - 'TMOUT': '86400', 06:21:40 INFO - 'USER': 'cltbld', 06:21:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:40 INFO - '_': '/tools/buildbot/bin/python'} 06:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:40 INFO - Downloading/unpacking jsonschema 06:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:21:42 INFO - Downloading/unpacking functools32 (from jsonschema) 06:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:42 INFO - Downloading functools32-3.2.3-2.tar.gz 06:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:21:42 INFO - warning: no files found matching '*.txt' 06:21:42 INFO - no previously-included directories found matching 'build' 06:21:42 INFO - no previously-included directories found matching 'dist' 06:21:42 INFO - no previously-included directories found matching '.git*' 06:21:42 INFO - Installing collected packages: jsonschema, functools32 06:21:42 INFO - Running setup.py install for functools32 06:21:42 INFO - warning: no files found matching '*.txt' 06:21:42 INFO - no previously-included directories found matching 'build' 06:21:42 INFO - no previously-included directories found matching 'dist' 06:21:42 INFO - no previously-included directories found matching '.git*' 06:21:42 INFO - Successfully installed jsonschema functools32 06:21:42 INFO - Cleaning up... 06:21:42 INFO - Return code: 0 06:21:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:21: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')]} 06:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21: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')]} 06:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24bbe4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b67d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, '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': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21: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', 'flake8'] in /builds/slave/test/build 06:21: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 flake8 06:21:42 INFO - Using env: {'DISPLAY': ':0', 06:21:42 INFO - 'HOME': '/home/cltbld', 06:21:42 INFO - 'LANG': 'en_US.UTF-8', 06:21:42 INFO - 'LANGUAGE': 'en_US:en', 06:21:42 INFO - 'LOGNAME': 'cltbld', 06:21:42 INFO - 'MAIL': '/var/mail/cltbld', 06:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:42 INFO - 'MOZ_NO_REMOTE': '1', 06:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:42 INFO - 'NO_EM_RESTART': '1', 06:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:42 INFO - 'PWD': '/builds/slave/test', 06:21:42 INFO - 'SHELL': '/bin/bash', 06:21:42 INFO - 'SHLVL': '1', 06:21:42 INFO - 'TERM': 'linux', 06:21:42 INFO - 'TMOUT': '86400', 06:21:42 INFO - 'USER': 'cltbld', 06:21:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:42 INFO - '_': '/tools/buildbot/bin/python'} 06:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:42 INFO - Downloading/unpacking flake8 06:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:21:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:21:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:21:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:45 INFO - no previously-included directories found matching 'docs/_build' 06:21:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:21:45 INFO - Running setup.py install for pep8 06:21:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:45 INFO - no previously-included directories found matching 'docs/_build' 06:21:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:21:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:21:45 INFO - Cleaning up... 06:21:45 INFO - Return code: 0 06:21:45 INFO - Running post-action listener: _resource_record_post_action 06:21:45 INFO - Running post-action listener: _start_resource_monitoring 06:21:45 INFO - Starting resource monitoring. 06:21:45 INFO - ##### 06:21:45 INFO - ##### Running install step. 06:21:45 INFO - ##### 06:21:45 INFO - Running pre-action listener: _resource_record_pre_action 06:21:45 INFO - Running main action method: install 06:21:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:46 INFO - Reading from file tmpfile_stdout 06:21:46 INFO - Detecting whether we're running mozinstall >=1.0... 06:21:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:21:46 INFO - Reading from file tmpfile_stdout 06:21:46 INFO - Output received: 06:21:46 INFO - Usage: mozinstall [options] installer 06:21:46 INFO - Options: 06:21:46 INFO - -h, --help show this help message and exit 06:21:46 INFO - -d DEST, --destination=DEST 06:21:46 INFO - Directory to install application into. [default: 06:21:46 INFO - "/builds/slave/test"] 06:21:46 INFO - --app=APP Application being installed. [default: firefox] 06:21:46 INFO - mkdir: /builds/slave/test/build/application 06:21:46 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'] 06:21:46 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 06:22:01 INFO - Reading from file tmpfile_stdout 06:22:01 INFO - Output received: 06:22:01 INFO - /builds/slave/test/build/application/firefox/firefox 06:22:01 INFO - Running post-action listener: _resource_record_post_action 06:22:01 INFO - ##### 06:22:01 INFO - ##### Running run-tests step. 06:22:01 INFO - ##### 06:22:01 INFO - Running pre-action listener: _resource_record_pre_action 06:22:01 INFO - Running main action method: run_tests 06:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:22:01 INFO - Python 2.7.3 06:22:01 INFO - Return code: 0 06:22:01 INFO - grabbing minidump binary from tooltool 06:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:01 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 0x1245640>, '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 0x1246540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12469d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:22:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:22:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:22:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:22:01 INFO - Return code: 0 06:22:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:22:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:22:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:22:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:22:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:22:02 INFO - Return code: 0 06:22:02 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/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:22:02 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/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:22:02 INFO - Using env: {'DISPLAY': ':0', 06:22:02 INFO - 'HOME': '/home/cltbld', 06:22:02 INFO - 'LANG': 'en_US.UTF-8', 06:22:02 INFO - 'LANGUAGE': 'en_US:en', 06:22:02 INFO - 'LOGNAME': 'cltbld', 06:22:02 INFO - 'MAIL': '/var/mail/cltbld', 06:22:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:22:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:02 INFO - 'MOZ_NO_REMOTE': '1', 06:22:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:02 INFO - 'NO_EM_RESTART': '1', 06:22:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:02 INFO - 'PWD': '/builds/slave/test', 06:22:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:22:02 INFO - 'SHELL': '/bin/bash', 06:22:02 INFO - 'SHLVL': '1', 06:22:02 INFO - 'TERM': 'linux', 06:22:02 INFO - 'TMOUT': '86400', 06:22:02 INFO - 'USER': 'cltbld', 06:22:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434', 06:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:02 INFO - '_': '/tools/buildbot/bin/python'} 06:22:02 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/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:22:02 INFO - mozversion application_buildid: 20160509005049 06:22:02 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:22:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:22:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:22:02 INFO - mozversion application_name: Firefox 06:22:02 INFO - mozversion application_remotingname: firefox-dev 06:22:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:22:02 INFO - mozversion application_vendor: Mozilla 06:22:02 INFO - mozversion application_version: 48.0a2 06:22:02 INFO - mozversion platform_buildid: 20160509005049 06:22:02 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:22:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:22:02 INFO - mozversion platform_version: 48.0a2 06:22:02 INFO - using testdate: 1462800122 06:22:02 INFO - actual date: 1462800122 06:22:02 INFO - starting webserver on 'localhost:38734' 06:22:02 INFO - SUITE-START | Running 2 tests 06:22:02 INFO - TEST-START | dromaeo_css 06:22:02 INFO - operating with platform_type : linux_ 06:22:02 INFO - Initialising browser for dromaeo_css test... 06:22:02 INFO - TEST-INFO | started process 765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunQJS5/profile http://localhost:38734/getInfo.html) 06:22:07 INFO - PROCESS | 765 | __metrics Screen width/height:1600/1200 06:22:07 INFO - PROCESS | 765 | colorDepth:24 06:22:07 INFO - PROCESS | 765 | Browser inner width/height: 1024/697 06:22:07 INFO - PROCESS | 765 | __metrics 06:22:07 ERROR - PROCESS | 765 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:22:08 INFO - TEST-INFO | 765: exit 0 06:22:08 INFO - Browser initialized. 06:22:08 INFO - Running cycle 1/1 for dromaeo_css test... 06:22:08 INFO - TEST-INFO | started process 866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunQJS5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:20 INFO - PROCESS | 866 | RSS: Main: 142663680 06:22:20 INFO - PROCESS | 866 | 06:23:11 INFO - PROCESS | 866 | 1462800191813 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:25:19 INFO - PROCESS | 866 | Cycle 1(1): loaded http://localhost:38734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38734/tests/dromaeo/cssquery-ext.html) 06:25:20 INFO - PROCESS | 866 | RSS: Main: 252051456 06:25:20 INFO - PROCESS | 866 | 06:28:22 INFO - PROCESS | 866 | Cycle 1(1): loaded http://localhost:38734/tests/dromaeo/cssquery-ext.html (next: http://localhost:38734/tests/dromaeo/cssquery-jquery.html) 06:28:23 INFO - PROCESS | 866 | RSS: Main: 217812992 06:28:23 INFO - PROCESS | 866 | 06:31:25 INFO - PROCESS | 866 | Cycle 1(1): loaded http://localhost:38734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38734/tests/dromaeo/cssquery-mootools.html) 06:31:25 INFO - PROCESS | 866 | RSS: Main: 227823616 06:31:25 INFO - PROCESS | 866 | 06:34:27 INFO - PROCESS | 866 | Cycle 1(1): loaded http://localhost:38734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38734/tests/dromaeo/cssquery-prototype.html) 06:34:28 INFO - PROCESS | 866 | RSS: Main: 221237248 06:34:28 INFO - PROCESS | 866 | 06:37:30 INFO - PROCESS | 866 | Cycle 1(1): loaded http://localhost:38734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38734/tests/dromaeo/cssquery-yui.html) 06:37:31 INFO - PROCESS | 866 | RSS: Main: 210919424 06:37:31 INFO - PROCESS | 866 | 06:40:33 INFO - PROCESS | 866 | Cycle 1(1): loaded http://localhost:38734/tests/dromaeo/cssquery-yui.html (next: http://localhost:38734/tests/dromaeo/cssquery-dojo.html) 06:40:33 INFO - PROCESS | 866 | RSS: Main: 264994816 06:40:33 INFO - PROCESS | 866 | 06:40:33 INFO - PROCESS | 866 | __start_tp_report 06:40:33 INFO - PROCESS | 866 | _x_x_mozilla_page_load 06:40:33 INFO - PROCESS | 866 | _x_x_mozilla_page_load_details 06:40:33 INFO - PROCESS | 866 | |i|pagename|runs| 06:40:34 INFO - PROCESS | 866 | |0;dojo.html;3343.8829640962563;3389.2882494676132;3402.506636537702;3419.914502137448;3438.1404648837793;5529.115341545354;5568.7215639217975;5587.078132108208;5599.748011339484;5601.971990140049;5603.187537807015;5622.100463925773;5623.915641265385;5630.40880707525;5638;5015.0972824891505;5115.258287548303;5128.820491282806;5175.068487672217;5225.163973764198;5044.646874718771;5096.949030509684;5101.209312556541;5102.617303702219;5107.514786095315;5055.418626857903;5164.1995490699;5248.0553500369915;5285.814996475124;5287.762050707708;5231.110711179109;5240.947590524084;5242.711650859202;5247.816326428557;5277.973610131963;4970.975145124287;4974.602031837444;5085.466026067246;5116.846494605131;5143.254228136937;5524.861878453031;5550.389457159709;5586.6368686035685;5588.469095435927;5595.1886976388605;5975.163477113164;6012.458878700938;6012.5791194616395;6014.78948236814;6015.488683461911;6020.8193754187005;6064.96967515164;6102.511799056065;6112.564273424362;6129.417705317987;5498;5547.084731019377;5549.084401073858;5553.916691249635;5588.6646801192055;6054.636721796706;6056.727447264883;6057.606255593372;6058.878822423527;6061.605995610271;5853.912191317134;5924.7333869975955;5931.051031834972;5936.7328470218945;5944.613600115978;5979.701014949235;5986;5987.550933679991;5995.970020149872;5996.9805133127475;5849.795257165979;5962.403759624003;5968.612040217372;5968.641881487125;6010.519158467399;5966.045432730829;5978.850528736816;5982.4316689914385;5989.670568118708;6021.157038014681;4555.544445555418;4556.157110934488;4565.20108980927;4566.680332376702;4585.12882552314;4030.919381612351;4048.4534587830854;4095.365218391154;4104.835806567704;4129.194807012604;5735.254416925773;5786.537077033827;5787.88424231513;5800.941990580124;5821.15593238978;6103.664298463538;6104.664243466652;6111.0527868179615;6118.082287656887;6124.601900876518;5587.972060139673;5690.857728556736;5722.799702010493;5815.912761308584;5816.185733997244;5184.11869982104;5204.583633309327;5208.348956380452;5209.843704688866;5215.869603259949;6266.811995640138;6298.118263443122;6299.401556852092;6301.873962520724;6306.211723534559;5889.469947704727;6048.5161187105805;6116.396640261158;6126.029144987285;6137.897974673567;6225.159603453476;6240.032794916795;6280.434760871361;6285.277193122666;6288.182536270256;5760.769569217185;5973.522118230444;5987.880720778268;5999.100134979788;6005.669688167192;6053.576249662481;6119.563485741553;6124.014786914997;6127.724252408563;6139.508839292936;5906.70466476683;5915.112733090071;5929.940700593112;5944.6730429826775;5948.851278718067;5773.480386765212;5798.420157984167;5858.326292476249;5900.232969713909;5903.313992133655;5735.254416925773;5757.481826635623;5794.333651630117;5794.565407594363;5830.387809279964;5849.707514624167;5914.881702366015;5920.851978700394;5922.170896074639;5924.496417804363;5681.715914204191;5802.187693722798;5850.590458668023;5886.911696324644;5968.403159683997 06:40:34 INFO - PROCESS | 866 | |1;ext.html;666.2338310942415;670.765232168741;682.1166589266899;686.2519853359837;754.8490301939613;32518.67481325189;38533.80733096334;39328.803355983255;39520.99999999996;39554.40668389977;43546.346804797955;44283;44311;44313.11373772522;44351.77824110875;8102.594870256464;9020.458772473672;9237.076292370743;9243.676471323504;10372.273940824145;10399.48002599867;10594.735131621694;10608.09831164352;10633.255672102956;10633.521491532862;10640.62757803477;10727.678169654922;10735.302205356666;10741.409222492759;10743.086837618812;8240.093589705128;10394.532246048946;10546.103581195608;10626.78746425071;10738.281874900056;10761.62334318303;10981.835272470918;11007.449627518672;11016.06363459107;11020.559177632886;44220.336694949605;44487;44782.32826507605;44887;44981.32528012082;3908.3746600543777;4053.5135783706146;4132.834686612532;4165.062860856314;4228.069824638575;32705.6729432705;32913.177170570685;33037.3392532148;33169;33232.16919577006;4516.954830451687;4602.493725690171;4630.768461576908;4638.052276099574;4858.635602329804;347122;348980;349099;349779;350233.99999999744;69176.57881974107;69896;69924.30075699178;69938.65030674814;69974.65012674904;72643;75215;75261;75323.62338188384;75361;19338.90330548338;19751.604967900563;19812.306569270295;19822.504437388892;19823.207071717257;13175.538856140181;14532.63668408277;14899.106053636817;14925.40298388074;14936.178510182044;21599.892000539898;21644;21694.240701575683;21762.238321658668;21832.345029649136;8016.7194148204535;8209.220124088202;8284.763113959318;8386.993560772624;8551.828963420698;1051.7318083888713;1178.1988247991276;1198.9940050299692;1273.35695473787;1284.955026574084;33366.3326733464;33467.16332091717;33641;34016.65983340135;34404;1227.6010296653624;1244.116677159227;1245.3773113443278;1293.2176033499597;1336.2917653643585;17589.384371546934;17828.643427131385;18136.63726725458;18137.36519221821;18147.637047259246;510206;510808;514012;515166;515383;63642.36357636364;64163.679181603795;64278.67860660667;64318.35681643217;64391.356086439475;1314.309987256698;1420.4176287722191;1514.053716427233;1521.4903007492392;1634.5913521619595;33458.33083338368;33830.830845845616;34013.48979765355;34198;34286;51316.486835131174;60867;61909.69045154745;62080.37919620746;62109.378906212165;448110;448281;451275;451313;451598;41715.7914210427;47740.52259477361;49244.75377623089;49303.50696492989;49754.751226243636;46811.063778723554;47503.762481187376;47547.28679069886;48297.517024830704;48424.515754842;38524;39528.40707389449;39619;39711.80144099261;40196.19607607773;41439.37840932328;42800.1439971205;42874.57125428706;43920.34119488146;44228.33657495076;43336.566634333256;43506.78246608747;44239;44810.77594612006;44922.77538612286;35466.64533354634;37202.25595488129;37821.810890945366;38172;38974.80512597419;29040.854795725885;29489.45023474416;29774.702252977193;29918;30029.54955675623 06:40:34 INFO - PROCESS | 866 | |2;jquery.html;424.0712838882848;424.42490425473494;426.70557315452334;431.5210116770385;433.7180832458901;14159.575212743608;18592.628147437044;19111.044447777607;19149.234030638774;19981;16148.192590370492;19082.713759293623;19341.613167736672;19626.313079042236;19725;5590.972045139779;5788.5369170466265;5789.131630255453;5791.884162316751;5813.273340832396;5717.714114294289;5727.140928860663;5742.712864356787;5749.166370876221;5749.568782341341;4258.510271318792;4501.774911254441;6163.599366041215;6428.646424446653;6437.0988061671405;6299.559030867841;6311.810645680614;6332.461740752042;6387.840303992391;6398.840028999266;5604.551635869161;5676.545876329884;5702.77188912443;5709.3434255060365;5717.656940583578;23047.423814404774;23336.949837257365;23652.526949461087;23947.76052239473;23949.042038318446;2491.9626205606933;2591.8315309504824;2701.243651777486;2782.4852402305637;3052.694730526952;14507;14981.625459363495;15207.61980950474;15326.310316035806;15716.921415392964;2006.7792542820278;2085.728855248823;2086.8017538333834;2091.623507768601;2092.9953622261246;78894.60552697258;78959.60520197419;80067.5996620019;80099.5995020027;82114;10777.730556735987;11233.66299011031;11291.43542822872;11344.829827552594;11360.943195284137;15886.682266354608;15926.920365398099;15987.36050557988;16017.279222435018;16034;8514.57427128641;8559.486430814171;8767.736967890973;8827.293816494664;8905.198532132139;8938.284937205008;8982.416142950819;8984.281257499384;9025.23285520725;9025.909740902638;4442.800073996678;4683.765811709401;4969.478204788517;4987.975060124676;5018.670052436108;1929.5176205948512;1973.1614064022733;2029.1781828359537;2071.06801939128;2075.9273425430038;979.5445118020154;1035.9533820978074;1072.4798472740715;1093.240198062355;1128.7234627516311;19006.33477828297;19319.4204173875;19337.903310483358;19686.30184733368;19794;1048.192891473561;1083.1443159903745;1088.2273585754044;1102.063246240689;1154.549725607014;10861.1854110942;11146.777064458665;11202.38386888729;11307.208495405243;11345.886541134483;522560;535685;538558;550914;555473;95334;100009;100119.49940250398;100542;100641;1083.06315037492;1093.824988001916;1144.490701637763;1146.6846617180342;1150.79285728568;17129.74305385445;17172.313107475562;17217.82782172162;17405;17497.47507574775;39941;40810.387844181765;41652.79173604112;41703.16593668049;42091;59490.70254648699;59842.40157598542;60202.096968546386;60251.096233555654;60305.09542356956;8491.74524764258;8743.344249181464;8868.290536757173;8911.777205569913;8938.553067351291;9276;9959.502024898582;13262;13854.238016909167;14207.928960355546;11392;11942.4028798558;12093.75812483763;12528.686782830502;12537.435815388148;11764.176507644383;12035.45840437165;12073.75852482963;12142.635720928387;12183.939080304543;11743.295402275891;11907.106966977339;11995.820062698893;12072.818907716215;12137.817932730839;9025.548722563977;9028.593713282786;9043;9270.860937085814;9358.53207339644;11400.771984560097;11574.884251157717;11661.24201926872;11843.348615826213;11876.228045177382 06:40:34 INFO - PROCESS | 866 | |3;mootools.html;1483.910965342079;1595.3219881550342;1596.888217824752;1835.6328734253145;1916.578352762392;8263.752087437379;8461.280791132753;8463;8463.66145354185;8479.618417171227;8272.586370681473;8466.238038576526;8467.95766021169;8472.025717042541;8477.491350518972;2148.2051640892814;2404.8677322747244;2467.124170919316;2496.2386472125995;2520.760527749861;2473.1714875516723;2474.542209691213;2479.851208927461;2493.588557887955;2505.08564374004;2468.7654672806057;2502.049221295905;2504.474060447308;2505.2108585795418;2506.147909710698;2155.8275337973005;2420.225527831095;2470.234227389497;2470.234227389515;2478.8512689238705;2356.7761062699014;2402.543516731833;2402.6396040593877;2403.723571789249;2409.2410890569413;8165.714200003031;8221.465604735673;8236.258736713664;8241.79395515111;8246.299064579518;5191.728026633461;5330;5335.893282134374;5339.145736682151;5385.407605163429;3531.434970404723;3626.6192049834917;3627.093226693327;3638.254157897651;3692.6861216796606;1235.172434468908;1239.39269757818;1275.0309764578988;1293.1594463598642;2193.2214064007367;11322.660320190407;11519.827202591969;11524.250923689933;11525.020373268198;11533.711657208552;4539.296409056601;4548.067646132535;4564.018735971782;4632.305154226893;4651.930221046687;9401.388909720847;9402.15380615748;9403.43579385239;9416.387934784218;9421.905780942103;4695.859124226278;5330.200469929541;5333.253344531769;5344.839654810284;5348.411674715778;4391.626711729538;4791.736454494967;4872.220444728827;4910.950890491049;4913.803447862046;3896.3181443247886;3912.471816304819;3982.522097348337;4008.9198216035516;4016.7389119707127;1191.6305945157028;1193.5822462138183;1207.1851500237306;1221.9633410997685;1228.152574723438;1060.6181774561153;1063.3832377221347;1077.2082519348273;1094.234036174665;1097.544519024596;5702.857428564319;5879.823605291848;5936.317323507852;6074.969625151846;6144.723487443076;477.9139754844092;483.3619622098796;490.0419679526588;490.16916326825685;495.10633306881425;4033.6571391432058;4057.5333836609166;4072.8778136655947;4216.536181020086;4274.465691788527;9908.900910990798;10096.091351778376;10142.645007424851;10167.491625418847;10168.803524578108;10048.497575121215;10113.190944724405;10187.185025197967;10192.847107293397;10205.234607404474;7735.187805280477;7855.489393189425;7927.841443171104;7944.205579442009;7981.401394895406;5602.635828671123;5607.102863541813;5638.6898720569125;5786.363500014911;5829.271341082364;9097.09029097085;9100.180983711498;9209.033051529494;9277.768055798659;9370.67202647904;9277.2578193743;9295.30285228597;9298;9374.859377109213;9564.234861211226;6447.580907241015;6924.030635710904;7012.824679383056;7229.277072292729;7301.488895777245;7749.573773442515;7845.882311765442;7849.882251766114;7862.72480463181;7866.646000929857;6984.580925144508;7193.100862392201;7239.927600724136;7241.058662373857;7390.445716571171;7130.465215108991;7153.6423178839805;7191.892121618284;7256.7460138894885;7286.307800758919;6452.387023232785;6522.412982831568;6527.445167160845;6534.738610455529;6541.509386796104;4825.758712064453;4861.732604706775;4871.171900776805;4904.8773780655765;4908.263760435821;4978.6763860348965;4985.202367621163;4987.526185012418;5069.518395752398;5069.695818250917 06:40:34 INFO - PROCESS | 866 | |4;prototype.html;362.94374371972344;364.1043034136026;364.52247555702013;365.1218818740929;368.2653107051433;6288.371162883715;6336.4930805535505;6337.556371054016;6343.714532846021;6351.2060992375955;6223.502119830403;6255.591597235063;6256.2805277393;6259.593126446778;6272.84317892053;4610.815567377309;4701.2478003519445;4749.335093086954;4757.167495688241;4837.830675926343;4828.73441960692;4855;4858.5627293543575;4872.731999740013;4877.658563900528;4791.880202994936;4800.975995120019;4810.567048965592;4812.446568644598;4821.758912054401;4543.341215523747;4667.6265898728025;4756.881077973044;4792.688475249098;4804.303376010459;4226.830926762957;4234.216669916075;4240.1307731914885;4244.129953359585;4248.532661407243;6021.458068773832;6023.698815059273;6031.698415079229;6031.909521357183;6035.064564992434;5573.550876772028;5574.275344205227;5575.944240557583;5577.107662773978;5590.468905453975;6588.868222635569;6594.7032383542855;6595.505337099688;6601.174853143357;6603.372679595479;4453.599176074136;4555.9772201138785;4561.863144105682;4563.201439748064;4620.330052142454;6839.418649414805;6924.549904256207;6937.791866243971;6939.757108501229;6951.7914462566205;4712.5994290485005;4722.88192795176;4731.33761273422;4732.337472753818;4735.100330937111;4794.400699912511;4795.112904112751;4797.088553174885;4797.760111994457;4804.42346918372;5520.06158952979;5530.364008139035;5531.778728850801;5540.9168862467095;5541.473560011793;6394.456471199907;6544.149260596092;6563.245226798884;6572.8356791080605;6663.06717059612;1640.8277130901322;1652.6942515634646;1659.576807913974;1661;1663.1850393307434;1025.6564051042835;1058.3596923861107;1088.4013792414141;1094.2449709700281;1108.955641774336;6354.3963323484195;6437.871242575122;6472.255690595548;6568.737250510022;6572.211334639874;6950.895736563955;6970.302969703091;6973.79078627642;7005.894911576331;7054.682539285642;6514.283428822826;6547.410733033955;6558.573692709959;6563.081168636395;6565.934340656532;3667.9083022924106;3739.8317075731657;3746.756460830037;3752.7935963521722;3754.81225938702;7051.8237044073285;7107.857842843217;7210.891836622455;7216.675249613675;7217.206107328189;7042.964785176041;7049.4712896532965;7052.894206586905;7063.25835787235;7064.32888875556;7188.4904170124855;7196.568205907663;7198.820029499095;7199.9280007200305;7205.351518363373;6909.067275917687;6910.585364878123;6911.5853048817235;6917.723291068301;6922.446204303543;6621.238557565942;6834.658267086526;6836.077129587641;6844.384005439534;6851.794446166623;7145.964270178616;7165.570065796069;7185.461090418344;7188.137423509213;7188.640567971685;4746.884482146762;4750;4751.881202969954;4756.6908150970075;4763.666543341933;6854.965725171542;6857.314268573103;6871.278515755774;6888.690008949509;6893.0694356261265;6476.417122459001;6726;6732.629705366252;6772.525923185527;6777.593344399352;6655.068290439439;6686.1642294713165;6700.631465269457;6719.5296329258435;6753.932460675331;6597.901031484627;6606.3393660635475;6615.140031796028;6616.735330586723;6620.205575330991;6762.966185169043;6764.086848275617;6774.86450270982;6774.966125169342;6787.592744435349;6302.684865756602;6406.615603063831;6424.9036264455135;6489.675516224264;6583.341665833378 06:40:34 INFO - PROCESS | 866 | |5;yui.html;837.8449986752447;851.6125163050812;919.7194855569053;931.9953400232998;956.9712908612744;14677.853221467782;14988.325525351358;14988.475403360871;15002.324895379707;17306.221220045096;14954.925225373858;14991.100533967969;15026.098434093961;15046.774298385533;15079.321430535652;774.4346626962292;897.5736525150551;912.8356895758794;922.6125027488471;940.0928104379273;913.7624217703411;930.3208657679897;932.2215949682023;932.3566738950136;933.7945651956559;959.5298303831142;978.6476868327396;979.7256768104942;980.0542476510167;981.0777868803337;796.0328201235498;954.179405711088;958.7171784323641;979.1432496565506;980.0983095552109;706.5054461876707;712.4620911212054;716.8637958787866;717.0892965933288;717.1645033535924;14190.290485475789;14197.503087391995;14262.572122836227;14272.072315299576;14303.070300430543;14182.92908535461;14440.71118577633;14476.710465790731;14483.058601190889;14532.636684082876;12326.938365308117;12404.56584019555;12405.689857753538;12421.44103515344;12516.061295402882;4030.3349947258666;4108.630223279919;4116.0533077392065;4164.6251837334485;4183.414321994923;60936;60964.695176523834;61011.38988610102;61039.38960610382;61705.382946170415;11013.779724405627;11300.265482743594;11316.038440472106;11492.310461372344;11519.078473722082;20748.58502829935;20761.89619051895;20766.273180438613;20779.272725454837;20812.89593552053;8689.391742577958;8703.086175951561;8805.42764720291;8816;8982.550872456351;4898.926516102261;4991.276264941635;4998.850034498971;5002.924956125661;5049.596032317406;3574.4280915053987;3650.561932568056;3651.1054791576234;3651.8904432867057;3658.2683463307444;615.7106160104744;635.9841003974846;638.9872202556015;655.3250152343094;659.2319947261483;739.2053542441896;776.9611519424006;792.2552800367636;853.2363534636465;853.2789792625222;9643.662471813594;9662.033796620282;9740;9797.167240784613;9825.231458337425;814.9062857771432;823.3372135430916;831.52441174863;859.9355048371397;865.10461672169;4698.600618947427;4901.264810278487;4902.632302577321;4987.750612469362;4993.076280888047;65040;67315.32684673188;67366;67439;67441;55582.72208638931;56726.43273567294;58564.414355856745;58911.41088589059;59395;51527.484725153015;51752.223716645036;51853.7407312961;52701;52834.207486887724;9787.265955053257;9834.164096051916;9884.901150988686;9888.456134912649;9994.350367226107;39052;39271.60728392794;39928.60071399249;40545.391819122146;40710;47108.29337559871;47507;51306.23040654468;51715.482845171064;52179;11910.106741994212;11912.225705329125;12269;13977.44090236379;14074.718505629626;14348;14547.709045819236;14679.70640587161;14766.040207386486;15548.61128471752;13888.375023124187;14334.569962901129;15186.924065380044;15290.388384464497;15316;13595.86404135946;14173.078749881224;14373.712525749635;14444.350004249623;15069.54791356261;13785.655358616115;13808.240546770025;13817.447302107803;13826.516071937434;14422.0625659336;11258.83791927271;11295.943520282346;11448.484818183368;11566.710832228924;11611.419429028347;11153.498092586015;11373.260738052;11592.95663390299;11619.651410457362;11631.709207269885 06:40:34 INFO - PROCESS | 866 | __end_tp_report 06:40:34 INFO - PROCESS | 866 | __start_cc_report 06:40:34 INFO - PROCESS | 866 | _x_x_mozilla_cycle_collect,844 06:40:34 INFO - PROCESS | 866 | __end_cc_report 06:40:34 INFO - PROCESS | 866 | __startTimestamp1462801233997__endTimestamp 06:40:34 INFO - PROCESS | 866 | 06:40:34 INFO - PROCESS | 866 | ------- Summary: start ------- 06:40:34 INFO - PROCESS | 866 | Number of tests: 6 06:40:34 INFO - PROCESS | 866 | 06:40:34 INFO - PROCESS | 866 | [#0] dojo.html Cycles:165 Average:5603.35 Median:5816.19 stddev:625.33 (10.8%) stddev-sans-first:601.60 06:40:34 INFO - PROCESS | 866 | Values: 3343.9 3389.3 3402.5 3419.9 3438.1 5529.1 5568.7 5587.1 5599.7 5602.0 5603.2 5622.1 5623.9 5630.4 5638.0 5015.1 5115.3 5128.8 5175.1 5225.2 5044.6 5096.9 5101.2 5102.6 5107.5 5055.4 5164.2 5248.1 5285.8 5287.8 5231.1 5240.9 5242.7 5247.8 5278.0 4971.0 4974.6 5085.5 5116.8 5143.3 5524.9 5550.4 5586.6 5588.5 5595.2 5975.2 6012.5 6012.6 6014.8 6015.5 6020.8 6065.0 6102.5 6112.6 6129.4 5498.0 5547.1 5549.1 5553.9 5588.7 6054.6 6056.7 6057.6 6058.9 6061.6 5853.9 5924.7 5931.1 5936.7 5944.6 5979.7 5986.0 5987.6 5996.0 5997.0 5849.8 5962.4 5968.6 5968.6 6010.5 5966.0 5978.9 5982.4 5989.7 6021.2 4555.5 4556.2 4565.2 4566.7 4585.1 4030.9 4048.5 4095.4 4104.8 4129.2 5735.3 5786.5 5787.9 5800.9 5821.2 6103.7 6104.7 6111.1 6118.1 6124.6 5588.0 5690.9 5722.8 5815.9 5816.2 5184.1 5204.6 5208.3 5209.8 5215.9 6266.8 6298.1 6299.4 6301.9 6306.2 5889.5 6048.5 6116.4 6126.0 6137.9 6225.2 6240.0 6280.4 6285.3 6288.2 5760.8 5973.5 5987.9 5999.1 6005.7 6053.6 6119.6 6124.0 6127.7 6139.5 5906.7 5915.1 5929.9 5944.7 5948.9 5773.5 5798.4 5858.3 5900.2 5903.3 5735.3 5757.5 5794.3 5794.6 5830.4 5849.7 5914.9 5920.9 5922.2 5924.5 5681.7 5802.2 5850.6 5886.9 5968.4 06:40:34 INFO - PROCESS | 866 | 06:40:34 INFO - PROCESS | 866 | [#1] ext.html Cycles:180 Average:62344.15 Median:39524.70 stddev:116869.80 (295.7%) stddev-sans-first:117105.90 06:40:34 INFO - PROCESS | 866 | Values: 666.2 670.8 682.1 686.3 754.8 32518.7 38533.8 39328.8 39521.0 39554.4 43546.3 44283.0 44311.0 44313.1 44351.8 8102.6 9020.5 9237.1 9243.7 10372.3 10399.5 10594.7 10608.1 10633.3 10633.5 10640.6 10727.7 10735.3 10741.4 10743.1 8240.1 10394.5 10546.1 10626.8 10738.3 10761.6 10981.8 11007.4 11016.1 11020.6 44220.3 44487.0 44782.3 44887.0 44981.3 3908.4 4053.5 4132.8 4165.1 4228.1 32705.7 32913.2 33037.3 33169.0 33232.2 4517.0 4602.5 4630.8 4638.1 4858.6 347122.0 348980.0 349099.0 349779.0 350234.0 69176.6 69896.0 69924.3 69938.7 69974.7 72643.0 75215.0 75261.0 75323.6 75361.0 19338.9 19751.6 19812.3 19822.5 19823.2 13175.5 14532.6 14899.1 14925.4 14936.2 21599.9 21644.0 21694.2 21762.2 21832.3 8016.7 8209.2 8284.8 8387.0 8551.8 1051.7 1178.2 1199.0 1273.4 1285.0 33366.3 33467.2 33641.0 34016.7 34404.0 1227.6 1244.1 1245.4 1293.2 1336.3 17589.4 17828.6 18136.6 18137.4 18147.6 510206.0 510808.0 514012.0 515166.0 515383.0 63642.4 64163.7 64278.7 64318.4 64391.4 1314.3 1420.4 1514.1 1521.5 1634.6 33458.3 33830.8 34013.5 34198.0 34286.0 51316.5 60867.0 61909.7 62080.4 62109.4 448110.0 448281.0 451275.0 451313.0 451598.0 41715.8 47740.5 49244.8 49303.5 49754.8 46811.1 47503.8 47547.3 48297.5 48424.5 38524.0 39528.4 39619.0 39711.8 40196.2 41439.4 42800.1 42874.6 43920.3 44228.3 43336.6 43506.8 44239.0 44810.8 44922.8 35466.6 37202.3 37821.8 38172.0 38974.8 29040.9 29489.5 29774.7 29918.0 30029.5 06:40:34 INFO - PROCESS | 866 | 06:40:34 INFO - PROCESS | 866 | [#2] jquery.html Cycles:180 Average:30888.45 Median:12570.21 stddev:88999.56 (708.0%) stddev-sans-first:89219.84 06:40:34 INFO - PROCESS | 866 | Values: 424.1 424.4 426.7 431.5 433.7 14159.6 18592.6 19111.0 19149.2 19981.0 16148.2 19082.7 19341.6 19626.3 19725.0 5591.0 5788.5 5789.1 5791.9 5813.3 5717.7 5727.1 5742.7 5749.2 5749.6 4258.5 4501.8 6163.6 6428.6 6437.1 6299.6 6311.8 6332.5 6387.8 6398.8 5604.6 5676.5 5702.8 5709.3 5717.7 23047.4 23336.9 23652.5 23947.8 23949.0 2492.0 2591.8 2701.2 2782.5 3052.7 14507.0 14981.6 15207.6 15326.3 15716.9 2006.8 2085.7 2086.8 2091.6 2093.0 78894.6 78959.6 80067.6 80099.6 82114.0 10777.7 11233.7 11291.4 11344.8 11360.9 15886.7 15926.9 15987.4 16017.3 16034.0 8514.6 8559.5 8767.7 8827.3 8905.2 8938.3 8982.4 8984.3 9025.2 9025.9 4442.8 4683.8 4969.5 4988.0 5018.7 1929.5 1973.2 2029.2 2071.1 2075.9 979.5 1036.0 1072.5 1093.2 1128.7 19006.3 19319.4 19337.9 19686.3 19794.0 1048.2 1083.1 1088.2 1102.1 1154.5 10861.2 11146.8 11202.4 11307.2 11345.9 522560.0 535685.0 538558.0 550914.0 555473.0 95334.0 100009.0 100119.5 100542.0 100641.0 1083.1 1093.8 1144.5 1146.7 1150.8 17129.7 17172.3 17217.8 17405.0 17497.5 39941.0 40810.4 41652.8 41703.2 42091.0 59490.7 59842.4 60202.1 60251.1 60305.1 8491.7 8743.3 8868.3 8911.8 8938.6 9276.0 9959.5 13262.0 13854.2 14207.9 11392.0 11942.4 12093.8 12528.7 12537.4 11764.2 12035.5 12073.8 12142.6 12183.9 11743.3 11907.1 11995.8 12072.8 12137.8 9025.5 9028.6 9043.0 9270.9 9358.5 11400.8 11574.9 11661.2 11843.3 11876.2 06:40:34 INFO - PROCESS | 866 | 06:40:34 INFO - PROCESS | 866 | [#3] mootools.html Cycles:180 Average:5546.15 Median:4906.57 stddev:2984.44 (60.8%) stddev-sans-first:2977.20 06:40:34 INFO - PROCESS | 866 | Values: 1483.9 1595.3 1596.9 1835.6 1916.6 8263.8 8461.3 8463.0 8463.7 8479.6 8272.6 8466.2 8468.0 8472.0 8477.5 2148.2 2404.9 2467.1 2496.2 2520.8 2473.2 2474.5 2479.9 2493.6 2505.1 2468.8 2502.0 2504.5 2505.2 2506.1 2155.8 2420.2 2470.2 2470.2 2478.9 2356.8 2402.5 2402.6 2403.7 2409.2 8165.7 8221.5 8236.3 8241.8 8246.3 5191.7 5330.0 5335.9 5339.1 5385.4 3531.4 3626.6 3627.1 3638.3 3692.7 1235.2 1239.4 1275.0 1293.2 2193.2 11322.7 11519.8 11524.3 11525.0 11533.7 4539.3 4548.1 4564.0 4632.3 4651.9 9401.4 9402.2 9403.4 9416.4 9421.9 4695.9 5330.2 5333.3 5344.8 5348.4 4391.6 4791.7 4872.2 4911.0 4913.8 3896.3 3912.5 3982.5 4008.9 4016.7 1191.6 1193.6 1207.2 1222.0 1228.2 1060.6 1063.4 1077.2 1094.2 1097.5 5702.9 5879.8 5936.3 6075.0 6144.7 477.9 483.4 490.0 490.2 495.1 4033.7 4057.5 4072.9 4216.5 4274.5 9908.9 10096.1 10142.6 10167.5 10168.8 10048.5 10113.2 10187.2 10192.8 10205.2 7735.2 7855.5 7927.8 7944.2 7981.4 5602.6 5607.1 5638.7 5786.4 5829.3 9097.1 9100.2 9209.0 9277.8 9370.7 9277.3 9295.3 9298.0 9374.9 9564.2 6447.6 6924.0 7012.8 7229.3 7301.5 7749.6 7845.9 7849.9 7862.7 7866.6 6984.6 7193.1 7239.9 7241.1 7390.4 7130.5 7153.6 7191.9 7256.7 7286.3 6452.4 6522.4 6527.4 6534.7 6541.5 4825.8 4861.7 4871.2 4904.9 4908.3 4978.7 4985.2 4987.5 5069.5 5069.7 06:40:34 INFO - PROCESS | 866 | 06:40:34 INFO - PROCESS | 866 | [#4] prototype.html Cycles:180 Average:5589.31 Median:6352.80 stddev:1696.87 (26.7%) stddev-sans-first:1655.67 06:40:34 INFO - PROCESS | 866 | Values: 362.9 364.1 364.5 365.1 368.3 6288.4 6336.5 6337.6 6343.7 6351.2 6223.5 6255.6 6256.3 6259.6 6272.8 4610.8 4701.2 4749.3 4757.2 4837.8 4828.7 4855.0 4858.6 4872.7 4877.7 4791.9 4801.0 4810.6 4812.4 4821.8 4543.3 4667.6 4756.9 4792.7 4804.3 4226.8 4234.2 4240.1 4244.1 4248.5 6021.5 6023.7 6031.7 6031.9 6035.1 5573.6 5574.3 5575.9 5577.1 5590.5 6588.9 6594.7 6595.5 6601.2 6603.4 4453.6 4556.0 4561.9 4563.2 4620.3 6839.4 6924.5 6937.8 6939.8 6951.8 4712.6 4722.9 4731.3 4732.3 4735.1 4794.4 4795.1 4797.1 4797.8 4804.4 5520.1 5530.4 5531.8 5540.9 5541.5 6394.5 6544.1 6563.2 6572.8 6663.1 1640.8 1652.7 1659.6 1661.0 1663.2 1025.7 1058.4 1088.4 1094.2 1109.0 6354.4 6437.9 6472.3 6568.7 6572.2 6950.9 6970.3 6973.8 7005.9 7054.7 6514.3 6547.4 6558.6 6563.1 6565.9 3667.9 3739.8 3746.8 3752.8 3754.8 7051.8 7107.9 7210.9 7216.7 7217.2 7043.0 7049.5 7052.9 7063.3 7064.3 7188.5 7196.6 7198.8 7199.9 7205.4 6909.1 6910.6 6911.6 6917.7 6922.4 6621.2 6834.7 6836.1 6844.4 6851.8 7146.0 7165.6 7185.5 7188.1 7188.6 4746.9 4750.0 4751.9 4756.7 4763.7 6855.0 6857.3 6871.3 6888.7 6893.1 6476.4 6726.0 6732.6 6772.5 6777.6 6655.1 6686.2 6700.6 6719.5 6753.9 6597.9 6606.3 6615.1 6616.7 6620.2 6763.0 6764.1 6774.9 6775.0 6787.6 6302.7 6406.6 6424.9 6489.7 6583.3 06:40:34 INFO - PROCESS | 866 | 06:40:34 INFO - PROCESS | 866 | [#5] yui.html Cycles:180 Average:16076.25 Median:4945.19 stddev:18521.47 (374.5%) stddev-sans-first:18538.08 06:40:34 INFO - PROCESS | 866 | Values: 837.8 851.6 919.7 932.0 957.0 14677.9 14988.3 14988.5 15002.3 17306.2 14954.9 14991.1 15026.1 15046.8 15079.3 774.4 897.6 912.8 922.6 940.1 913.8 930.3 932.2 932.4 933.8 959.5 978.6 979.7 980.1 981.1 796.0 954.2 958.7 979.1 980.1 706.5 712.5 716.9 717.1 717.2 14190.3 14197.5 14262.6 14272.1 14303.1 14182.9 14440.7 14476.7 14483.1 14532.6 12326.9 12404.6 12405.7 12421.4 12516.1 4030.3 4108.6 4116.1 4164.6 4183.4 60936.0 60964.7 61011.4 61039.4 61705.4 11013.8 11300.3 11316.0 11492.3 11519.1 20748.6 20761.9 20766.3 20779.3 20812.9 8689.4 8703.1 8805.4 8816.0 8982.6 4898.9 4991.3 4998.9 5002.9 5049.6 3574.4 3650.6 3651.1 3651.9 3658.3 615.7 636.0 639.0 655.3 659.2 739.2 777.0 792.3 853.2 853.3 9643.7 9662.0 9740.0 9797.2 9825.2 814.9 823.3 831.5 859.9 865.1 4698.6 4901.3 4902.6 4987.8 4993.1 65040.0 67315.3 67366.0 67439.0 67441.0 55582.7 56726.4 58564.4 58911.4 59395.0 51527.5 51752.2 51853.7 52701.0 52834.2 9787.3 9834.2 9884.9 9888.5 9994.4 39052.0 39271.6 39928.6 40545.4 40710.0 47108.3 47507.0 51306.2 51715.5 52179.0 11910.1 11912.2 12269.0 13977.4 14074.7 14348.0 14547.7 14679.7 14766.0 15548.6 13888.4 14334.6 15186.9 15290.4 15316.0 13595.9 14173.1 14373.7 14444.4 15069.5 13785.7 13808.2 13817.4 13826.5 14422.1 11258.8 11295.9 11448.5 11566.7 11611.4 11153.5 11373.3 11593.0 11619.7 11631.7 06:40:34 INFO - PROCESS | 866 | -------- Summary: end -------- 06:40:34 INFO - PROCESS | 866 | 06:40:34 INFO - TEST-INFO | 866: exit 0 06:40:34 INFO - TEST-OK | dromaeo_css | took 1111715ms 06:40:34 INFO - TEST-START | kraken 06:40:34 INFO - operating with platform_type : linux_ 06:40:34 INFO - Initialising browser for kraken test... 06:40:34 INFO - TEST-INFO | started process 1058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9etV2/profile http://localhost:38734/getInfo.html) 06:40:38 INFO - PROCESS | 1058 | __metrics Screen width/height:1600/1200 06:40:38 INFO - PROCESS | 1058 | colorDepth:24 06:40:38 INFO - PROCESS | 1058 | Browser inner width/height: 1024/697 06:40:38 INFO - PROCESS | 1058 | __metrics 06:40:39 ERROR - PROCESS | 1058 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:40:40 INFO - TEST-INFO | 1058: exit 0 06:40:40 INFO - Browser initialized. 06:40:40 INFO - Running cycle 1/1 for kraken test... 06:40:40 INFO - TEST-INFO | started process 1165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9etV2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:51 INFO - PROCESS | 1165 | RSS: Main: 141991936 06:40:51 INFO - PROCESS | 1165 | 06:40:54 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38734/tests/kraken/driver.html?testName=audio-beat-detection) 06:40:55 INFO - PROCESS | 1165 | RSS: Main: 196796416 06:40:55 INFO - PROCESS | 1165 | 06:40:57 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38734/tests/kraken/driver.html?testName=audio-dft) 06:40:58 INFO - PROCESS | 1165 | RSS: Main: 182673408 06:40:58 INFO - PROCESS | 1165 | 06:41:01 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38734/tests/kraken/driver.html?testName=audio-fft) 06:41:01 INFO - PROCESS | 1165 | RSS: Main: 272465920 06:41:01 INFO - PROCESS | 1165 | 06:41:03 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38734/tests/kraken/driver.html?testName=audio-oscillator) 06:41:04 INFO - PROCESS | 1165 | RSS: Main: 178864128 06:41:04 INFO - PROCESS | 1165 | 06:41:06 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:07 INFO - PROCESS | 1165 | RSS: Main: 177668096 06:41:07 INFO - PROCESS | 1165 | 06:41:10 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38734/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:10 INFO - PROCESS | 1165 | RSS: Main: 212885504 06:41:10 INFO - PROCESS | 1165 | 06:41:14 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38734/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:14 INFO - PROCESS | 1165 | RSS: Main: 213786624 06:41:14 INFO - PROCESS | 1165 | 06:41:17 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38734/tests/kraken/driver.html?testName=json-parse-financial) 06:41:18 INFO - PROCESS | 1165 | RSS: Main: 212873216 06:41:18 INFO - PROCESS | 1165 | 06:41:19 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:20 INFO - PROCESS | 1165 | RSS: Main: 190476288 06:41:20 INFO - PROCESS | 1165 | 06:41:21 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38734/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:41:22 INFO - PROCESS | 1165 | RSS: Main: 191057920 06:41:22 INFO - PROCESS | 1165 | 06:41:24 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:41:25 INFO - PROCESS | 1165 | RSS: Main: 208699392 06:41:25 INFO - PROCESS | 1165 | 06:41:27 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:28 INFO - PROCESS | 1165 | RSS: Main: 213200896 06:41:28 INFO - PROCESS | 1165 | 06:41:30 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:31 INFO - PROCESS | 1165 | RSS: Main: 209174528 06:41:31 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | Cycle 1(1): loaded http://localhost:38734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38734/tests/kraken/driver.html?testName=ai-astar) 06:41:33 INFO - PROCESS | 1165 | RSS: Main: 273207296 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | __start_tp_report 06:41:33 INFO - PROCESS | 1165 | _x_x_mozilla_page_load 06:41:33 INFO - PROCESS | 1165 | _x_x_mozilla_page_load_details 06:41:33 INFO - PROCESS | 1165 | |i|pagename|runs| 06:41:33 INFO - PROCESS | 1165 | |0;ai-astar;111;112;111;110;111;111;105;110;110;110 06:41:33 INFO - PROCESS | 1165 | |1;audio-beat-detection;152;129;149;174;126;158;152;134;209;130 06:41:33 INFO - PROCESS | 1165 | |2;audio-dft;164;162;161;161;161;161;160;161;160;161 06:41:33 INFO - PROCESS | 1165 | |3;audio-fft;76;76;76;173;76;77;75;75;167;75 06:41:33 INFO - PROCESS | 1165 | |4;audio-oscillator;93;92;146;92;93;92;145;92;93;151 06:41:33 INFO - PROCESS | 1165 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;117;118 06:41:33 INFO - PROCESS | 1165 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;146;145 06:41:33 INFO - PROCESS | 1165 | |7;imaging-desaturate;95;94;95;95;95;95;94;94;94;94 06:41:33 INFO - PROCESS | 1165 | |8;json-parse-financial;55;53;54;54;52;55;56;72;53;52 06:41:33 INFO - PROCESS | 1165 | |9;json-stringify-tinderbox;58;56;57;57;58;57;57;57;57;57 06:41:33 INFO - PROCESS | 1165 | |10;stanford-crypto-aes;73;71;73;73;81;74;80;74;74;72 06:41:33 INFO - PROCESS | 1165 | |11;stanford-crypto-ccm;114;114;122;111;115;112;111;112;128;114 06:41:33 INFO - PROCESS | 1165 | |12;stanford-crypto-pbkdf2;164;163;161;160;155;161;154;160;154;161 06:41:33 INFO - PROCESS | 1165 | |13;stanford-crypto-sha256-iterative;67;67;66;66;64;66;65;66;65;65 06:41:33 INFO - PROCESS | 1165 | __end_tp_report 06:41:33 INFO - PROCESS | 1165 | __start_cc_report 06:41:33 INFO - PROCESS | 1165 | _x_x_mozilla_cycle_collect,1609 06:41:33 INFO - PROCESS | 1165 | __end_cc_report 06:41:33 INFO - PROCESS | 1165 | __startTimestamp1462801293392__endTimestamp 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | ------- Summary: start ------- 06:41:33 INFO - PROCESS | 1165 | Number of tests: 14 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 06:41:33 INFO - PROCESS | 1165 | Values: 111.0 112.0 111.0 110.0 111.0 111.0 105.0 110.0 110.0 110.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:152.00 stddev:25.36 (16.7%) stddev-sans-first:26.89 06:41:33 INFO - PROCESS | 1165 | Values: 152.0 129.0 149.0 174.0 126.0 158.0 152.0 134.0 209.0 130.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:0.60 06:41:33 INFO - PROCESS | 1165 | Values: 164.0 162.0 161.0 161.0 161.0 161.0 160.0 161.0 160.0 161.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:39.77 (52.3%) stddev-sans-first:41.61 06:41:33 INFO - PROCESS | 1165 | Values: 76.0 76.0 76.0 173.0 76.0 77.0 75.0 75.0 167.0 75.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:26.57 (28.9%) stddev-sans-first:27.55 06:41:33 INFO - PROCESS | 1165 | Values: 93.0 92.0 146.0 92.0 93.0 92.0 145.0 92.0 93.0 151.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:41:33 INFO - PROCESS | 1165 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 118.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 06:41:33 INFO - PROCESS | 1165 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 06:41:33 INFO - PROCESS | 1165 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:54.50 stddev:5.91 (10.8%) stddev-sans-first:6.26 06:41:33 INFO - PROCESS | 1165 | Values: 55.0 53.0 54.0 54.0 52.0 55.0 56.0 72.0 53.0 52.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 06:41:33 INFO - PROCESS | 1165 | Values: 58.0 56.0 57.0 57.0 58.0 57.0 57.0 57.0 57.0 57.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:3.31 (4.5%) stddev-sans-first:3.46 06:41:33 INFO - PROCESS | 1165 | Values: 73.0 71.0 73.0 73.0 81.0 74.0 80.0 74.0 74.0 72.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:114.00 stddev:5.48 (4.8%) stddev-sans-first:5.79 06:41:33 INFO - PROCESS | 1165 | Values: 114.0 114.0 122.0 111.0 115.0 112.0 111.0 112.0 128.0 114.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:161.00 stddev:3.65 (2.3%) stddev-sans-first:3.46 06:41:33 INFO - PROCESS | 1165 | Values: 164.0 163.0 161.0 160.0 155.0 161.0 154.0 160.0 154.0 161.0 06:41:33 INFO - PROCESS | 1165 | 06:41:33 INFO - PROCESS | 1165 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:0.88 06:41:33 INFO - PROCESS | 1165 | Values: 67.0 67.0 66.0 66.0 64.0 66.0 65.0 66.0 65.0 65.0 06:41:33 INFO - PROCESS | 1165 | -------- Summary: end -------- 06:41:33 INFO - PROCESS | 1165 | 06:41:34 INFO - TEST-INFO | 1165: exit 0 06:41:34 INFO - TEST-OK | kraken | took 59929ms 06:41:34 INFO - SUITE-END | took 1171s 06:41:34 INFO - Completed test suite (00:19:31) 06:41:34 INFO - javascript benchmark 06:41:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.8829640962563, 3389.2882494676132, 3402.506636537702, 3419.914502137448, 3438.1404648837793, 5529.115341545354, 5568.7215639217975, 5587.078132108208, 5599.748011339484, 5601.971990140049, 5603.187537807015, 5622.100463925773, 5623.915641265385, 5630.40880707525, 5638.0, 5015.0972824891505, 5115.258287548303, 5128.820491282806, 5175.068487672217, 5225.163973764198, 5044.646874718771, 5096.949030509684, 5101.209312556541, 5102.617303702219, 5107.514786095315, 5055.418626857903, 5164.1995490699, 5248.0553500369915, 5285.814996475124, 5287.762050707708, 5231.110711179109, 5240.947590524084, 5242.711650859202, 5247.816326428557, 5277.973610131963, 4970.975145124287, 4974.602031837444, 5085.466026067246, 5116.846494605131, 5143.254228136937, 5524.861878453031, 5550.389457159709, 5586.6368686035685, 5588.469095435927, 5595.1886976388605, 5975.163477113164, 6012.458878700938, 6012.5791194616395, 6014.78948236814, 6015.488683461911, 6020.8193754187005, 6064.96967515164, 6102.511799056065, 6112.564273424362, 6129.417705317987, 5498.0, 5547.084731019377, 5549.084401073858, 5553.916691249635, 5588.6646801192055, 6054.636721796706, 6056.727447264883, 6057.606255593372, 6058.878822423527, 6061.605995610271, 5853.912191317134, 5924.7333869975955, 5931.051031834972, 5936.7328470218945, 5944.613600115978, 5979.701014949235, 5986.0, 5987.550933679991, 5995.970020149872, 5996.9805133127475, 5849.795257165979, 5962.403759624003, 5968.612040217372, 5968.641881487125, 6010.519158467399, 5966.045432730829, 5978.850528736816, 5982.4316689914385, 5989.670568118708, 6021.157038014681, 4555.544445555418, 4556.157110934488, 4565.20108980927, 4566.680332376702, 4585.12882552314, 4030.919381612351, 4048.4534587830854, 4095.365218391154, 4104.835806567704, 4129.194807012604, 5735.254416925773, 5786.537077033827, 5787.88424231513, 5800.941990580124, 5821.15593238978, 6103.664298463538, 6104.664243466652, 6111.0527868179615, 6118.082287656887, 6124.601900876518, 5587.972060139673, 5690.857728556736, 5722.799702010493, 5815.912761308584, 5816.185733997244, 5184.11869982104, 5204.583633309327, 5208.348956380452, 5209.843704688866, 5215.869603259949, 6266.811995640138, 6298.118263443122, 6299.401556852092, 6301.873962520724, 6306.211723534559, 5889.469947704727, 6048.5161187105805, 6116.396640261158, 6126.029144987285, 6137.897974673567, 6225.159603453476, 6240.032794916795, 6280.434760871361, 6285.277193122666, 6288.182536270256, 5760.769569217185, 5973.522118230444, 5987.880720778268, 5999.100134979788, 6005.669688167192, 6053.576249662481, 6119.563485741553, 6124.014786914997, 6127.724252408563, 6139.508839292936, 5906.70466476683, 5915.112733090071, 5929.940700593112, 5944.6730429826775, 5948.851278718067, 5773.480386765212, 5798.420157984167, 5858.326292476249, 5900.232969713909, 5903.313992133655, 5735.254416925773, 5757.481826635623, 5794.333651630117, 5794.565407594363, 5830.387809279964, 5849.707514624167, 5914.881702366015, 5920.851978700394, 5922.170896074639, 5924.496417804363, 5681.715914204191, 5802.187693722798, 5850.590458668023, 5886.911696324644, 5968.403159683997], "value": 5562.510059673196, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.2338310942415, 670.765232168741, 682.1166589266899, 686.2519853359837, 754.8490301939613, 32518.67481325189, 38533.80733096334, 39328.803355983255, 39520.99999999996, 39554.40668389977, 43546.346804797955, 44283.0, 44311.0, 44313.11373772522, 44351.77824110875, 8102.594870256464, 9020.458772473672, 9237.076292370743, 9243.676471323504, 10372.273940824145, 10399.48002599867, 10594.735131621694, 10608.09831164352, 10633.255672102956, 10633.521491532862, 10640.62757803477, 10727.678169654922, 10735.302205356666, 10741.409222492759, 10743.086837618812, 8240.093589705128, 10394.532246048946, 10546.103581195608, 10626.78746425071, 10738.281874900056, 10761.62334318303, 10981.835272470918, 11007.449627518672, 11016.06363459107, 11020.559177632886, 44220.336694949605, 44487.0, 44782.32826507605, 44887.0, 44981.32528012082, 3908.3746600543777, 4053.5135783706146, 4132.834686612532, 4165.062860856314, 4228.069824638575, 32705.6729432705, 32913.177170570685, 33037.3392532148, 33169.0, 33232.16919577006, 4516.954830451687, 4602.493725690171, 4630.768461576908, 4638.052276099574, 4858.635602329804, 347122.0, 348980.0, 349099.0, 349779.0, 350233.99999999744, 69176.57881974107, 69896.0, 69924.30075699178, 69938.65030674814, 69974.65012674904, 72643.0, 75215.0, 75261.0, 75323.62338188384, 75361.0, 19338.90330548338, 19751.604967900563, 19812.306569270295, 19822.504437388892, 19823.207071717257, 13175.538856140181, 14532.63668408277, 14899.106053636817, 14925.40298388074, 14936.178510182044, 21599.892000539898, 21644.0, 21694.240701575683, 21762.238321658668, 21832.345029649136, 8016.7194148204535, 8209.220124088202, 8284.763113959318, 8386.993560772624, 8551.828963420698, 1051.7318083888713, 1178.1988247991276, 1198.9940050299692, 1273.35695473787, 1284.955026574084, 33366.3326733464, 33467.16332091717, 33641.0, 34016.65983340135, 34404.0, 1227.6010296653624, 1244.116677159227, 1245.3773113443278, 1293.2176033499597, 1336.2917653643585, 17589.384371546934, 17828.643427131385, 18136.63726725458, 18137.36519221821, 18147.637047259246, 510206.0, 510808.0, 514012.0, 515166.0, 515383.0, 63642.36357636364, 64163.679181603795, 64278.67860660667, 64318.35681643217, 64391.356086439475, 1314.309987256698, 1420.4176287722191, 1514.053716427233, 1521.4903007492392, 1634.5913521619595, 33458.33083338368, 33830.830845845616, 34013.48979765355, 34198.0, 34286.0, 51316.486835131174, 60867.0, 61909.69045154745, 62080.37919620746, 62109.378906212165, 448110.0, 448281.0, 451275.0, 451313.0, 451598.0, 41715.7914210427, 47740.52259477361, 49244.75377623089, 49303.50696492989, 49754.751226243636, 46811.063778723554, 47503.762481187376, 47547.28679069886, 48297.517024830704, 48424.515754842, 38524.0, 39528.40707389449, 39619.0, 39711.80144099261, 40196.19607607773, 41439.37840932328, 42800.1439971205, 42874.57125428706, 43920.34119488146, 44228.33657495076, 43336.566634333256, 43506.78246608747, 44239.0, 44810.77594612006, 44922.77538612286, 35466.64533354634, 37202.25595488129, 37821.810890945366, 38172.0, 38974.80512597419, 29040.854795725885, 29489.45023474416, 29774.702252977193, 29918.0, 30029.54955675623], "value": 22157.233866748375, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.0712838882848, 424.42490425473494, 426.70557315452334, 431.5210116770385, 433.7180832458901, 14159.575212743608, 18592.628147437044, 19111.044447777607, 19149.234030638774, 19981.0, 16148.192590370492, 19082.713759293623, 19341.613167736672, 19626.313079042236, 19725.0, 5590.972045139779, 5788.5369170466265, 5789.131630255453, 5791.884162316751, 5813.273340832396, 5717.714114294289, 5727.140928860663, 5742.712864356787, 5749.166370876221, 5749.568782341341, 4258.510271318792, 4501.774911254441, 6163.599366041215, 6428.646424446653, 6437.0988061671405, 6299.559030867841, 6311.810645680614, 6332.461740752042, 6387.840303992391, 6398.840028999266, 5604.551635869161, 5676.545876329884, 5702.77188912443, 5709.3434255060365, 5717.656940583578, 23047.423814404774, 23336.949837257365, 23652.526949461087, 23947.76052239473, 23949.042038318446, 2491.9626205606933, 2591.8315309504824, 2701.243651777486, 2782.4852402305637, 3052.694730526952, 14507.0, 14981.625459363495, 15207.61980950474, 15326.310316035806, 15716.921415392964, 2006.7792542820278, 2085.728855248823, 2086.8017538333834, 2091.623507768601, 2092.9953622261246, 78894.60552697258, 78959.60520197419, 80067.5996620019, 80099.5995020027, 82114.0, 10777.730556735987, 11233.66299011031, 11291.43542822872, 11344.829827552594, 11360.943195284137, 15886.682266354608, 15926.920365398099, 15987.36050557988, 16017.279222435018, 16034.0, 8514.57427128641, 8559.486430814171, 8767.736967890973, 8827.293816494664, 8905.198532132139, 8938.284937205008, 8982.416142950819, 8984.281257499384, 9025.23285520725, 9025.909740902638, 4442.800073996678, 4683.765811709401, 4969.478204788517, 4987.975060124676, 5018.670052436108, 1929.5176205948512, 1973.1614064022733, 2029.1781828359537, 2071.06801939128, 2075.9273425430038, 979.5445118020154, 1035.9533820978074, 1072.4798472740715, 1093.240198062355, 1128.7234627516311, 19006.33477828297, 19319.4204173875, 19337.903310483358, 19686.30184733368, 19794.0, 1048.192891473561, 1083.1443159903745, 1088.2273585754044, 1102.063246240689, 1154.549725607014, 10861.1854110942, 11146.777064458665, 11202.38386888729, 11307.208495405243, 11345.886541134483, 522560.0, 535685.0, 538558.0, 550914.0, 555473.0, 95334.0, 100009.0, 100119.49940250398, 100542.0, 100641.0, 1083.06315037492, 1093.824988001916, 1144.490701637763, 1146.6846617180342, 1150.79285728568, 17129.74305385445, 17172.313107475562, 17217.82782172162, 17405.0, 17497.47507574775, 39941.0, 40810.387844181765, 41652.79173604112, 41703.16593668049, 42091.0, 59490.70254648699, 59842.40157598542, 60202.096968546386, 60251.096233555654, 60305.09542356956, 8491.74524764258, 8743.344249181464, 8868.290536757173, 8911.777205569913, 8938.553067351291, 9276.0, 9959.502024898582, 13262.0, 13854.238016909167, 14207.928960355546, 11392.0, 11942.4028798558, 12093.75812483763, 12528.686782830502, 12537.435815388148, 11764.176507644383, 12035.45840437165, 12073.75852482963, 12142.635720928387, 12183.939080304543, 11743.295402275891, 11907.106966977339, 11995.820062698893, 12072.818907716215, 12137.817932730839, 9025.548722563977, 9028.593713282786, 9043.0, 9270.860937085814, 9358.53207339644, 11400.771984560097, 11574.884251157717, 11661.24201926872, 11843.348615826213, 11876.228045177382], "value": 9649.263613808973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.910965342079, 1595.3219881550342, 1596.888217824752, 1835.6328734253145, 1916.578352762392, 8263.752087437379, 8461.280791132753, 8463.0, 8463.66145354185, 8479.618417171227, 8272.586370681473, 8466.238038576526, 8467.95766021169, 8472.025717042541, 8477.491350518972, 2148.2051640892814, 2404.8677322747244, 2467.124170919316, 2496.2386472125995, 2520.760527749861, 2473.1714875516723, 2474.542209691213, 2479.851208927461, 2493.588557887955, 2505.08564374004, 2468.7654672806057, 2502.049221295905, 2504.474060447308, 2505.2108585795418, 2506.147909710698, 2155.8275337973005, 2420.225527831095, 2470.234227389497, 2470.234227389515, 2478.8512689238705, 2356.7761062699014, 2402.543516731833, 2402.6396040593877, 2403.723571789249, 2409.2410890569413, 8165.714200003031, 8221.465604735673, 8236.258736713664, 8241.79395515111, 8246.299064579518, 5191.728026633461, 5330.0, 5335.893282134374, 5339.145736682151, 5385.407605163429, 3531.434970404723, 3626.6192049834917, 3627.093226693327, 3638.254157897651, 3692.6861216796606, 1235.172434468908, 1239.39269757818, 1275.0309764578988, 1293.1594463598642, 2193.2214064007367, 11322.660320190407, 11519.827202591969, 11524.250923689933, 11525.020373268198, 11533.711657208552, 4539.296409056601, 4548.067646132535, 4564.018735971782, 4632.305154226893, 4651.930221046687, 9401.388909720847, 9402.15380615748, 9403.43579385239, 9416.387934784218, 9421.905780942103, 4695.859124226278, 5330.200469929541, 5333.253344531769, 5344.839654810284, 5348.411674715778, 4391.626711729538, 4791.736454494967, 4872.220444728827, 4910.950890491049, 4913.803447862046, 3896.3181443247886, 3912.471816304819, 3982.522097348337, 4008.9198216035516, 4016.7389119707127, 1191.6305945157028, 1193.5822462138183, 1207.1851500237306, 1221.9633410997685, 1228.152574723438, 1060.6181774561153, 1063.3832377221347, 1077.2082519348273, 1094.234036174665, 1097.544519024596, 5702.857428564319, 5879.823605291848, 5936.317323507852, 6074.969625151846, 6144.723487443076, 477.9139754844092, 483.3619622098796, 490.0419679526588, 490.16916326825685, 495.10633306881425, 4033.6571391432058, 4057.5333836609166, 4072.8778136655947, 4216.536181020086, 4274.465691788527, 9908.900910990798, 10096.091351778376, 10142.645007424851, 10167.491625418847, 10168.803524578108, 10048.497575121215, 10113.190944724405, 10187.185025197967, 10192.847107293397, 10205.234607404474, 7735.187805280477, 7855.489393189425, 7927.841443171104, 7944.205579442009, 7981.401394895406, 5602.635828671123, 5607.102863541813, 5638.6898720569125, 5786.363500014911, 5829.271341082364, 9097.09029097085, 9100.180983711498, 9209.033051529494, 9277.768055798659, 9370.67202647904, 9277.2578193743, 9295.30285228597, 9298.0, 9374.859377109213, 9564.234861211226, 6447.580907241015, 6924.030635710904, 7012.824679383056, 7229.277072292729, 7301.488895777245, 7749.573773442515, 7845.882311765442, 7849.882251766114, 7862.72480463181, 7866.646000929857, 6984.580925144508, 7193.100862392201, 7239.927600724136, 7241.058662373857, 7390.445716571171, 7130.465215108991, 7153.6423178839805, 7191.892121618284, 7256.7460138894885, 7286.307800758919, 6452.387023232785, 6522.412982831568, 6527.445167160845, 6534.738610455529, 6541.509386796104, 4825.758712064453, 4861.732604706775, 4871.171900776805, 4904.8773780655765, 4908.263760435821, 4978.6763860348965, 4985.202367621163, 4987.526185012418, 5069.518395752398, 5069.695818250917], "value": 4498.628393686312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.94374371972344, 364.1043034136026, 364.52247555702013, 365.1218818740929, 368.2653107051433, 6288.371162883715, 6336.4930805535505, 6337.556371054016, 6343.714532846021, 6351.2060992375955, 6223.502119830403, 6255.591597235063, 6256.2805277393, 6259.593126446778, 6272.84317892053, 4610.815567377309, 4701.2478003519445, 4749.335093086954, 4757.167495688241, 4837.830675926343, 4828.73441960692, 4855.0, 4858.5627293543575, 4872.731999740013, 4877.658563900528, 4791.880202994936, 4800.975995120019, 4810.567048965592, 4812.446568644598, 4821.758912054401, 4543.341215523747, 4667.6265898728025, 4756.881077973044, 4792.688475249098, 4804.303376010459, 4226.830926762957, 4234.216669916075, 4240.1307731914885, 4244.129953359585, 4248.532661407243, 6021.458068773832, 6023.698815059273, 6031.698415079229, 6031.909521357183, 6035.064564992434, 5573.550876772028, 5574.275344205227, 5575.944240557583, 5577.107662773978, 5590.468905453975, 6588.868222635569, 6594.7032383542855, 6595.505337099688, 6601.174853143357, 6603.372679595479, 4453.599176074136, 4555.9772201138785, 4561.863144105682, 4563.201439748064, 4620.330052142454, 6839.418649414805, 6924.549904256207, 6937.791866243971, 6939.757108501229, 6951.7914462566205, 4712.5994290485005, 4722.88192795176, 4731.33761273422, 4732.337472753818, 4735.100330937111, 4794.400699912511, 4795.112904112751, 4797.088553174885, 4797.760111994457, 4804.42346918372, 5520.06158952979, 5530.364008139035, 5531.778728850801, 5540.9168862467095, 5541.473560011793, 6394.456471199907, 6544.149260596092, 6563.245226798884, 6572.8356791080605, 6663.06717059612, 1640.8277130901322, 1652.6942515634646, 1659.576807913974, 1661.0, 1663.1850393307434, 1025.6564051042835, 1058.3596923861107, 1088.4013792414141, 1094.2449709700281, 1108.955641774336, 6354.3963323484195, 6437.871242575122, 6472.255690595548, 6568.737250510022, 6572.211334639874, 6950.895736563955, 6970.302969703091, 6973.79078627642, 7005.894911576331, 7054.682539285642, 6514.283428822826, 6547.410733033955, 6558.573692709959, 6563.081168636395, 6565.934340656532, 3667.9083022924106, 3739.8317075731657, 3746.756460830037, 3752.7935963521722, 3754.81225938702, 7051.8237044073285, 7107.857842843217, 7210.891836622455, 7216.675249613675, 7217.206107328189, 7042.964785176041, 7049.4712896532965, 7052.894206586905, 7063.25835787235, 7064.32888875556, 7188.4904170124855, 7196.568205907663, 7198.820029499095, 7199.9280007200305, 7205.351518363373, 6909.067275917687, 6910.585364878123, 6911.5853048817235, 6917.723291068301, 6922.446204303543, 6621.238557565942, 6834.658267086526, 6836.077129587641, 6844.384005439534, 6851.794446166623, 7145.964270178616, 7165.570065796069, 7185.461090418344, 7188.137423509213, 7188.640567971685, 4746.884482146762, 4750.0, 4751.881202969954, 4756.6908150970075, 4763.666543341933, 6854.965725171542, 6857.314268573103, 6871.278515755774, 6888.690008949509, 6893.0694356261265, 6476.417122459001, 6726.0, 6732.629705366252, 6772.525923185527, 6777.593344399352, 6655.068290439439, 6686.1642294713165, 6700.631465269457, 6719.5296329258435, 6753.932460675331, 6597.901031484627, 6606.3393660635475, 6615.140031796028, 6616.735330586723, 6620.205575330991, 6762.966185169043, 6764.086848275617, 6774.86450270982, 6774.966125169342, 6787.592744435349, 6302.684865756602, 6406.615603063831, 6424.9036264455135, 6489.675516224264, 6583.341665833378], "value": 5035.533339315344, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [837.8449986752447, 851.6125163050812, 919.7194855569053, 931.9953400232998, 956.9712908612744, 14677.853221467782, 14988.325525351358, 14988.475403360871, 15002.324895379707, 17306.221220045096, 14954.925225373858, 14991.100533967969, 15026.098434093961, 15046.774298385533, 15079.321430535652, 774.4346626962292, 897.5736525150551, 912.8356895758794, 922.6125027488471, 940.0928104379273, 913.7624217703411, 930.3208657679897, 932.2215949682023, 932.3566738950136, 933.7945651956559, 959.5298303831142, 978.6476868327396, 979.7256768104942, 980.0542476510167, 981.0777868803337, 796.0328201235498, 954.179405711088, 958.7171784323641, 979.1432496565506, 980.0983095552109, 706.5054461876707, 712.4620911212054, 716.8637958787866, 717.0892965933288, 717.1645033535924, 14190.290485475789, 14197.503087391995, 14262.572122836227, 14272.072315299576, 14303.070300430543, 14182.92908535461, 14440.71118577633, 14476.710465790731, 14483.058601190889, 14532.636684082876, 12326.938365308117, 12404.56584019555, 12405.689857753538, 12421.44103515344, 12516.061295402882, 4030.3349947258666, 4108.630223279919, 4116.0533077392065, 4164.6251837334485, 4183.414321994923, 60936.0, 60964.695176523834, 61011.38988610102, 61039.38960610382, 61705.382946170415, 11013.779724405627, 11300.265482743594, 11316.038440472106, 11492.310461372344, 11519.078473722082, 20748.58502829935, 20761.89619051895, 20766.273180438613, 20779.272725454837, 20812.89593552053, 8689.391742577958, 8703.086175951561, 8805.42764720291, 8816.0, 8982.550872456351, 4898.926516102261, 4991.276264941635, 4998.850034498971, 5002.924956125661, 5049.596032317406, 3574.4280915053987, 3650.561932568056, 3651.1054791576234, 3651.8904432867057, 3658.2683463307444, 615.7106160104744, 635.9841003974846, 638.9872202556015, 655.3250152343094, 659.2319947261483, 739.2053542441896, 776.9611519424006, 792.2552800367636, 853.2363534636465, 853.2789792625222, 9643.662471813594, 9662.033796620282, 9740.0, 9797.167240784613, 9825.231458337425, 814.9062857771432, 823.3372135430916, 831.52441174863, 859.9355048371397, 865.10461672169, 4698.600618947427, 4901.264810278487, 4902.632302577321, 4987.750612469362, 4993.076280888047, 65040.0, 67315.32684673188, 67366.0, 67439.0, 67441.0, 55582.72208638931, 56726.43273567294, 58564.414355856745, 58911.41088589059, 59395.0, 51527.484725153015, 51752.223716645036, 51853.7407312961, 52701.0, 52834.207486887724, 9787.265955053257, 9834.164096051916, 9884.901150988686, 9888.456134912649, 9994.350367226107, 39052.0, 39271.60728392794, 39928.60071399249, 40545.391819122146, 40710.0, 47108.29337559871, 47507.0, 51306.23040654468, 51715.482845171064, 52179.0, 11910.106741994212, 11912.225705329125, 12269.0, 13977.44090236379, 14074.718505629626, 14348.0, 14547.709045819236, 14679.70640587161, 14766.040207386486, 15548.61128471752, 13888.375023124187, 14334.569962901129, 15186.924065380044, 15290.388384464497, 15316.0, 13595.86404135946, 14173.078749881224, 14373.712525749635, 14444.350004249623, 15069.54791356261, 13785.655358616115, 13808.240546770025, 13817.447302107803, 13826.516071937434, 14422.0625659336, 11258.83791927271, 11295.943520282346, 11448.484818183368, 11566.710832228924, 11611.419429028347, 11153.498092586015, 11373.260738052, 11592.95663390299, 11619.651410457362, 11631.709207269885], "value": 7362.879622846541, "unit": "score"}], "name": "dromaeo_css", "value": 7636.88367491468, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 110.0, 111.0, 111.0, 105.0, 110.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 149.0, 174.0, 126.0, 158.0, 152.0, 134.0, 209.0, 130.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 173.0, 76.0, 77.0, 75.0, 75.0, 167.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 146.0, 92.0, 93.0, 92.0, 145.0, 92.0, 93.0, 151.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 52.0, 55.0, 56.0, 72.0, 53.0, 52.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 57.0, 58.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 73.0, 73.0, 81.0, 74.0, 80.0, 74.0, 74.0, 72.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 122.0, 111.0, 115.0, 112.0, 111.0, 112.0, 128.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 160.0, 155.0, 161.0, 154.0, 160.0, 154.0, 161.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 64.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1510.0999999999997, "alertThreshold": 2.0}]} 06:41:34 INFO - Return code: 0 06:41:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:41:34 ERROR - # TBPL SUCCESS # 06:41:34 INFO - Running post-action listener: _resource_record_post_action 06:41:34 INFO - Running post-run listener: _resource_record_post_run 06:41:35 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 498036736; Read time: 0; Write time: 471580 06:41:35 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 248651776; Read time: 0; Write time: 298876 06:41:35 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 249384960; Read time: 0; Write time: 172704 06:41:35 INFO - Running post-run listener: _upload_blobber_files 06:41:35 INFO - Blob upload gear active. 06:41:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:41:35 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'] 06:41:35 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 06:41:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:41:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:41:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:36 INFO - (blobuploader) - INFO - Done attempting. 06:41:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:41:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:41:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:37 INFO - (blobuploader) - INFO - Done attempting. 06:41:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:41:37 INFO - Return code: 0 06:41:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:41:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:41:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a735f2e9f9f331198dc39a85c64a41b8862fcb1bf4f0310a7fd04ea9c7ef16806c568064ff86ca8bfe11665039f074c667258d088d1a73f839d75af435e7db8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4905ee76b4e9a43ed95ceb8803b3b216d4011f8fde4031f996e38aa9ea0f2c0f6e327e8d7c41ab8f11695f8770fe2813cde21c3487eb76b198413c8235845af7"} 06:41:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:41:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:41:37 INFO - Contents: 06:41:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a735f2e9f9f331198dc39a85c64a41b8862fcb1bf4f0310a7fd04ea9c7ef16806c568064ff86ca8bfe11665039f074c667258d088d1a73f839d75af435e7db8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4905ee76b4e9a43ed95ceb8803b3b216d4011f8fde4031f996e38aa9ea0f2c0f6e327e8d7c41ab8f11695f8770fe2813cde21c3487eb76b198413c8235845af7"} 06:41:37 INFO - Running post-run listener: copy_logs_to_upload_dir 06:41:37 INFO - Copying logs to upload dir... 06:41:37 INFO - mkdir: /builds/slave/test/build/upload/logs 06:41:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.691634 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-09 06:41:37.303739) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:37.308833) ========= 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=32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434 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/4a735f2e9f9f331198dc39a85c64a41b8862fcb1bf4f0310a7fd04ea9c7ef16806c568064ff86ca8bfe11665039f074c667258d088d1a73f839d75af435e7db8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4905ee76b4e9a43ed95ceb8803b3b216d4011f8fde4031f996e38aa9ea0f2c0f6e327e8d7c41ab8f11695f8770fe2813cde21c3487eb76b198413c8235845af7"} build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011456 build_url: 'https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/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/4a735f2e9f9f331198dc39a85c64a41b8862fcb1bf4f0310a7fd04ea9c7ef16806c568064ff86ca8bfe11665039f074c667258d088d1a73f839d75af435e7db8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4905ee76b4e9a43ed95ceb8803b3b216d4011f8fde4031f996e38aa9ea0f2c0f6e327e8d7c41ab8f11695f8770fe2813cde21c3487eb76b198413c8235845af7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:37.333009) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:37.333290) ========= 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=32c5991c409366f7fec8a718000001d2-1462800065.19366-738772434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:37.416126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:37.416430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:37.416718) ========= ========= Total master_lag: 0.16 =========