builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1462800065.12 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.121034) ========= 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.121537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.121813) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.139525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.139795) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209 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% 220M=0s 2016-05-09 06:21:05 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112912 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.317145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.317475) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015465 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.343951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:21:05.344264) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:21:05,830 truncating revision to first 12 chars 2016-05-09 06:21:05,830 Setting DEBUG logging. 2016-05-09 06:21:05,830 attempt 1/10 2016-05-09 06:21:05,830 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,600 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=1.088776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 06:21:06.445377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.445704) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.446086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.446348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.454877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-09 06:21:06.455150) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209 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-041', 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": 316, 06:21:07 INFO - "slavename": "talos-linux64-ix-041", 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:08 INFO - Downloaded 1361 bytes. 06:21:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:21:08 INFO - Using the following test package requirements: 06:21:08 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:21:08 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:08 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:21:08 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:08 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:21:08 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:08 INFO - u'jsshell-linux-x86_64.zip'], 06:21:08 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:08 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:21:08 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:21:08 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:08 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:21:08 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:08 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:21:08 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:08 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:21:08 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:21:08 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:21:08 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:21:08 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:08 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:08 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:08 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:08 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:08 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:09 INFO - Downloaded 23798585 bytes. 06:21:09 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:09 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:10 INFO - Return code: 0 06:21:10 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:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:10 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:10 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:10 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:10 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:10 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:11 INFO - Downloaded 23798585 bytes. 06:21:11 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:11 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:13 INFO - Return code: 0 06:21:13 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:13 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:13 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:13 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:13 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:13 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:14 INFO - Downloaded 10840145 bytes. 06:21:14 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:14 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:14 INFO - Return code: 0 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.tar.bz2 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.tar.bz2 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.tar.bz2 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.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:21:14 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:16 INFO - Downloaded 62704189 bytes. 06:21:16 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:16 INFO - mkdir: /builds/slave/test/properties 06:21:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:16 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:16 INFO - Contents: 06:21:16 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:16 INFO - Running post-action listener: _resource_record_post_action 06:21:16 INFO - Running post-action listener: set_extra_try_arguments 06:21:16 INFO - ##### 06:21:16 INFO - ##### Running populate-webroot step. 06:21:16 INFO - ##### 06:21:16 INFO - Running pre-action listener: _resource_record_pre_action 06:21:16 INFO - Running main action method: populate_webroot 06:21:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:16 INFO - '--tppagecycles', 06:21:16 INFO - '7'], 06:21:16 INFO - 'tests': ['tsvgm']}}, 06:21:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:21:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:21:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:16 INFO - 'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:16 INFO - 'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['damp', 'tps']}, 06:21:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:16 INFO - 'tests': ['damp', 'tps']}, 06:21:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['dromaeo_dom']}, 06:21:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['a11yr', 06:21:16 INFO - 'ts_paint', 06:21:16 INFO - 'tpaint', 06:21:16 INFO - 'sessionrestore', 06:21:16 INFO - 'sessionrestore_no_auto_restore', 06:21:16 INFO - 'tabpaint']}, 06:21:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:21:16 INFO - 'ts_paint', 06:21:16 INFO - 'tpaint', 06:21:16 INFO - 'sessionrestore', 06:21:16 INFO - 'sessionrestore_no_auto_restore', 06:21:16 INFO - 'tabpaint']}, 06:21:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:21:16 INFO - 'ts_paint', 06:21:16 INFO - 'tpaint', 06:21:16 INFO - 'sessionrestore', 06:21:16 INFO - 'sessionrestore_no_auto_restore', 06:21:16 INFO - 'tabpaint']}, 06:21:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:21:16 INFO - 'ts_paint', 06:21:16 INFO - 'tpaint', 06:21:16 INFO - 'sessionrestore', 06:21:16 INFO - 'sessionrestore_no_auto_restore', 06:21:16 INFO - 'tabpaint']}, 06:21:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['a11yr', 06:21:16 INFO - 'ts_paint', 06:21:16 INFO - 'tpaint', 06:21:16 INFO - 'sessionrestore', 06:21:16 INFO - 'sessionrestore_no_auto_restore', 06:21:16 INFO - 'tabpaint']}, 06:21:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['a11yr', 06:21:16 INFO - 'ts_paint', 06:21:16 INFO - 'tpaint', 06:21:16 INFO - 'sessionrestore', 06:21:16 INFO - 'sessionrestore_no_auto_restore', 06:21:16 INFO - 'tabpaint']}, 06:21:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['tsvgx', 06:21:16 INFO - 'tsvgr_opacity', 06:21:16 INFO - 'tart', 06:21:16 INFO - 'tscrollx', 06:21:16 INFO - 'cart']}, 06:21:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:21:16 INFO - 'tsvgr_opacity', 06:21:16 INFO - 'tart', 06:21:16 INFO - 'tscrollx', 06:21:16 INFO - 'cart']}, 06:21:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:16 INFO - 'talos_options': ['--disable-e10s'], 06:21:16 INFO - 'tests': ['tp5o']}, 06:21:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:16 INFO - 'tests': ['tp5o']}, 06:21:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:16 INFO - 'talos_options': ['--disable-e10s', 06:21:16 INFO - '--xperf_path', 06:21:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:16 INFO - 'tests': ['tp5n']}, 06:21:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:16 INFO - 'talos_options': ['--xperf_path', 06:21:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:16 INFO - 'tests': ['tp5n']}}, 06:21:16 INFO - 'talos.zip': {'path': '', 06:21:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:16 INFO - Running post-action listener: _resource_record_post_action 06:21:16 INFO - ##### 06:21:16 INFO - ##### Running create-virtualenv step. 06:21:16 INFO - ##### 06:21:16 INFO - Running pre-action listener: _resource_record_pre_action 06:21:16 INFO - Running main action method: create_virtualenv 06:21:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:16 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:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:16 INFO - Using real prefix '/usr' 06:21:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:19 INFO - Installing pip.................done. 06:21:19 INFO - Return code: 0 06:21:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:19 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 0x7f4cc3c31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 06:21:19 INFO - 'HOME': '/home/cltbld', 06:21:19 INFO - 'LANG': 'en_US.UTF-8', 06:21:19 INFO - 'LANGUAGE': 'en_US:en', 06:21:19 INFO - 'LOGNAME': 'cltbld', 06:21:19 INFO - 'MAIL': '/var/mail/cltbld', 06:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:19 INFO - 'MOZ_NO_REMOTE': '1', 06:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:19 INFO - 'NO_EM_RESTART': '1', 06:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:19 INFO - 'PWD': '/builds/slave/test', 06:21:19 INFO - 'SHELL': '/bin/bash', 06:21:19 INFO - 'SHLVL': '1', 06:21:19 INFO - 'TERM': 'linux', 06:21:19 INFO - 'TMOUT': '86400', 06:21:19 INFO - 'USER': 'cltbld', 06:21:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 06:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:19 INFO - '_': '/tools/buildbot/bin/python'} 06:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:19 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:19 INFO - Cleaning up... 06:21:19 INFO - Return code: 0 06:21:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:21:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:19 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 0x7f4cc3c31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 06:21:19 INFO - 'HOME': '/home/cltbld', 06:21:19 INFO - 'LANG': 'en_US.UTF-8', 06:21:19 INFO - 'LANGUAGE': 'en_US:en', 06:21:19 INFO - 'LOGNAME': 'cltbld', 06:21:19 INFO - 'MAIL': '/var/mail/cltbld', 06:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:19 INFO - 'MOZ_NO_REMOTE': '1', 06:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:19 INFO - 'NO_EM_RESTART': '1', 06:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:19 INFO - 'PWD': '/builds/slave/test', 06:21:19 INFO - 'SHELL': '/bin/bash', 06:21:19 INFO - 'SHLVL': '1', 06:21:19 INFO - 'TERM': 'linux', 06:21:19 INFO - 'TMOUT': '86400', 06:21:19 INFO - 'USER': 'cltbld', 06:21:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 06:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:19 INFO - '_': '/tools/buildbot/bin/python'} 06:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:19 INFO - Downloading/unpacking psutil>=0.7.1 06:21:19 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:19 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:19 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:19 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:19 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:19 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:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:21 INFO - Installing collected packages: psutil 06:21:21 INFO - Running setup.py install for psutil 06:21:21 INFO - building 'psutil._psutil_linux' extension 06:21:21 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:22 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:22 INFO - building 'psutil._psutil_posix' extension 06:21:22 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:22 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:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:22 INFO - Successfully installed psutil 06:21:22 INFO - Cleaning up... 06:21:22 INFO - Return code: 0 06:21:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:21:22 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:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:22 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:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:22 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 0x7f4cc3c31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 06:21:22 INFO - 'HOME': '/home/cltbld', 06:21:22 INFO - 'LANG': 'en_US.UTF-8', 06:21:22 INFO - 'LANGUAGE': 'en_US:en', 06:21:22 INFO - 'LOGNAME': 'cltbld', 06:21:22 INFO - 'MAIL': '/var/mail/cltbld', 06:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:22 INFO - 'MOZ_NO_REMOTE': '1', 06:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:22 INFO - 'NO_EM_RESTART': '1', 06:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:22 INFO - 'PWD': '/builds/slave/test', 06:21:22 INFO - 'SHELL': '/bin/bash', 06:21:22 INFO - 'SHLVL': '1', 06:21:22 INFO - 'TERM': 'linux', 06:21:22 INFO - 'TMOUT': '86400', 06:21:22 INFO - 'USER': 'cltbld', 06:21:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 06:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:22 INFO - '_': '/tools/buildbot/bin/python'} 06:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:21:22 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:22 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:22 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:22 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:22 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:22 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 - Downloading mozsystemmonitor-0.0.tar.gz 06:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:24 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:24 INFO - Installing collected packages: mozsystemmonitor 06:21:24 INFO - Running setup.py install for mozsystemmonitor 06:21:24 INFO - Successfully installed mozsystemmonitor 06:21:24 INFO - Cleaning up... 06:21:24 INFO - Return code: 0 06:21:24 INFO - Installing blobuploader==1.2.4 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', '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 0x7f4cc3c31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 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 blobuploader==1.2.4 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 - Downloading blobuploader-1.2.4.tar.gz 06:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:27 INFO - Downloading docopt-0.6.1.tar.gz 06:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:27 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:27 INFO - Running setup.py install for blobuploader 06:21:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:27 INFO - Running setup.py install for requests 06:21:27 INFO - Running setup.py install for docopt 06:21:28 INFO - Successfully installed blobuploader requests docopt 06:21:28 INFO - Cleaning up... 06:21:28 INFO - Return code: 0 06:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:28 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 0x7f4cc3c31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 06:21:28 INFO - 'HOME': '/home/cltbld', 06:21:28 INFO - 'LANG': 'en_US.UTF-8', 06:21:28 INFO - 'LANGUAGE': 'en_US:en', 06:21:28 INFO - 'LOGNAME': 'cltbld', 06:21:28 INFO - 'MAIL': '/var/mail/cltbld', 06:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:28 INFO - 'MOZ_NO_REMOTE': '1', 06:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:28 INFO - 'NO_EM_RESTART': '1', 06:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:28 INFO - 'PWD': '/builds/slave/test', 06:21:28 INFO - 'SHELL': '/bin/bash', 06:21:28 INFO - 'SHLVL': '1', 06:21:28 INFO - 'TERM': 'linux', 06:21:28 INFO - 'TMOUT': '86400', 06:21:28 INFO - 'USER': 'cltbld', 06:21:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 06:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:28 INFO - '_': '/tools/buildbot/bin/python'} 06:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:28 INFO - Running setup.py (path:/tmp/pip-7KbbYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:28 INFO - Running setup.py (path:/tmp/pip-qa7rcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:28 INFO - Running setup.py (path:/tmp/pip-Xd0PYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:28 INFO - Running setup.py (path:/tmp/pip-3yfeO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:28 INFO - Running setup.py (path:/tmp/pip-qPWNPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:28 INFO - Running setup.py (path:/tmp/pip-npHLHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:28 INFO - Running setup.py (path:/tmp/pip-mbmxqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:28 INFO - Running setup.py (path:/tmp/pip-HljR0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:28 INFO - Running setup.py (path:/tmp/pip-wZOyYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:29 INFO - Running setup.py (path:/tmp/pip-H2Q7r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:29 INFO - Running setup.py (path:/tmp/pip-iElUMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:29 INFO - Running setup.py (path:/tmp/pip-8L0pKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:29 INFO - Running setup.py (path:/tmp/pip-HasY2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:29 INFO - Running setup.py (path:/tmp/pip-bCnGAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:29 INFO - Running setup.py (path:/tmp/pip-OruStP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:29 INFO - Running setup.py (path:/tmp/pip-BJMJ2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:29 INFO - Running setup.py (path:/tmp/pip-fy3FQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:29 INFO - Running setup.py install for manifestparser 06:21:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:29 INFO - Running setup.py install for mozcrash 06:21:29 INFO - Running setup.py install for mozdebug 06:21:29 INFO - Running setup.py install for mozdevice 06:21:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:21:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Running setup.py install for mozfile 06:21:30 INFO - Running setup.py install for mozhttpd 06:21:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Running setup.py install for mozinfo 06:21:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Running setup.py install for mozInstall 06:21:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Running setup.py install for mozleak 06:21:30 INFO - Running setup.py install for mozlog 06:21:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Running setup.py install for moznetwork 06:21:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Running setup.py install for mozprocess 06:21:30 INFO - Running setup.py install for mozprofile 06:21:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:30 INFO - Running setup.py install for mozrunner 06:21:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozscreenshot 06:21:31 INFO - Running setup.py install for moztest 06:21:31 INFO - Running setup.py install for mozversion 06:21:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:31 INFO - Cleaning up... 06:21:31 INFO - Return code: 0 06:21:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:31 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 0x7f4cc3c31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 06:21:31 INFO - 'HOME': '/home/cltbld', 06:21:31 INFO - 'LANG': 'en_US.UTF-8', 06:21:31 INFO - 'LANGUAGE': 'en_US:en', 06:21:31 INFO - 'LOGNAME': 'cltbld', 06:21:31 INFO - 'MAIL': '/var/mail/cltbld', 06:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:31 INFO - 'MOZ_NO_REMOTE': '1', 06:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:31 INFO - 'NO_EM_RESTART': '1', 06:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:31 INFO - 'PWD': '/builds/slave/test', 06:21:31 INFO - 'SHELL': '/bin/bash', 06:21:31 INFO - 'SHLVL': '1', 06:21:31 INFO - 'TERM': 'linux', 06:21:31 INFO - 'TMOUT': '86400', 06:21:31 INFO - 'USER': 'cltbld', 06:21:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 06:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:31 INFO - '_': '/tools/buildbot/bin/python'} 06:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:31 INFO - Running setup.py (path:/tmp/pip-UThZVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:31 INFO - Running setup.py (path:/tmp/pip-HTaoUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:31 INFO - Running setup.py (path:/tmp/pip-iktkgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:31 INFO - Running setup.py (path:/tmp/pip-KPD3ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:31 INFO - Running setup.py (path:/tmp/pip-pt91Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:31 INFO - Running setup.py (path:/tmp/pip-3_i7oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:32 INFO - Running setup.py (path:/tmp/pip-mBjZhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:32 INFO - Running setup.py (path:/tmp/pip-06hePl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:32 INFO - Running setup.py (path:/tmp/pip-ol9ZED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:32 INFO - Running setup.py (path:/tmp/pip-gpG8uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:32 INFO - Running setup.py (path:/tmp/pip-_rICOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:32 INFO - Running setup.py (path:/tmp/pip-L_XZgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:32 INFO - Running setup.py (path:/tmp/pip-3BgCTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:32 INFO - Running setup.py (path:/tmp/pip-QT5LSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:32 INFO - Running setup.py (path:/tmp/pip-58TIKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:32 INFO - Running setup.py (path:/tmp/pip-75PT9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:32 INFO - Running setup.py (path:/tmp/pip-QTiZDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:34 INFO - Downloading blessings-1.6.tar.gz 06:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:34 INFO - Installing collected packages: blessings 06:21:34 INFO - Running setup.py install for blessings 06:21:34 INFO - Successfully installed blessings 06:21:34 INFO - Cleaning up... 06:21:34 INFO - Return code: 0 06:21:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:35 INFO - Reading from file tmpfile_stdout 06:21:35 INFO - Current package versions: 06:21:35 INFO - argparse == 1.2.1 06:21:35 INFO - blessings == 1.6 06:21:35 INFO - blobuploader == 1.2.4 06:21:35 INFO - docopt == 0.6.1 06:21:35 INFO - manifestparser == 1.1 06:21:35 INFO - mozInstall == 1.12 06:21:35 INFO - mozcrash == 0.17 06:21:35 INFO - mozdebug == 0.1 06:21:35 INFO - mozdevice == 0.48 06:21:35 INFO - mozfile == 1.2 06:21:35 INFO - mozhttpd == 0.7 06:21:35 INFO - mozinfo == 0.9 06:21:35 INFO - mozleak == 0.1 06:21:35 INFO - mozlog == 3.1 06:21:35 INFO - moznetwork == 0.27 06:21:35 INFO - mozprocess == 0.22 06:21:35 INFO - mozprofile == 0.28 06:21:35 INFO - mozrunner == 6.11 06:21:35 INFO - mozscreenshot == 0.1 06:21:35 INFO - mozsystemmonitor == 0.0 06:21:35 INFO - moztest == 0.7 06:21:35 INFO - mozversion == 1.4 06:21:35 INFO - psutil == 3.1.1 06:21:35 INFO - requests == 1.2.3 06:21:35 INFO - wsgiref == 0.1.2 06:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:35 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 0x7f4cc3c31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 06:21:35 INFO - 'HOME': '/home/cltbld', 06:21:35 INFO - 'LANG': 'en_US.UTF-8', 06:21:35 INFO - 'LANGUAGE': 'en_US:en', 06:21:35 INFO - 'LOGNAME': 'cltbld', 06:21:35 INFO - 'MAIL': '/var/mail/cltbld', 06:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:35 INFO - 'MOZ_NO_REMOTE': '1', 06:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:35 INFO - 'NO_EM_RESTART': '1', 06:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:35 INFO - 'PWD': '/builds/slave/test', 06:21:35 INFO - 'SHELL': '/bin/bash', 06:21:35 INFO - 'SHLVL': '1', 06:21:35 INFO - 'TERM': 'linux', 06:21:35 INFO - 'TMOUT': '86400', 06:21:35 INFO - 'USER': 'cltbld', 06:21:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 06:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:35 INFO - '_': '/tools/buildbot/bin/python'} 06:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 INFO - Cleaning up... 06:21:35 INFO - Return code: 0 06:21:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:35 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 0x7f4cc3c31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 06:21:35 INFO - 'HOME': '/home/cltbld', 06:21:35 INFO - 'LANG': 'en_US.UTF-8', 06:21:35 INFO - 'LANGUAGE': 'en_US:en', 06:21:35 INFO - 'LOGNAME': 'cltbld', 06:21:35 INFO - 'MAIL': '/var/mail/cltbld', 06:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:35 INFO - 'MOZ_NO_REMOTE': '1', 06:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:35 INFO - 'NO_EM_RESTART': '1', 06:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:35 INFO - 'PWD': '/builds/slave/test', 06:21:35 INFO - 'SHELL': '/bin/bash', 06:21:35 INFO - 'SHLVL': '1', 06:21:35 INFO - 'TERM': 'linux', 06:21:35 INFO - 'TMOUT': '86400', 06:21:35 INFO - 'USER': 'cltbld', 06:21:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 06:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:35 INFO - '_': '/tools/buildbot/bin/python'} 06:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:35 INFO - Downloading/unpacking jsonschema 06:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:21:37 INFO - Downloading/unpacking functools32 (from jsonschema) 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:37 INFO - Downloading functools32-3.2.3-2.tar.gz 06:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:21:37 INFO - warning: no files found matching '*.txt' 06:21:37 INFO - no previously-included directories found matching 'build' 06:21:37 INFO - no previously-included directories found matching 'dist' 06:21:37 INFO - no previously-included directories found matching '.git*' 06:21:37 INFO - Installing collected packages: jsonschema, functools32 06:21:37 INFO - Running setup.py install for functools32 06:21:37 INFO - warning: no files found matching '*.txt' 06:21:37 INFO - no previously-included directories found matching 'build' 06:21:37 INFO - no previously-included directories found matching 'dist' 06:21:37 INFO - no previously-included directories found matching '.git*' 06:21:37 INFO - Successfully installed jsonschema functools32 06:21:37 INFO - Cleaning up... 06:21:37 INFO - Return code: 0 06:21:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4cc3c31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', '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:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:21:37 INFO - Using env: {'DISPLAY': ':0', 06:21:37 INFO - 'HOME': '/home/cltbld', 06:21:37 INFO - 'LANG': 'en_US.UTF-8', 06:21:37 INFO - 'LANGUAGE': 'en_US:en', 06:21:37 INFO - 'LOGNAME': 'cltbld', 06:21:37 INFO - 'MAIL': '/var/mail/cltbld', 06:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:37 INFO - 'MOZ_NO_REMOTE': '1', 06:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:37 INFO - 'NO_EM_RESTART': '1', 06:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:37 INFO - 'PWD': '/builds/slave/test', 06:21:37 INFO - 'SHELL': '/bin/bash', 06:21:37 INFO - 'SHLVL': '1', 06:21:37 INFO - 'TERM': 'linux', 06:21:37 INFO - 'TMOUT': '86400', 06:21:37 INFO - 'USER': 'cltbld', 06:21:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 06:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:37 INFO - '_': '/tools/buildbot/bin/python'} 06:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:38 INFO - Downloading/unpacking flake8 06:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:21:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 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:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:21:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:21:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:40 INFO - no previously-included directories found matching 'docs/_build' 06:21:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:21:40 INFO - Running setup.py install for pep8 06:21:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:40 INFO - no previously-included directories found matching 'docs/_build' 06:21:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:21:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:21:40 INFO - Cleaning up... 06:21:41 INFO - Return code: 0 06:21:41 INFO - Running post-action listener: _resource_record_post_action 06:21:41 INFO - Running post-action listener: _start_resource_monitoring 06:21:41 INFO - Starting resource monitoring. 06:21:41 INFO - ##### 06:21:41 INFO - ##### Running install step. 06:21:41 INFO - ##### 06:21:41 INFO - Running pre-action listener: _resource_record_pre_action 06:21:41 INFO - Running main action method: install 06:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:41 INFO - Reading from file tmpfile_stdout 06:21:41 INFO - Detecting whether we're running mozinstall >=1.0... 06:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:21:41 INFO - Reading from file tmpfile_stdout 06:21:41 INFO - Output received: 06:21:41 INFO - Usage: mozinstall [options] installer 06:21:41 INFO - Options: 06:21:41 INFO - -h, --help show this help message and exit 06:21:41 INFO - -d DEST, --destination=DEST 06:21:41 INFO - Directory to install application into. [default: 06:21:41 INFO - "/builds/slave/test"] 06:21:41 INFO - --app=APP Application being installed. [default: firefox] 06:21:41 INFO - mkdir: /builds/slave/test/build/application 06:21:41 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:41 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:21:56 INFO - Reading from file tmpfile_stdout 06:21:56 INFO - Output received: 06:21:56 INFO - /builds/slave/test/build/application/firefox/firefox 06:21:56 INFO - Running post-action listener: _resource_record_post_action 06:21:56 INFO - ##### 06:21:56 INFO - ##### Running run-tests step. 06:21:56 INFO - ##### 06:21:56 INFO - Running pre-action listener: _resource_record_pre_action 06:21:56 INFO - Running main action method: run_tests 06:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:21:56 INFO - Python 2.7.3 06:21:56 INFO - Return code: 0 06:21:56 INFO - grabbing minidump binary from tooltool 06:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:56 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 0x1633410>, '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 0x1634310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16347a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:21:56 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:21:56 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:21:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:21:57 INFO - Return code: 0 06:21:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:21:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:21:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:21:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:21:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:21:57 INFO - Return code: 0 06:21:57 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-041', '--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:21:57 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-041 --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:21:57 INFO - Using env: {'DISPLAY': ':0', 06:21:57 INFO - 'HOME': '/home/cltbld', 06:21:57 INFO - 'LANG': 'en_US.UTF-8', 06:21:57 INFO - 'LANGUAGE': 'en_US:en', 06:21:57 INFO - 'LOGNAME': 'cltbld', 06:21:57 INFO - 'MAIL': '/var/mail/cltbld', 06:21:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:21:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:57 INFO - 'MOZ_NO_REMOTE': '1', 06:21:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:57 INFO - 'NO_EM_RESTART': '1', 06:21:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:57 INFO - 'PWD': '/builds/slave/test', 06:21:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:21:57 INFO - 'SHELL': '/bin/bash', 06:21:57 INFO - 'SHLVL': '1', 06:21:57 INFO - 'TERM': 'linux', 06:21:57 INFO - 'TMOUT': '86400', 06:21:57 INFO - 'USER': 'cltbld', 06:21:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209', 06:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:57 INFO - '_': '/tools/buildbot/bin/python'} 06:21:57 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-041', '--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:21:58 INFO - mozversion application_buildid: 20160509005049 06:21:58 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:21:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:21:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:21:58 INFO - mozversion application_name: Firefox 06:21:58 INFO - mozversion application_remotingname: firefox-dev 06:21:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:21:58 INFO - mozversion application_vendor: Mozilla 06:21:58 INFO - mozversion application_version: 48.0a2 06:21:58 INFO - mozversion platform_buildid: 20160509005049 06:21:58 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:21:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:21:58 INFO - mozversion platform_version: 48.0a2 06:21:58 INFO - using testdate: 1462800118 06:21:58 INFO - actual date: 1462800118 06:21:58 INFO - starting webserver on 'localhost:50650' 06:21:58 INFO - SUITE-START | Running 2 tests 06:21:58 INFO - TEST-START | dromaeo_css 06:21:58 INFO - operating with platform_type : linux_ 06:21:58 INFO - Initialising browser for dromaeo_css test... 06:21:58 INFO - TEST-INFO | started process 21914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcEZ_iB/profile http://localhost:50650/getInfo.html) 06:22:02 INFO - PROCESS | 21914 | __metrics Screen width/height:1600/1200 06:22:02 INFO - PROCESS | 21914 | colorDepth:24 06:22:02 INFO - PROCESS | 21914 | Browser inner width/height: 1024/697 06:22:02 INFO - PROCESS | 21914 | __metrics 06:22:03 ERROR - PROCESS | 21914 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:22:04 INFO - TEST-INFO | 21914: exit 0 06:22:04 INFO - Browser initialized. 06:22:04 INFO - Running cycle 1/1 for dromaeo_css test... 06:22:04 INFO - TEST-INFO | started process 22007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcEZ_iB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:16 INFO - PROCESS | 22007 | RSS: Main: 142462976 06:22:16 INFO - PROCESS | 22007 | 06:23:06 INFO - PROCESS | 22007 | 1462800186956 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:15 INFO - PROCESS | 22007 | Cycle 1(1): loaded http://localhost:50650/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50650/tests/dromaeo/cssquery-ext.html) 06:25:16 INFO - PROCESS | 22007 | RSS: Main: 248197120 06:25:16 INFO - PROCESS | 22007 | 06:28:18 INFO - PROCESS | 22007 | Cycle 1(1): loaded http://localhost:50650/tests/dromaeo/cssquery-ext.html (next: http://localhost:50650/tests/dromaeo/cssquery-jquery.html) 06:28:19 INFO - PROCESS | 22007 | RSS: Main: 218951680 06:28:19 INFO - PROCESS | 22007 | 06:31:20 INFO - PROCESS | 22007 | Cycle 1(1): loaded http://localhost:50650/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50650/tests/dromaeo/cssquery-mootools.html) 06:31:21 INFO - PROCESS | 22007 | RSS: Main: 219328512 06:31:21 INFO - PROCESS | 22007 | 06:34:23 INFO - PROCESS | 22007 | Cycle 1(1): loaded http://localhost:50650/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50650/tests/dromaeo/cssquery-prototype.html) 06:34:23 INFO - PROCESS | 22007 | RSS: Main: 213393408 06:34:23 INFO - PROCESS | 22007 | 06:37:26 INFO - PROCESS | 22007 | Cycle 1(1): loaded http://localhost:50650/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50650/tests/dromaeo/cssquery-yui.html) 06:37:27 INFO - PROCESS | 22007 | RSS: Main: 184733696 06:37:27 INFO - PROCESS | 22007 | 06:40:29 INFO - PROCESS | 22007 | Cycle 1(1): loaded http://localhost:50650/tests/dromaeo/cssquery-yui.html (next: http://localhost:50650/tests/dromaeo/cssquery-dojo.html) 06:40:29 INFO - PROCESS | 22007 | RSS: Main: 253349888 06:40:29 INFO - PROCESS | 22007 | 06:40:29 INFO - PROCESS | 22007 | __start_tp_report 06:40:29 INFO - PROCESS | 22007 | _x_x_mozilla_page_load 06:40:29 INFO - PROCESS | 22007 | _x_x_mozilla_page_load_details 06:40:29 INFO - PROCESS | 22007 | |i|pagename|runs| 06:40:29 INFO - PROCESS | 22007 | |0;dojo.html;3326.3679900818843;3359.512870633757;3367.6800703933127;3381.0702056934356;3403.6256011838695;5498.422665620113;5512.062949298619;5537.418571050042;5550.528205102566;5552.472515111068;5538.086215774392;5555.916661250085;5559.122285759795;5560.304961879765;5599.32808063032;4947.925781113268;5043.773030213631;5056.266841308017;5067.265246539249;5164.1995490699;5003.599712023048;5088;5090.516400941905;5167.9224811627855;5168.302279192318;5163.432022477525;5166.354205724285;5194.58443324535;5208.427073021964;5209.791608335662;5183.688978661255;5191.714455704935;5205.635605507616;5207.9479205207845;5236.842894713165;4972.701637901701;4987.725675087869;5003.874903127415;5099.311592934943;5100.209467532539;5476.863078423032;5534;5538.113901775737;5547.278853748987;5549.417311182308;5947.524198064145;5963.940360596382;5991.910121348184;6007.189029481052;6011;5872.148538461942;5949.6727679977585;5994.55040871932;6030.758769649209;6056.152138700585;5585.3297604287745;5631.267935168402;5632.859178520488;5635.915461268084;5638.351589567212;6105.26736791579;6113.510919126459;6127.571070025056;6130.417610327012;6131.767124586389;5688.203651488795;5799.9130013049835;5837.270341207349;5895.233619629421;5899.764009439575;5941.673207973517;5954.285485741739;5961.165436838846;5961.821145365646;5965.194698715618;5769.971150144306;5933.258342707161;5939;5944.762209511571;5948.018576934844;5812.331581868055;5842.795502157404;5862.677552734641;5910.408959104141;5920.911186332209;4507.076049409863;4510.030343476168;4510.21071312519;4510.797014134372;4539.818407263672;4002.8999275017777;4039.7980100994832;4055.128147448254;4064.227796718614;4087.7751723655483;5556.111022236423;5580.553555715533;5585.553155747531;5595.104783234663;5597.048501754712;5927.407259274038;5928.081147422156;5928.3775203603;5929.644221346733;5930.377310382348;5525.336959564797;5601;5625.634333768292;5667.716614169275;5726.942730572641;5134.383873935151;5146.176611742103;5148.330717006766;5152.124138896396;5169.147090730063;6161.383861613893;6167.938320616737;6168.814935551941;6175.2589689237575;6180.103884936659;5814.186013957965;5981.5214782817275;5994.910076348945;6072.271327440735;6074.90887636677;6102;6103.725332359965;6103.908441373472;6108.08378743192;6125.84685382869;5776;5811.622244554091;5812.3025236971835;5824.854378640398;5830.591858569859;5788.305403351625;5908.350081490947;5988;6006.759729610942;6033.18551995475;5774.797882074107;5794.217780599565;5794.304683438015;5795.39148389413;5812.7674893003805;5708.286464191976;5715.828525144252;5771.538276937751;5780.421957804186;5782.797602083907;5686.77252909879;5734.627249228787;5745.454181852718;5762.567807414544;5763.394843541368;5759.078547432391;5781.5663825214115;5785.392533783892;5789.247397838254;5794.652320860761;5610.831675049755;5699.2590963174525;5703.942960570341;5711.371749107512;5753.108268218432 06:40:29 INFO - PROCESS | 22007 | |1;ext.html;662.7448432353542;672.5292295393219;680.7583307925686;721.9602921839297;740.8999785029023;33658.83170584147;34591.82704086476;34603.30793384134;34626.30747385054;34653.48019779706;34334.8283258584;40855.38716919249;41315.58684413155;41316.58683413165;41474.58525414745;8881.60032798524;9010.18908298253;9019.098090190993;9028.458292502439;9033.909660903373;8337.666493340259;8820.514871682055;8962.193402593764;8965.596548155316;10810.72973175669;10661.573537058508;10751.247412681116;10753.51609177589;10754.139668826476;10763.13894888411;10702.892971070307;10800.189985751022;10800.891991080067;10802.405867677275;10812.026917577416;10454.163666906628;10578.153747700166;10594.25840191187;10594.576216951313;10604.257701960865;40394.39408408876;40760.592394075975;40787.18425631471;45298.54701453009;45313.77343113296;3562.8040457774814;3580.838862251205;3605.5312809334882;3722.8696995605023;3801.3727734923705;34444;34662.82668586666;34892.47661285083;34953.12617184565;35093;4282.164977829325;4365.454318210223;4366.039471316305;4367.301231802928;4412.294032954712;336815;339460;339565;340245;342106;61553;62922.37077629257;62925.056124158174;62932.05601915975;63036;62188;63529;63569.682151588946;63599.68200159062;63643;19820.90089549543;20078.799212007692;20115.597688046157;20164.193432262546;20166.798332016493;13726.313684315744;15388.615284617974;15443.227838608025;15449.613759656098;15472.845271547365;20001.699974500396;21338.57322853534;21442.142314307253;21499.892500537397;21505.569888602142;7375.262473752582;7459.216782237895;7655.46411751172;7736.226377362219;7774.92225077742;1104.745908441063;1160.1762748448696;1172.0623501199177;1210.056156198167;1210.5944508589546;32843.50734738981;33192.336153276796;33423.498647520304;33775.15562110967;34492;1095.3592148593161;1123.8089524780808;1198.8801119887942;1202.1825158892038;1220.6155061155707;18093.095345232687;18146.183421746053;18550.628987420445;18624;18629.627407451775;512042;518875;519710;521107;521504;62965.37034629687;63780;63780;63788.362116378245;63822.36177638257;1511.7430036893754;1557.3770491803143;1563.6090977255685;1612.8790340724493;1641.8358164183487;31498.68501315049;33838;33953;34238.65761342454;35278.64721352753;51217.743911281694;66754.3324566748;69555.65222174059;69559;69559.30440695529;443796;444475;449470;449691;449958;42933.355999659405;46154.76922615366;47342.28986565136;47584.76207619078;47904.5209547914;45198.77400612976;45531.54468455406;46023.30965035594;46083.76958115188;46361.536384637075;40826.1834763309;41318.38022429606;42016.57983420249;42243;43284.13431731411;41629.58370416378;41649.16701665889;41736.79131604323;41854.37218441665;41862.372064419666;41994.790026049675;42228;42672.14655706807;43011;43464.565354347316;35725.46411803773;36480;37501.62498374981;37906.81046594749;38130.42804357882;28840.855795720887;28847.85576072106;29040.56439153372;29321.266968325963;29330.853345733136 06:40:29 INFO - PROCESS | 22007 | |2;jquery.html;414.77394819823195;418.76758399088493;419.5385076415942;429.7894031924356;435.2209544914603;17592.560185995324;18550.721739173907;18962.146703398346;19114.522136946583;19157.329493467732;18482.537936551595;18718.812811871878;18774.62450750984;19667.114979825907;19680.606387872234;5654.547636189116;5763.942360576403;5812.709364531777;5822.214001109859;5832.854178645546;5649.661020338773;5691.146328050784;5779.884402311951;5801.9129713054335;5816.883662326751;5673.773049078032;5760.740766665489;5766.394528574502;5769.509591684712;5813.040848260032;5594.888102237953;5670.801521946753;5722;5725.370209276997;5760.164776107462;5086.109930762102;5130.538251557377;5132.076226279269;5143.7685304161405;5203.60972927032;21342.89328553347;22284;22703.545929081327;22720.204792832337;22857.31428057161;2359.2332491940188;2655.49545586338;2682.557378032622;2700.527407703664;2777.6250206222103;10121.69634910954;10510.054095131398;10563;11630.011449026842;14360.64098397538;2001.148037449777;2028.6956956456502;2095.182878677317;2118.205672872673;2129.084493667722;83754.58122709347;84560.57719711424;86735.56632216861;86797;87067.56466217629;10467.84298235527;10573.788524229472;10632.893671063344;10641.946790266154;10666.839997400046;15427.922860385626;15433.151176685391;15471.381144754308;15511;15534.1456219909;8678.132186781271;8756.168164024408;8806.691765788166;8818.51498167594;9052.094790520896;8784.560771961376;8859.11408859109;8896.199342059117;8942.37403381757;9087.681931132378;4668.929966050512;4672.672912896064;4724.173269677793;4788.449328327218;4820.68665536739;1892.9621407571772;1947.5707585877703;1990;2010.7587089549347;2011.3262057210998;980.5195454227377;1033.188946676855;1060.4432672846817;1101.5869049106584;1135.9488823002985;17913.462596122135;18284.360047398277;18624.534386640444;18711.532211694543;18978.43064708061;1029.562435964712;1058.8464672622426;1078.428432930548;1094.3215206571977;1106.6016234155697;10282.742931426774;10502.632407865687;10670.115352598388;10680;10970.670879873616;540925;573478;578341;581323;581990;91702;95079;95146.52426737822;95676;96734.5163274179;1100.7193165742844;1111.4664960818852;1112.3937454087543;1113.465536542448;1140.931544107356;16575.585610359838;16575.91712041432;16687.332506699597;16911.830881691025;17230.913845430692;38866.61133388743;39008.60991390163;39326.213475730896;41048;42027;54889.451105488435;55510;56528.434715652314;57070.287891363325;58408.4159158403;8657.22085012352;8700.347473939606;8723.171298726611;8772.868406974028;8837.823243534966;9827.55775990068;13326.33368331599;13341.933290333487;13398.196108233537;13864.653383665489;11734.706632333919;11736.823947640964;11838.28970261787;11922.880771192524;12009.63971080869;11341;11682.18926066461;11885.465154067915;12088.879111208775;12153.574624888086;12029.939850301043;12146;12203.572874949334;12214.57248996281;12617.116801823784;8624.353173511887;8644.783880402789;8749.868751968854;8861;8901.554922253732;11882.76234475323;11951.880481195076;12116.878831211576;12143.574974875837;12166.635000949986 06:40:29 INFO - PROCESS | 22007 | |3;mootools.html;1422.1751384197166;1580.5416429235522;1581.965986733829;1848.953776155596;1968.5275533871875;8304.709335173271;8468.407211495198;8481.151884811516;8497.277731392824;8498.277646400064;8375.204355586226;8547.615357308921;8548.74353769388;8555.443896146746;8557.22984931356;2101.8949052547387;2396.7363590005084;2446.9021239150456;2474.4679893822827;2479.9008039678392;2434.306222726523;2479.2066538707622;2491.9750802491926;2493.5262300163004;2493.6633554470186;2381.6189409694452;2410.927672169838;2414.4326083370393;2414.8671823049726;2415.6738840256517;2116.375669177596;2350.0717216699395;2390.115657206827;2393.1384701507445;2396.065534441569;2329.149860300995;2336.778006089419;2338.018032426385;2340.6372012338115;2420.491696743686;8382.119877412844;8480.66077356905;8488.66045358185;8491.532965686885;8499;5108.361454818148;5226.764795584208;5263.131583288753;5272.4200337963175;5298.443663415324;3533.222691007974;3644.8542058317635;3656.232191239843;3675.5405574303213;3729.0490924814;1235.4440501774147;1250.8561515425752;1260.9810852837215;1341.8926485881204;2113.6301147299314;11825.822612660817;11862.347570883598;11947.103967202494;11948.342841143734;11958.820617690742;4452.710573812692;4661.067786442725;4661.370714953506;4668.253079507263;4684.672072954929;9599.32804703664;9677.661281855102;9683.370580912218;9703;9707.417554946725;4725.267583524559;5380.031594313061;5380.166074258496;5404.459554044643;5444.482774136451;4795.568398844121;4864;4872.4153101628035;4924;4942.28336891156;3903.785291808978;3949.328614135604;3984.880453586397;4009.1380353223612;4057.350823868167;1204.0848954794244;1206.879312068786;1211.1703483114095;1215.6474622359594;1241.2552468518816;1034.234666346898;1044.7805960748176;1057.281048886749;1066.4454483668449;1073.5652060915343;6047.909281360783;6050.909236361458;6052.243469566304;6062.666553339609;6295.811125666238;971.315222767961;981.3621146254849;982.1504398695077;1038.3562191441204;1041.385582506325;4051.918961620751;4069.4709687740406;4070.75575465473;4101.118259574206;4113.25961326964;10321.74195645115;10686.305390149615;10735.463226838627;10752.892471075189;10757.78484430307;10608.257421980541;10699.786004280026;10784.892151078546;10785;10788.892111078789;7588.392928565812;8170.060443049126;8204.425690201748;8312.584370781437;8327.750167494985;5876.882462350643;5974.671393073423;5975.073863551156;5999.100134979788;6075.2405949256345;9201.723948281295;9425.38734982224;9431.198348140484;9441.622335106518;9485.66800161991;8808.823823523622;8970.416922900251;8981.101889810967;9146.77133071652;9161.587728552098;6702.7654032110595;6880.380765731108;7218.566885986857;7628.1227658817725;7766.534007959314;7968.322692571196;7985.520868747662;7989.041315042232;8014.559199244098;8043.3565314773505;7183.389411900047;7273.0908636420445;7373.262673732798;7482.476226664081;7500.512466689648;7186.496945213994;7212.206657267801;7245.058142441449;7299.343059124704;7338.376238019828;6351.428371446592;6408.519361048034;6415;6538.738450461929;6606.207255129223;4897.436794768647;4924.384451943507;4949.406071271326;4993.825216117419;5039.571636410946;4926.531979461945;5225;5229.215617657382;5246.658967167122;5251.632385732962 06:40:29 INFO - PROCESS | 22007 | |4;prototype.html;351.4113859285696;354.9946750798738;358.24946736586855;363.2100182103923;366.7451121470579;6104.328523862371;6241.843953901149;6243.406876346746;6258.718357673904;6360.872782544347;6312.589681670688;6323.24121105468;6342.17551718276;6343.841403964903;6344.714487848047;4852.830150944717;4874.780634871421;4875.561199492045;4884.951150488503;4893.2170852663585;4623.052274283764;4720.716756994591;4793.784279707422;4883.145449546333;4889.951100489003;4734.739589322586;4739.573438390544;4757;4807.351007613962;4828.903421931577;4797.208460603996;4812.7834247458595;4819.036192761461;4821.566059054684;4844.878878028042;4221.155768846213;4231.8518851840345;4243.91512169758;4246.7876606169875;4257.489101307832;6037.667928263943;6051.394860513958;6069.666168360738;6075.967085595459;6078.939210607881;5340.732963351817;5567.916481252784;5591.916121258185;5604.467575580314;5610.046292130348;6613.2064152301555;6632.602043877383;6653.4677225821815;6656.467482601381;6662;4618.976905115453;4621.237495813187;4622.237330840408;4624.722516648978;4625.034360396851;6880.8967865482055;6959.060526828915;6970.198427180889;6970.825729356807;6971.372576468142;4696.365990591226;4703.435587729495;4704.341392205094;4711.481737008926;4712.575868171881;4614.930776038362;4771.379720636295;4771.809127634925;4774.236122220497;4784.043191361741;5469.808556700496;5526.751296191681;5559;5592.2318452366335;5622.493975542221;6650.3349665034075;6651.767188148391;6705;6708.228553716288;6718.865622687519;1567.2477210938814;1628.4544677532922;1652.0996057148643;1653.2312474699322;1655.6688662267595;1086.5056399338282;1094.43089593411;1104.2932523185168;1105.850710154135;1117.0337657925998;6373.426391624684;6400.615963042233;6449.451796597248;6455.774047908395;6467.51493637979;6847.828804279933;6848.246692863781;6860.416864566568;6862.519623626298;6866.34769696878;6447.903281450782;6452.870942581122;6458.967705161444;6463.838404039937;6508.121403610547;3665.395209790355;3709.27669104522;3711.9628803712158;3713.33160031197;3714.9226724250207;6923.065386172802;7101.218865924744;7101.857962840714;7111.040009598638;7116.857662846714;6917.584944903322;6936.895946560806;6948.861022779516;6965.756198533129;6975.162980442278;7080.575165490087;7083.539569927938;7088.858222835514;7092.716291348288;7103.502754807114;6843.828904277433;6847.657617119224;6862.759803406857;6865.965670171618;6869.175698916162;6654.534182607171;6712.194536655633;6828.760993365208;6837.794866154023;6879.759208427681;7217.927820721936;7241.746538871114;7243.275672432715;7249;7257.782266532013;4698.436187657503;4726.125666751662;4731.148393289241;4740.786664600032;4742.051589682008;6680.0647909291765;6853.588784672936;6947.478939079489;6952.582845029315;6974.0236366909685;6648.5346025777735;6652.933470665232;6664.866702666017;6764.0868482754195;6817.250102488623;6749.595024298558;6773.458123350219;6814.591124532544;6833.41915937131;6835.829104272433;6598.736050557924;6608.867822643617;6610.305917878553;6612.4710023198995;6634.767783127568;6602;6787.592744435152;6804.149481314836;6808.421284190899;6832.521723479309;6618.933810661832;6638.435732962752;6650.135482387259;6654.700538475683;6656.134702488645 06:40:29 INFO - PROCESS | 22007 | |5;yui.html;923.1698800968736;932.87406200163;938.7514605574585;956.4452617481861;958.3100167879129;15057.62355941102;15415.15216663083;15420.074795512277;15424.383024679013;15438.691226175484;14287.857121428782;14317.140971541688;14388;14392.71214575708;14424.134551926893;744.2371569141619;899.1413200393641;918.3984490158956;920.1718453391967;923.201430762389;905.5381755304776;907.4827348411408;912.3704643795793;912.9041450647686;913.808100298938;966.4104896013426;971.3394891473795;971.8104969530945;972.4457059476101;978.2223132609593;774.7520793346132;946.7159852044393;969.6024629901707;970.8058388322364;971.8056388722284;707.2291202589151;712.8609921065395;714.0503130835975;714.3891972363606;715.5170260074428;14682.70634587313;14722.779158312635;14741.778873316909;14771.33528991198;14824.258787060604;14339.856601434061;14540.345684444226;15169.317380717894;15219.162946037963;15271.160086195256;12091.818622720666;12123.454444549929;12153.5138594457;12467.251964882136;12519.874801251963;4123.835046598162;4141.213169497786;4155.854545090907;4242.830286788525;4304.332828411601;51148.48851511512;51242.23136652953;51566.226506602434;51604.22593661098;52154.47845521534;11067.335959842274;11143.275687080313;11169.609063682732;11178.608748693756;11293.943530282297;18170.818291817177;18237.361692340703;18265.086745662662;18268.26926922908;18718.53203669919;8680.262177714838;8723.738287851374;8774.210321071134;8789.956050219836;8838.469691818384;5129.538341549279;5165.948340516622;5259.605529585297;5299.708516031578;5324.893502129936;3364.1925937775245;3517.2437925846066;3532.240568277781;3532.8763493278125;3535.4520049392386;603;629.2386212682613;661.632793799446;684.4832151725416;686.1731613405934;722.4328901812053;725.9691238441426;814.3281792521194;818.2799136759613;823.7858156879255;9213.262938964866;9237.861432078524;9707.320487565943;9729.221662267002;9749.853752193723;649.8999771091866;782.4210084537401;803.1809145129224;816.9673213071529;825.7316372179066;4742.905141897143;4769.35613692154;4824.589909857631;4834.105690447279;4916.287138364989;66820.33179668238;67233.66383168053;67797;67955.66022169957;68199.65900170467;58288.708556457794;58403.123953140734;59241.26069914397;59451;59468;50886.49113508966;50941.745291273306;51077.489225107274;51596.22605660918;51716.48283517117;8614.267787237904;8886.777830554029;8895.688650897187;8981.910180898107;9474.763130921781;38693.613063869;38908.221835563694;38925.416118757676;41292.79353603213;41993.79003105087;45732.30770768579;45915.31127033164;51428;51941.48058519366;52705;11846.289222646668;11927.821082683593;11933.761324773282;12033.097517686383;12414.62756117318;12903.612891613267;12967.740645187232;13703.246321452416;14861.702765944838;14949.25253737287;10781.518812872924;13836.377363018488;13929.373178206803;14183.929080354532;14193.716125677634;13089.934550327187;13603.183808971493;13644.181349119084;13659.863401366256;13696.65758356049;13260.80108798388;13374;13618.057600271499;13676.452941882611;13684.52104176349;10413;10497;10520.15838732915;10876.891231087588;10910.509027093642;10396.220283478619;10487.580496780349;10657.89342106569;10751.569937202737;10820.350778953289 06:40:29 INFO - PROCESS | 22007 | __end_tp_report 06:40:29 INFO - PROCESS | 22007 | __start_cc_report 06:40:29 INFO - PROCESS | 22007 | _x_x_mozilla_cycle_collect,811 06:40:29 INFO - PROCESS | 22007 | __end_cc_report 06:40:29 INFO - PROCESS | 22007 | __startTimestamp1462801229730__endTimestamp 06:40:29 INFO - PROCESS | 22007 | 06:40:29 INFO - PROCESS | 22007 | ------- Summary: start ------- 06:40:29 INFO - PROCESS | 22007 | Number of tests: 6 06:40:29 INFO - PROCESS | 22007 | 06:40:29 INFO - PROCESS | 22007 | [#0] dojo.html Cycles:165 Average:5529.89 Median:5726.94 stddev:602.39 (10.5%) stddev-sans-first:578.91 06:40:29 INFO - PROCESS | 22007 | Values: 3326.4 3359.5 3367.7 3381.1 3403.6 5498.4 5512.1 5537.4 5550.5 5552.5 5538.1 5555.9 5559.1 5560.3 5599.3 4947.9 5043.8 5056.3 5067.3 5164.2 5003.6 5088.0 5090.5 5167.9 5168.3 5163.4 5166.4 5194.6 5208.4 5209.8 5183.7 5191.7 5205.6 5207.9 5236.8 4972.7 4987.7 5003.9 5099.3 5100.2 5476.9 5534.0 5538.1 5547.3 5549.4 5947.5 5963.9 5991.9 6007.2 6011.0 5872.1 5949.7 5994.6 6030.8 6056.2 5585.3 5631.3 5632.9 5635.9 5638.4 6105.3 6113.5 6127.6 6130.4 6131.8 5688.2 5799.9 5837.3 5895.2 5899.8 5941.7 5954.3 5961.2 5961.8 5965.2 5770.0 5933.3 5939.0 5944.8 5948.0 5812.3 5842.8 5862.7 5910.4 5920.9 4507.1 4510.0 4510.2 4510.8 4539.8 4002.9 4039.8 4055.1 4064.2 4087.8 5556.1 5580.6 5585.6 5595.1 5597.0 5927.4 5928.1 5928.4 5929.6 5930.4 5525.3 5601.0 5625.6 5667.7 5726.9 5134.4 5146.2 5148.3 5152.1 5169.1 6161.4 6167.9 6168.8 6175.3 6180.1 5814.2 5981.5 5994.9 6072.3 6074.9 6102.0 6103.7 6103.9 6108.1 6125.8 5776.0 5811.6 5812.3 5824.9 5830.6 5788.3 5908.4 5988.0 6006.8 6033.2 5774.8 5794.2 5794.3 5795.4 5812.8 5708.3 5715.8 5771.5 5780.4 5782.8 5686.8 5734.6 5745.5 5762.6 5763.4 5759.1 5781.6 5785.4 5789.2 5794.7 5610.8 5699.3 5703.9 5711.4 5753.1 06:40:29 INFO - PROCESS | 22007 | 06:40:29 INFO - PROCESS | 22007 | [#1] ext.html Cycles:180 Average:61378.82 Median:20965.90 stddev:116656.05 (556.4%) stddev-sans-first:116894.23 06:40:29 INFO - PROCESS | 22007 | Values: 662.7 672.5 680.8 722.0 740.9 33658.8 34591.8 34603.3 34626.3 34653.5 34334.8 40855.4 41315.6 41316.6 41474.6 8881.6 9010.2 9019.1 9028.5 9033.9 8337.7 8820.5 8962.2 8965.6 10810.7 10661.6 10751.2 10753.5 10754.1 10763.1 10702.9 10800.2 10800.9 10802.4 10812.0 10454.2 10578.2 10594.3 10594.6 10604.3 40394.4 40760.6 40787.2 45298.5 45313.8 3562.8 3580.8 3605.5 3722.9 3801.4 34444.0 34662.8 34892.5 34953.1 35093.0 4282.2 4365.5 4366.0 4367.3 4412.3 336815.0 339460.0 339565.0 340245.0 342106.0 61553.0 62922.4 62925.1 62932.1 63036.0 62188.0 63529.0 63569.7 63599.7 63643.0 19820.9 20078.8 20115.6 20164.2 20166.8 13726.3 15388.6 15443.2 15449.6 15472.8 20001.7 21338.6 21442.1 21499.9 21505.6 7375.3 7459.2 7655.5 7736.2 7774.9 1104.7 1160.2 1172.1 1210.1 1210.6 32843.5 33192.3 33423.5 33775.2 34492.0 1095.4 1123.8 1198.9 1202.2 1220.6 18093.1 18146.2 18550.6 18624.0 18629.6 512042.0 518875.0 519710.0 521107.0 521504.0 62965.4 63780.0 63780.0 63788.4 63822.4 1511.7 1557.4 1563.6 1612.9 1641.8 31498.7 33838.0 33953.0 34238.7 35278.6 51217.7 66754.3 69555.7 69559.0 69559.3 443796.0 444475.0 449470.0 449691.0 449958.0 42933.4 46154.8 47342.3 47584.8 47904.5 45198.8 45531.5 46023.3 46083.8 46361.5 40826.2 41318.4 42016.6 42243.0 43284.1 41629.6 41649.2 41736.8 41854.4 41862.4 41994.8 42228.0 42672.1 43011.0 43464.6 35725.5 36480.0 37501.6 37906.8 38130.4 28840.9 28847.9 29040.6 29321.3 29330.9 06:40:29 INFO - PROCESS | 22007 | 06:40:29 INFO - PROCESS | 22007 | [#2] jquery.html Cycles:180 Average:31419.77 Median:22711.88 stddev:93925.79 (413.6%) stddev-sans-first:94160.42 06:40:29 INFO - PROCESS | 22007 | Values: 414.8 418.8 419.5 429.8 435.2 17592.6 18550.7 18962.1 19114.5 19157.3 18482.5 18718.8 18774.6 19667.1 19680.6 5654.5 5763.9 5812.7 5822.2 5832.9 5649.7 5691.1 5779.9 5801.9 5816.9 5673.8 5760.7 5766.4 5769.5 5813.0 5594.9 5670.8 5722.0 5725.4 5760.2 5086.1 5130.5 5132.1 5143.8 5203.6 21342.9 22284.0 22703.5 22720.2 22857.3 2359.2 2655.5 2682.6 2700.5 2777.6 10121.7 10510.1 10563.0 11630.0 14360.6 2001.1 2028.7 2095.2 2118.2 2129.1 83754.6 84560.6 86735.6 86797.0 87067.6 10467.8 10573.8 10632.9 10641.9 10666.8 15427.9 15433.2 15471.4 15511.0 15534.1 8678.1 8756.2 8806.7 8818.5 9052.1 8784.6 8859.1 8896.2 8942.4 9087.7 4668.9 4672.7 4724.2 4788.4 4820.7 1893.0 1947.6 1990.0 2010.8 2011.3 980.5 1033.2 1060.4 1101.6 1135.9 17913.5 18284.4 18624.5 18711.5 18978.4 1029.6 1058.8 1078.4 1094.3 1106.6 10282.7 10502.6 10670.1 10680.0 10970.7 540925.0 573478.0 578341.0 581323.0 581990.0 91702.0 95079.0 95146.5 95676.0 96734.5 1100.7 1111.5 1112.4 1113.5 1140.9 16575.6 16575.9 16687.3 16911.8 17230.9 38866.6 39008.6 39326.2 41048.0 42027.0 54889.5 55510.0 56528.4 57070.3 58408.4 8657.2 8700.3 8723.2 8772.9 8837.8 9827.6 13326.3 13341.9 13398.2 13864.7 11734.7 11736.8 11838.3 11922.9 12009.6 11341.0 11682.2 11885.5 12088.9 12153.6 12029.9 12146.0 12203.6 12214.6 12617.1 8624.4 8644.8 8749.9 8861.0 8901.6 11882.8 11951.9 12116.9 12143.6 12166.6 06:40:29 INFO - PROCESS | 22007 | 06:40:29 INFO - PROCESS | 22007 | [#3] mootools.html Cycles:180 Average:5653.72 Median:4945.84 stddev:3071.78 (62.1%) stddev-sans-first:3063.93 06:40:29 INFO - PROCESS | 22007 | Values: 1422.2 1580.5 1582.0 1849.0 1968.5 8304.7 8468.4 8481.2 8497.3 8498.3 8375.2 8547.6 8548.7 8555.4 8557.2 2101.9 2396.7 2446.9 2474.5 2479.9 2434.3 2479.2 2492.0 2493.5 2493.7 2381.6 2410.9 2414.4 2414.9 2415.7 2116.4 2350.1 2390.1 2393.1 2396.1 2329.1 2336.8 2338.0 2340.6 2420.5 8382.1 8480.7 8488.7 8491.5 8499.0 5108.4 5226.8 5263.1 5272.4 5298.4 3533.2 3644.9 3656.2 3675.5 3729.0 1235.4 1250.9 1261.0 1341.9 2113.6 11825.8 11862.3 11947.1 11948.3 11958.8 4452.7 4661.1 4661.4 4668.3 4684.7 9599.3 9677.7 9683.4 9703.0 9707.4 4725.3 5380.0 5380.2 5404.5 5444.5 4795.6 4864.0 4872.4 4924.0 4942.3 3903.8 3949.3 3984.9 4009.1 4057.4 1204.1 1206.9 1211.2 1215.6 1241.3 1034.2 1044.8 1057.3 1066.4 1073.6 6047.9 6050.9 6052.2 6062.7 6295.8 971.3 981.4 982.2 1038.4 1041.4 4051.9 4069.5 4070.8 4101.1 4113.3 10321.7 10686.3 10735.5 10752.9 10757.8 10608.3 10699.8 10784.9 10785.0 10788.9 7588.4 8170.1 8204.4 8312.6 8327.8 5876.9 5974.7 5975.1 5999.1 6075.2 9201.7 9425.4 9431.2 9441.6 9485.7 8808.8 8970.4 8981.1 9146.8 9161.6 6702.8 6880.4 7218.6 7628.1 7766.5 7968.3 7985.5 7989.0 8014.6 8043.4 7183.4 7273.1 7373.3 7482.5 7500.5 7186.5 7212.2 7245.1 7299.3 7338.4 6351.4 6408.5 6415.0 6538.7 6606.2 4897.4 4924.4 4949.4 4993.8 5039.6 4926.5 5225.0 5229.2 5246.7 5251.6 06:40:29 INFO - PROCESS | 22007 | 06:40:29 INFO - PROCESS | 22007 | [#4] prototype.html Cycles:180 Average:5590.61 Median:6387.02 stddev:1693.49 (26.5%) stddev-sans-first:1651.95 06:40:29 INFO - PROCESS | 22007 | Values: 351.4 355.0 358.2 363.2 366.7 6104.3 6241.8 6243.4 6258.7 6360.9 6312.6 6323.2 6342.2 6343.8 6344.7 4852.8 4874.8 4875.6 4885.0 4893.2 4623.1 4720.7 4793.8 4883.1 4890.0 4734.7 4739.6 4757.0 4807.4 4828.9 4797.2 4812.8 4819.0 4821.6 4844.9 4221.2 4231.9 4243.9 4246.8 4257.5 6037.7 6051.4 6069.7 6076.0 6078.9 5340.7 5567.9 5591.9 5604.5 5610.0 6613.2 6632.6 6653.5 6656.5 6662.0 4619.0 4621.2 4622.2 4624.7 4625.0 6880.9 6959.1 6970.2 6970.8 6971.4 4696.4 4703.4 4704.3 4711.5 4712.6 4614.9 4771.4 4771.8 4774.2 4784.0 5469.8 5526.8 5559.0 5592.2 5622.5 6650.3 6651.8 6705.0 6708.2 6718.9 1567.2 1628.5 1652.1 1653.2 1655.7 1086.5 1094.4 1104.3 1105.9 1117.0 6373.4 6400.6 6449.5 6455.8 6467.5 6847.8 6848.2 6860.4 6862.5 6866.3 6447.9 6452.9 6459.0 6463.8 6508.1 3665.4 3709.3 3712.0 3713.3 3714.9 6923.1 7101.2 7101.9 7111.0 7116.9 6917.6 6936.9 6948.9 6965.8 6975.2 7080.6 7083.5 7088.9 7092.7 7103.5 6843.8 6847.7 6862.8 6866.0 6869.2 6654.5 6712.2 6828.8 6837.8 6879.8 7217.9 7241.7 7243.3 7249.0 7257.8 4698.4 4726.1 4731.1 4740.8 4742.1 6680.1 6853.6 6947.5 6952.6 6974.0 6648.5 6652.9 6664.9 6764.1 6817.3 6749.6 6773.5 6814.6 6833.4 6835.8 6598.7 6608.9 6610.3 6612.5 6634.8 6602.0 6787.6 6804.1 6808.4 6832.5 6618.9 6638.4 6650.1 6654.7 6656.1 06:40:29 INFO - PROCESS | 22007 | 06:40:29 INFO - PROCESS | 22007 | [#5] yui.html Cycles:180 Average:15560.76 Median:4875.20 stddev:18013.63 (369.5%) stddev-sans-first:18030.63 06:40:29 INFO - PROCESS | 22007 | Values: 923.2 932.9 938.8 956.4 958.3 15057.6 15415.2 15420.1 15424.4 15438.7 14287.9 14317.1 14388.0 14392.7 14424.1 744.2 899.1 918.4 920.2 923.2 905.5 907.5 912.4 912.9 913.8 966.4 971.3 971.8 972.4 978.2 774.8 946.7 969.6 970.8 971.8 707.2 712.9 714.1 714.4 715.5 14682.7 14722.8 14741.8 14771.3 14824.3 14339.9 14540.3 15169.3 15219.2 15271.2 12091.8 12123.5 12153.5 12467.3 12519.9 4123.8 4141.2 4155.9 4242.8 4304.3 51148.5 51242.2 51566.2 51604.2 52154.5 11067.3 11143.3 11169.6 11178.6 11293.9 18170.8 18237.4 18265.1 18268.3 18718.5 8680.3 8723.7 8774.2 8790.0 8838.5 5129.5 5165.9 5259.6 5299.7 5324.9 3364.2 3517.2 3532.2 3532.9 3535.5 603.0 629.2 661.6 684.5 686.2 722.4 726.0 814.3 818.3 823.8 9213.3 9237.9 9707.3 9729.2 9749.9 649.9 782.4 803.2 817.0 825.7 4742.9 4769.4 4824.6 4834.1 4916.3 66820.3 67233.7 67797.0 67955.7 68199.7 58288.7 58403.1 59241.3 59451.0 59468.0 50886.5 50941.7 51077.5 51596.2 51716.5 8614.3 8886.8 8895.7 8981.9 9474.8 38693.6 38908.2 38925.4 41292.8 41993.8 45732.3 45915.3 51428.0 51941.5 52705.0 11846.3 11927.8 11933.8 12033.1 12414.6 12903.6 12967.7 13703.2 14861.7 14949.3 10781.5 13836.4 13929.4 14183.9 14193.7 13089.9 13603.2 13644.2 13659.9 13696.7 13260.8 13374.0 13618.1 13676.5 13684.5 10413.0 10497.0 10520.2 10876.9 10910.5 10396.2 10487.6 10657.9 10751.6 10820.4 06:40:29 INFO - PROCESS | 22007 | -------- Summary: end -------- 06:40:29 INFO - PROCESS | 22007 | 06:40:30 INFO - TEST-INFO | 22007: exit 0 06:40:30 INFO - TEST-OK | dromaeo_css | took 1112332ms 06:40:30 INFO - TEST-START | kraken 06:40:30 INFO - operating with platform_type : linux_ 06:40:30 INFO - Initialising browser for kraken test... 06:40:30 INFO - TEST-INFO | started process 22197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7xwmdI/profile http://localhost:50650/getInfo.html) 06:40:34 INFO - PROCESS | 22197 | __metrics Screen width/height:1600/1200 06:40:34 INFO - PROCESS | 22197 | colorDepth:24 06:40:34 INFO - PROCESS | 22197 | Browser inner width/height: 1024/697 06:40:34 INFO - PROCESS | 22197 | __metrics 06:40:35 ERROR - PROCESS | 22197 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:40:36 INFO - TEST-INFO | 22197: exit 0 06:40:36 INFO - Browser initialized. 06:40:36 INFO - Running cycle 1/1 for kraken test... 06:40:36 INFO - TEST-INFO | started process 22288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7xwmdI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:48 INFO - PROCESS | 22288 | RSS: Main: 142303232 06:40:48 INFO - PROCESS | 22288 | 06:40:50 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50650/tests/kraken/driver.html?testName=audio-beat-detection) 06:40:51 INFO - PROCESS | 22288 | RSS: Main: 196820992 06:40:51 INFO - PROCESS | 22288 | 06:40:54 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50650/tests/kraken/driver.html?testName=audio-dft) 06:40:54 INFO - PROCESS | 22288 | RSS: Main: 182272000 06:40:54 INFO - PROCESS | 22288 | 06:40:57 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50650/tests/kraken/driver.html?testName=audio-fft) 06:40:58 INFO - PROCESS | 22288 | RSS: Main: 272347136 06:40:58 INFO - PROCESS | 22288 | 06:41:00 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50650/tests/kraken/driver.html?testName=audio-oscillator) 06:41:00 INFO - PROCESS | 22288 | RSS: Main: 178688000 06:41:00 INFO - PROCESS | 22288 | 06:41:02 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50650/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:03 INFO - PROCESS | 22288 | RSS: Main: 177209344 06:41:03 INFO - PROCESS | 22288 | 06:41:06 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50650/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:07 INFO - PROCESS | 22288 | RSS: Main: 212336640 06:41:07 INFO - PROCESS | 22288 | 06:41:10 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50650/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:10 INFO - PROCESS | 22288 | RSS: Main: 213442560 06:41:11 INFO - PROCESS | 22288 | 06:41:13 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50650/tests/kraken/driver.html?testName=json-parse-financial) 06:41:14 INFO - PROCESS | 22288 | RSS: Main: 213078016 06:41:14 INFO - PROCESS | 22288 | 06:41:15 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50650/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:16 INFO - PROCESS | 22288 | RSS: Main: 192745472 06:41:16 INFO - PROCESS | 22288 | 06:41:18 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50650/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:41:18 INFO - PROCESS | 22288 | RSS: Main: 196816896 06:41:18 INFO - PROCESS | 22288 | 06:41:20 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50650/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:41:21 INFO - PROCESS | 22288 | RSS: Main: 209412096 06:41:21 INFO - PROCESS | 22288 | 06:41:23 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:24 INFO - PROCESS | 22288 | RSS: Main: 214999040 06:41:24 INFO - PROCESS | 22288 | 06:41:26 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:27 INFO - PROCESS | 22288 | RSS: Main: 209575936 06:41:27 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | Cycle 1(1): loaded http://localhost:50650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50650/tests/kraken/driver.html?testName=ai-astar) 06:41:29 INFO - PROCESS | 22288 | RSS: Main: 273121280 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | __start_tp_report 06:41:29 INFO - PROCESS | 22288 | _x_x_mozilla_page_load 06:41:29 INFO - PROCESS | 22288 | _x_x_mozilla_page_load_details 06:41:29 INFO - PROCESS | 22288 | |i|pagename|runs| 06:41:29 INFO - PROCESS | 22288 | |0;ai-astar;113;110;110;110;111;111;107;112;110;110 06:41:29 INFO - PROCESS | 22288 | |1;audio-beat-detection;157;126;160;184;126;159;154;134;195;125 06:41:29 INFO - PROCESS | 22288 | |2;audio-dft;162;161;162;162;161;161;161;160;159;161 06:41:29 INFO - PROCESS | 22288 | |3;audio-fft;75;77;73;172;76;76;73;76;156;77 06:41:29 INFO - PROCESS | 22288 | |4;audio-oscillator;92;92;147;92;93;93;153;91;94;153 06:41:29 INFO - PROCESS | 22288 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 06:41:29 INFO - PROCESS | 22288 | |6;imaging-darkroom;145;146;145;145;145;146;146;145;146;145 06:41:29 INFO - PROCESS | 22288 | |7;imaging-desaturate;94;94;95;94;94;95;95;95;94;94 06:41:29 INFO - PROCESS | 22288 | |8;json-parse-financial;54;55;54;54;54;55;53;76;52;53 06:41:29 INFO - PROCESS | 22288 | |9;json-stringify-tinderbox;58;59;57;57;58;58;57;57;58;57 06:41:29 INFO - PROCESS | 22288 | |10;stanford-crypto-aes;72;72;70;72;73;73;73;73;73;73 06:41:29 INFO - PROCESS | 22288 | |11;stanford-crypto-ccm;112;119;117;113;114;115;112;114;132;125 06:41:29 INFO - PROCESS | 22288 | |12;stanford-crypto-pbkdf2;159;158;162;159;161;164;157;158;154;157 06:41:29 INFO - PROCESS | 22288 | |13;stanford-crypto-sha256-iterative;69;69;66;68;66;65;65;66;66;65 06:41:29 INFO - PROCESS | 22288 | __end_tp_report 06:41:29 INFO - PROCESS | 22288 | __start_cc_report 06:41:29 INFO - PROCESS | 22288 | _x_x_mozilla_cycle_collect,1628 06:41:29 INFO - PROCESS | 22288 | __end_cc_report 06:41:29 INFO - PROCESS | 22288 | __startTimestamp1462801289499__endTimestamp 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | ------- Summary: start ------- 06:41:29 INFO - PROCESS | 22288 | Number of tests: 14 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:1.58 (1.4%) stddev-sans-first:1.36 06:41:29 INFO - PROCESS | 22288 | Values: 113.0 110.0 110.0 110.0 111.0 111.0 107.0 112.0 110.0 110.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:158.00 stddev:24.54 (15.5%) stddev-sans-first:25.96 06:41:29 INFO - PROCESS | 22288 | Values: 157.0 126.0 160.0 184.0 126.0 159.0 154.0 134.0 195.0 125.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 06:41:29 INFO - PROCESS | 22288 | Values: 162.0 161.0 162.0 162.0 161.0 161.0 161.0 160.0 159.0 161.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:37.58 (49.5%) stddev-sans-first:39.29 06:41:29 INFO - PROCESS | 22288 | Values: 75.0 77.0 73.0 172.0 76.0 76.0 73.0 76.0 156.0 77.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:28.35 (30.8%) stddev-sans-first:29.31 06:41:29 INFO - PROCESS | 22288 | Values: 92.0 92.0 147.0 92.0 93.0 93.0 153.0 91.0 94.0 153.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:41:29 INFO - PROCESS | 22288 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:41:29 INFO - PROCESS | 22288 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:41:29 INFO - PROCESS | 22288 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:7.09 (13.1%) stddev-sans-first:7.48 06:41:29 INFO - PROCESS | 22288 | Values: 54.0 55.0 54.0 54.0 54.0 55.0 53.0 76.0 52.0 53.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 06:41:29 INFO - PROCESS | 22288 | Values: 58.0 59.0 57.0 57.0 58.0 58.0 57.0 57.0 58.0 57.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:73.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 06:41:29 INFO - PROCESS | 22288 | Values: 72.0 72.0 70.0 72.0 73.0 73.0 73.0 73.0 73.0 73.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:116.00 stddev:6.50 (5.6%) stddev-sans-first:6.60 06:41:29 INFO - PROCESS | 22288 | Values: 112.0 119.0 117.0 113.0 114.0 115.0 112.0 114.0 132.0 125.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.00 stddev:2.85 (1.8%) stddev-sans-first:3.02 06:41:29 INFO - PROCESS | 22288 | Values: 159.0 158.0 162.0 159.0 161.0 164.0 157.0 158.0 154.0 157.0 06:41:29 INFO - PROCESS | 22288 | 06:41:29 INFO - PROCESS | 22288 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:1.58 (2.4%) stddev-sans-first:1.39 06:41:29 INFO - PROCESS | 22288 | Values: 69.0 69.0 66.0 68.0 66.0 65.0 65.0 66.0 66.0 65.0 06:41:29 INFO - PROCESS | 22288 | -------- Summary: end -------- 06:41:29 INFO - PROCESS | 22288 | 06:41:30 INFO - TEST-INFO | 22288: exit 0 06:41:30 INFO - TEST-OK | kraken | took 59986ms 06:41:30 INFO - SUITE-END | took 1172s 06:41:30 INFO - Completed test suite (00:19:32) 06:41:30 INFO - javascript benchmark 06:41:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3326.3679900818843, 3359.512870633757, 3367.6800703933127, 3381.0702056934356, 3403.6256011838695, 5498.422665620113, 5512.062949298619, 5537.418571050042, 5550.528205102566, 5552.472515111068, 5538.086215774392, 5555.916661250085, 5559.122285759795, 5560.304961879765, 5599.32808063032, 4947.925781113268, 5043.773030213631, 5056.266841308017, 5067.265246539249, 5164.1995490699, 5003.599712023048, 5088.0, 5090.516400941905, 5167.9224811627855, 5168.302279192318, 5163.432022477525, 5166.354205724285, 5194.58443324535, 5208.427073021964, 5209.791608335662, 5183.688978661255, 5191.714455704935, 5205.635605507616, 5207.9479205207845, 5236.842894713165, 4972.701637901701, 4987.725675087869, 5003.874903127415, 5099.311592934943, 5100.209467532539, 5476.863078423032, 5534.0, 5538.113901775737, 5547.278853748987, 5549.417311182308, 5947.524198064145, 5963.940360596382, 5991.910121348184, 6007.189029481052, 6011.0, 5872.148538461942, 5949.6727679977585, 5994.55040871932, 6030.758769649209, 6056.152138700585, 5585.3297604287745, 5631.267935168402, 5632.859178520488, 5635.915461268084, 5638.351589567212, 6105.26736791579, 6113.510919126459, 6127.571070025056, 6130.417610327012, 6131.767124586389, 5688.203651488795, 5799.9130013049835, 5837.270341207349, 5895.233619629421, 5899.764009439575, 5941.673207973517, 5954.285485741739, 5961.165436838846, 5961.821145365646, 5965.194698715618, 5769.971150144306, 5933.258342707161, 5939.0, 5944.762209511571, 5948.018576934844, 5812.331581868055, 5842.795502157404, 5862.677552734641, 5910.408959104141, 5920.911186332209, 4507.076049409863, 4510.030343476168, 4510.21071312519, 4510.797014134372, 4539.818407263672, 4002.8999275017777, 4039.7980100994832, 4055.128147448254, 4064.227796718614, 4087.7751723655483, 5556.111022236423, 5580.553555715533, 5585.553155747531, 5595.104783234663, 5597.048501754712, 5927.407259274038, 5928.081147422156, 5928.3775203603, 5929.644221346733, 5930.377310382348, 5525.336959564797, 5601.0, 5625.634333768292, 5667.716614169275, 5726.942730572641, 5134.383873935151, 5146.176611742103, 5148.330717006766, 5152.124138896396, 5169.147090730063, 6161.383861613893, 6167.938320616737, 6168.814935551941, 6175.2589689237575, 6180.103884936659, 5814.186013957965, 5981.5214782817275, 5994.910076348945, 6072.271327440735, 6074.90887636677, 6102.0, 6103.725332359965, 6103.908441373472, 6108.08378743192, 6125.84685382869, 5776.0, 5811.622244554091, 5812.3025236971835, 5824.854378640398, 5830.591858569859, 5788.305403351625, 5908.350081490947, 5988.0, 6006.759729610942, 6033.18551995475, 5774.797882074107, 5794.217780599565, 5794.304683438015, 5795.39148389413, 5812.7674893003805, 5708.286464191976, 5715.828525144252, 5771.538276937751, 5780.421957804186, 5782.797602083907, 5686.77252909879, 5734.627249228787, 5745.454181852718, 5762.567807414544, 5763.394843541368, 5759.078547432391, 5781.5663825214115, 5785.392533783892, 5789.247397838254, 5794.652320860761, 5610.831675049755, 5699.2590963174525, 5703.942960570341, 5711.371749107512, 5753.108268218432], "value": 5491.337516570245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.7448432353542, 672.5292295393219, 680.7583307925686, 721.9602921839297, 740.8999785029023, 33658.83170584147, 34591.82704086476, 34603.30793384134, 34626.30747385054, 34653.48019779706, 34334.8283258584, 40855.38716919249, 41315.58684413155, 41316.58683413165, 41474.58525414745, 8881.60032798524, 9010.18908298253, 9019.098090190993, 9028.458292502439, 9033.909660903373, 8337.666493340259, 8820.514871682055, 8962.193402593764, 8965.596548155316, 10810.72973175669, 10661.573537058508, 10751.247412681116, 10753.51609177589, 10754.139668826476, 10763.13894888411, 10702.892971070307, 10800.189985751022, 10800.891991080067, 10802.405867677275, 10812.026917577416, 10454.163666906628, 10578.153747700166, 10594.25840191187, 10594.576216951313, 10604.257701960865, 40394.39408408876, 40760.592394075975, 40787.18425631471, 45298.54701453009, 45313.77343113296, 3562.8040457774814, 3580.838862251205, 3605.5312809334882, 3722.8696995605023, 3801.3727734923705, 34444.0, 34662.82668586666, 34892.47661285083, 34953.12617184565, 35093.0, 4282.164977829325, 4365.454318210223, 4366.039471316305, 4367.301231802928, 4412.294032954712, 336815.0, 339460.0, 339565.0, 340245.0, 342106.0, 61553.0, 62922.37077629257, 62925.056124158174, 62932.05601915975, 63036.0, 62188.0, 63529.0, 63569.682151588946, 63599.68200159062, 63643.0, 19820.90089549543, 20078.799212007692, 20115.597688046157, 20164.193432262546, 20166.798332016493, 13726.313684315744, 15388.615284617974, 15443.227838608025, 15449.613759656098, 15472.845271547365, 20001.699974500396, 21338.57322853534, 21442.142314307253, 21499.892500537397, 21505.569888602142, 7375.262473752582, 7459.216782237895, 7655.46411751172, 7736.226377362219, 7774.92225077742, 1104.745908441063, 1160.1762748448696, 1172.0623501199177, 1210.056156198167, 1210.5944508589546, 32843.50734738981, 33192.336153276796, 33423.498647520304, 33775.15562110967, 34492.0, 1095.3592148593161, 1123.8089524780808, 1198.8801119887942, 1202.1825158892038, 1220.6155061155707, 18093.095345232687, 18146.183421746053, 18550.628987420445, 18624.0, 18629.627407451775, 512042.0, 518875.0, 519710.0, 521107.0, 521504.0, 62965.37034629687, 63780.0, 63780.0, 63788.362116378245, 63822.36177638257, 1511.7430036893754, 1557.3770491803143, 1563.6090977255685, 1612.8790340724493, 1641.8358164183487, 31498.68501315049, 33838.0, 33953.0, 34238.65761342454, 35278.64721352753, 51217.743911281694, 66754.3324566748, 69555.65222174059, 69559.0, 69559.30440695529, 443796.0, 444475.0, 449470.0, 449691.0, 449958.0, 42933.355999659405, 46154.76922615366, 47342.28986565136, 47584.76207619078, 47904.5209547914, 45198.77400612976, 45531.54468455406, 46023.30965035594, 46083.76958115188, 46361.536384637075, 40826.1834763309, 41318.38022429606, 42016.57983420249, 42243.0, 43284.13431731411, 41629.58370416378, 41649.16701665889, 41736.79131604323, 41854.37218441665, 41862.372064419666, 41994.790026049675, 42228.0, 42672.14655706807, 43011.0, 43464.565354347316, 35725.46411803773, 36480.0, 37501.62498374981, 37906.81046594749, 38130.42804357882, 28840.855795720887, 28847.85576072106, 29040.56439153372, 29321.266968325963, 29330.853345733136], "value": 21610.171040859972, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.77394819823195, 418.76758399088493, 419.5385076415942, 429.7894031924356, 435.2209544914603, 17592.560185995324, 18550.721739173907, 18962.146703398346, 19114.522136946583, 19157.329493467732, 18482.537936551595, 18718.812811871878, 18774.62450750984, 19667.114979825907, 19680.606387872234, 5654.547636189116, 5763.942360576403, 5812.709364531777, 5822.214001109859, 5832.854178645546, 5649.661020338773, 5691.146328050784, 5779.884402311951, 5801.9129713054335, 5816.883662326751, 5673.773049078032, 5760.740766665489, 5766.394528574502, 5769.509591684712, 5813.040848260032, 5594.888102237953, 5670.801521946753, 5722.0, 5725.370209276997, 5760.164776107462, 5086.109930762102, 5130.538251557377, 5132.076226279269, 5143.7685304161405, 5203.60972927032, 21342.89328553347, 22284.0, 22703.545929081327, 22720.204792832337, 22857.31428057161, 2359.2332491940188, 2655.49545586338, 2682.557378032622, 2700.527407703664, 2777.6250206222103, 10121.69634910954, 10510.054095131398, 10563.0, 11630.011449026842, 14360.64098397538, 2001.148037449777, 2028.6956956456502, 2095.182878677317, 2118.205672872673, 2129.084493667722, 83754.58122709347, 84560.57719711424, 86735.56632216861, 86797.0, 87067.56466217629, 10467.84298235527, 10573.788524229472, 10632.893671063344, 10641.946790266154, 10666.839997400046, 15427.922860385626, 15433.151176685391, 15471.381144754308, 15511.0, 15534.1456219909, 8678.132186781271, 8756.168164024408, 8806.691765788166, 8818.51498167594, 9052.094790520896, 8784.560771961376, 8859.11408859109, 8896.199342059117, 8942.37403381757, 9087.681931132378, 4668.929966050512, 4672.672912896064, 4724.173269677793, 4788.449328327218, 4820.68665536739, 1892.9621407571772, 1947.5707585877703, 1990.0, 2010.7587089549347, 2011.3262057210998, 980.5195454227377, 1033.188946676855, 1060.4432672846817, 1101.5869049106584, 1135.9488823002985, 17913.462596122135, 18284.360047398277, 18624.534386640444, 18711.532211694543, 18978.43064708061, 1029.562435964712, 1058.8464672622426, 1078.428432930548, 1094.3215206571977, 1106.6016234155697, 10282.742931426774, 10502.632407865687, 10670.115352598388, 10680.0, 10970.670879873616, 540925.0, 573478.0, 578341.0, 581323.0, 581990.0, 91702.0, 95079.0, 95146.52426737822, 95676.0, 96734.5163274179, 1100.7193165742844, 1111.4664960818852, 1112.3937454087543, 1113.465536542448, 1140.931544107356, 16575.585610359838, 16575.91712041432, 16687.332506699597, 16911.830881691025, 17230.913845430692, 38866.61133388743, 39008.60991390163, 39326.213475730896, 41048.0, 42027.0, 54889.451105488435, 55510.0, 56528.434715652314, 57070.287891363325, 58408.4159158403, 8657.22085012352, 8700.347473939606, 8723.171298726611, 8772.868406974028, 8837.823243534966, 9827.55775990068, 13326.33368331599, 13341.933290333487, 13398.196108233537, 13864.653383665489, 11734.706632333919, 11736.823947640964, 11838.28970261787, 11922.880771192524, 12009.63971080869, 11341.0, 11682.18926066461, 11885.465154067915, 12088.879111208775, 12153.574624888086, 12029.939850301043, 12146.0, 12203.572874949334, 12214.57248996281, 12617.116801823784, 8624.353173511887, 8644.783880402789, 8749.868751968854, 8861.0, 8901.554922253732, 11882.76234475323, 11951.880481195076, 12116.878831211576, 12143.574974875837, 12166.635000949986], "value": 9443.571255499199, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.1751384197166, 1580.5416429235522, 1581.965986733829, 1848.953776155596, 1968.5275533871875, 8304.709335173271, 8468.407211495198, 8481.151884811516, 8497.277731392824, 8498.277646400064, 8375.204355586226, 8547.615357308921, 8548.74353769388, 8555.443896146746, 8557.22984931356, 2101.8949052547387, 2396.7363590005084, 2446.9021239150456, 2474.4679893822827, 2479.9008039678392, 2434.306222726523, 2479.2066538707622, 2491.9750802491926, 2493.5262300163004, 2493.6633554470186, 2381.6189409694452, 2410.927672169838, 2414.4326083370393, 2414.8671823049726, 2415.6738840256517, 2116.375669177596, 2350.0717216699395, 2390.115657206827, 2393.1384701507445, 2396.065534441569, 2329.149860300995, 2336.778006089419, 2338.018032426385, 2340.6372012338115, 2420.491696743686, 8382.119877412844, 8480.66077356905, 8488.66045358185, 8491.532965686885, 8499.0, 5108.361454818148, 5226.764795584208, 5263.131583288753, 5272.4200337963175, 5298.443663415324, 3533.222691007974, 3644.8542058317635, 3656.232191239843, 3675.5405574303213, 3729.0490924814, 1235.4440501774147, 1250.8561515425752, 1260.9810852837215, 1341.8926485881204, 2113.6301147299314, 11825.822612660817, 11862.347570883598, 11947.103967202494, 11948.342841143734, 11958.820617690742, 4452.710573812692, 4661.067786442725, 4661.370714953506, 4668.253079507263, 4684.672072954929, 9599.32804703664, 9677.661281855102, 9683.370580912218, 9703.0, 9707.417554946725, 4725.267583524559, 5380.031594313061, 5380.166074258496, 5404.459554044643, 5444.482774136451, 4795.568398844121, 4864.0, 4872.4153101628035, 4924.0, 4942.28336891156, 3903.785291808978, 3949.328614135604, 3984.880453586397, 4009.1380353223612, 4057.350823868167, 1204.0848954794244, 1206.879312068786, 1211.1703483114095, 1215.6474622359594, 1241.2552468518816, 1034.234666346898, 1044.7805960748176, 1057.281048886749, 1066.4454483668449, 1073.5652060915343, 6047.909281360783, 6050.909236361458, 6052.243469566304, 6062.666553339609, 6295.811125666238, 971.315222767961, 981.3621146254849, 982.1504398695077, 1038.3562191441204, 1041.385582506325, 4051.918961620751, 4069.4709687740406, 4070.75575465473, 4101.118259574206, 4113.25961326964, 10321.74195645115, 10686.305390149615, 10735.463226838627, 10752.892471075189, 10757.78484430307, 10608.257421980541, 10699.786004280026, 10784.892151078546, 10785.0, 10788.892111078789, 7588.392928565812, 8170.060443049126, 8204.425690201748, 8312.584370781437, 8327.750167494985, 5876.882462350643, 5974.671393073423, 5975.073863551156, 5999.100134979788, 6075.2405949256345, 9201.723948281295, 9425.38734982224, 9431.198348140484, 9441.622335106518, 9485.66800161991, 8808.823823523622, 8970.416922900251, 8981.101889810967, 9146.77133071652, 9161.587728552098, 6702.7654032110595, 6880.380765731108, 7218.566885986857, 7628.1227658817725, 7766.534007959314, 7968.322692571196, 7985.520868747662, 7989.041315042232, 8014.559199244098, 8043.3565314773505, 7183.389411900047, 7273.0908636420445, 7373.262673732798, 7482.476226664081, 7500.512466689648, 7186.496945213994, 7212.206657267801, 7245.058142441449, 7299.343059124704, 7338.376238019828, 6351.428371446592, 6408.519361048034, 6415.0, 6538.738450461929, 6606.207255129223, 4897.436794768647, 4924.384451943507, 4949.406071271326, 4993.825216117419, 5039.571636410946, 4926.531979461945, 5225.0, 5229.215617657382, 5246.658967167122, 5251.632385732962], "value": 4631.852300969974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4113859285696, 354.9946750798738, 358.24946736586855, 363.2100182103923, 366.7451121470579, 6104.328523862371, 6241.843953901149, 6243.406876346746, 6258.718357673904, 6360.872782544347, 6312.589681670688, 6323.24121105468, 6342.17551718276, 6343.841403964903, 6344.714487848047, 4852.830150944717, 4874.780634871421, 4875.561199492045, 4884.951150488503, 4893.2170852663585, 4623.052274283764, 4720.716756994591, 4793.784279707422, 4883.145449546333, 4889.951100489003, 4734.739589322586, 4739.573438390544, 4757.0, 4807.351007613962, 4828.903421931577, 4797.208460603996, 4812.7834247458595, 4819.036192761461, 4821.566059054684, 4844.878878028042, 4221.155768846213, 4231.8518851840345, 4243.91512169758, 4246.7876606169875, 4257.489101307832, 6037.667928263943, 6051.394860513958, 6069.666168360738, 6075.967085595459, 6078.939210607881, 5340.732963351817, 5567.916481252784, 5591.916121258185, 5604.467575580314, 5610.046292130348, 6613.2064152301555, 6632.602043877383, 6653.4677225821815, 6656.467482601381, 6662.0, 4618.976905115453, 4621.237495813187, 4622.237330840408, 4624.722516648978, 4625.034360396851, 6880.8967865482055, 6959.060526828915, 6970.198427180889, 6970.825729356807, 6971.372576468142, 4696.365990591226, 4703.435587729495, 4704.341392205094, 4711.481737008926, 4712.575868171881, 4614.930776038362, 4771.379720636295, 4771.809127634925, 4774.236122220497, 4784.043191361741, 5469.808556700496, 5526.751296191681, 5559.0, 5592.2318452366335, 5622.493975542221, 6650.3349665034075, 6651.767188148391, 6705.0, 6708.228553716288, 6718.865622687519, 1567.2477210938814, 1628.4544677532922, 1652.0996057148643, 1653.2312474699322, 1655.6688662267595, 1086.5056399338282, 1094.43089593411, 1104.2932523185168, 1105.850710154135, 1117.0337657925998, 6373.426391624684, 6400.615963042233, 6449.451796597248, 6455.774047908395, 6467.51493637979, 6847.828804279933, 6848.246692863781, 6860.416864566568, 6862.519623626298, 6866.34769696878, 6447.903281450782, 6452.870942581122, 6458.967705161444, 6463.838404039937, 6508.121403610547, 3665.395209790355, 3709.27669104522, 3711.9628803712158, 3713.33160031197, 3714.9226724250207, 6923.065386172802, 7101.218865924744, 7101.857962840714, 7111.040009598638, 7116.857662846714, 6917.584944903322, 6936.895946560806, 6948.861022779516, 6965.756198533129, 6975.162980442278, 7080.575165490087, 7083.539569927938, 7088.858222835514, 7092.716291348288, 7103.502754807114, 6843.828904277433, 6847.657617119224, 6862.759803406857, 6865.965670171618, 6869.175698916162, 6654.534182607171, 6712.194536655633, 6828.760993365208, 6837.794866154023, 6879.759208427681, 7217.927820721936, 7241.746538871114, 7243.275672432715, 7249.0, 7257.782266532013, 4698.436187657503, 4726.125666751662, 4731.148393289241, 4740.786664600032, 4742.051589682008, 6680.0647909291765, 6853.588784672936, 6947.478939079489, 6952.582845029315, 6974.0236366909685, 6648.5346025777735, 6652.933470665232, 6664.866702666017, 6764.0868482754195, 6817.250102488623, 6749.595024298558, 6773.458123350219, 6814.591124532544, 6833.41915937131, 6835.829104272433, 6598.736050557924, 6608.867822643617, 6610.305917878553, 6612.4710023198995, 6634.767783127568, 6602.0, 6787.592744435152, 6804.149481314836, 6808.421284190899, 6832.521723479309, 6618.933810661832, 6638.435732962752, 6650.135482387259, 6654.700538475683, 6656.134702488645], "value": 5036.515636751502, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.1698800968736, 932.87406200163, 938.7514605574585, 956.4452617481861, 958.3100167879129, 15057.62355941102, 15415.15216663083, 15420.074795512277, 15424.383024679013, 15438.691226175484, 14287.857121428782, 14317.140971541688, 14388.0, 14392.71214575708, 14424.134551926893, 744.2371569141619, 899.1413200393641, 918.3984490158956, 920.1718453391967, 923.201430762389, 905.5381755304776, 907.4827348411408, 912.3704643795793, 912.9041450647686, 913.808100298938, 966.4104896013426, 971.3394891473795, 971.8104969530945, 972.4457059476101, 978.2223132609593, 774.7520793346132, 946.7159852044393, 969.6024629901707, 970.8058388322364, 971.8056388722284, 707.2291202589151, 712.8609921065395, 714.0503130835975, 714.3891972363606, 715.5170260074428, 14682.70634587313, 14722.779158312635, 14741.778873316909, 14771.33528991198, 14824.258787060604, 14339.856601434061, 14540.345684444226, 15169.317380717894, 15219.162946037963, 15271.160086195256, 12091.818622720666, 12123.454444549929, 12153.5138594457, 12467.251964882136, 12519.874801251963, 4123.835046598162, 4141.213169497786, 4155.854545090907, 4242.830286788525, 4304.332828411601, 51148.48851511512, 51242.23136652953, 51566.226506602434, 51604.22593661098, 52154.47845521534, 11067.335959842274, 11143.275687080313, 11169.609063682732, 11178.608748693756, 11293.943530282297, 18170.818291817177, 18237.361692340703, 18265.086745662662, 18268.26926922908, 18718.53203669919, 8680.262177714838, 8723.738287851374, 8774.210321071134, 8789.956050219836, 8838.469691818384, 5129.538341549279, 5165.948340516622, 5259.605529585297, 5299.708516031578, 5324.893502129936, 3364.1925937775245, 3517.2437925846066, 3532.240568277781, 3532.8763493278125, 3535.4520049392386, 603.0, 629.2386212682613, 661.632793799446, 684.4832151725416, 686.1731613405934, 722.4328901812053, 725.9691238441426, 814.3281792521194, 818.2799136759613, 823.7858156879255, 9213.262938964866, 9237.861432078524, 9707.320487565943, 9729.221662267002, 9749.853752193723, 649.8999771091866, 782.4210084537401, 803.1809145129224, 816.9673213071529, 825.7316372179066, 4742.905141897143, 4769.35613692154, 4824.589909857631, 4834.105690447279, 4916.287138364989, 66820.33179668238, 67233.66383168053, 67797.0, 67955.66022169957, 68199.65900170467, 58288.708556457794, 58403.123953140734, 59241.26069914397, 59451.0, 59468.0, 50886.49113508966, 50941.745291273306, 51077.489225107274, 51596.22605660918, 51716.48283517117, 8614.267787237904, 8886.777830554029, 8895.688650897187, 8981.910180898107, 9474.763130921781, 38693.613063869, 38908.221835563694, 38925.416118757676, 41292.79353603213, 41993.79003105087, 45732.30770768579, 45915.31127033164, 51428.0, 51941.48058519366, 52705.0, 11846.289222646668, 11927.821082683593, 11933.761324773282, 12033.097517686383, 12414.62756117318, 12903.612891613267, 12967.740645187232, 13703.246321452416, 14861.702765944838, 14949.25253737287, 10781.518812872924, 13836.377363018488, 13929.373178206803, 14183.929080354532, 14193.716125677634, 13089.934550327187, 13603.183808971493, 13644.181349119084, 13659.863401366256, 13696.65758356049, 13260.80108798388, 13374.0, 13618.057600271499, 13676.452941882611, 13684.52104176349, 10413.0, 10497.0, 10520.15838732915, 10876.891231087588, 10910.509027093642, 10396.220283478619, 10487.580496780349, 10657.89342106569, 10751.569937202737, 10820.350778953289], "value": 7170.113404635338, "unit": "score"}], "name": "dromaeo_css", "value": 7565.206726528956, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 110.0, 110.0, 111.0, 111.0, 107.0, 112.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 160.0, 184.0, 126.0, 159.0, 154.0, 134.0, 195.0, 125.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 160.0, 159.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 73.0, 172.0, 76.0, 76.0, 73.0, 76.0, 156.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 147.0, 92.0, 93.0, 93.0, 153.0, 91.0, 94.0, 153.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 53.0, 76.0, 52.0, 53.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 57.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 70.0, 72.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 119.0, 117.0, 113.0, 114.0, 115.0, 112.0, 114.0, 132.0, 125.0], "value": 117.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 162.0, 159.0, 161.0, 164.0, 157.0, 158.0, 154.0, 157.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 66.0, 68.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1511.8999999999999, "alertThreshold": 2.0}]} 06:41:30 INFO - Return code: 0 06:41:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:41:30 ERROR - # TBPL SUCCESS # 06:41:30 INFO - Running post-action listener: _resource_record_post_action 06:41:30 INFO - Running post-run listener: _resource_record_post_run 06:41:31 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 499089408; Read time: 0; Write time: 545056 06:41:31 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 254435328; Read time: 0; Write time: 315944 06:41:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 244056064; Read time: 0; Write time: 229112 06:41:31 INFO - Running post-run listener: _upload_blobber_files 06:41:31 INFO - Blob upload gear active. 06:41:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:31 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:31 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:31 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:32 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:41:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:33 INFO - (blobuploader) - INFO - Done attempting. 06:41:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:41:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:41:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:33 INFO - (blobuploader) - INFO - Done attempting. 06:41:33 INFO - (blobuploader) - INFO - Iteration through files over. 06:41:33 INFO - Return code: 0 06:41:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:41:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:41:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ef935d0c5468658c01b0f54034f0a5b8020d72be0a697bcdda0d7e8d587e2a68db7ca6fee14aa05a4467a703224040c78bb5bfdd34bb794cfde556571a01c80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/951fa16a420b12708613b65fdd98042be547403c9a018fe0771eda76485f4342018007f10e119fc7d2868233001348bcaa526f0e0a866e20bd1f2e1644417de4"} 06:41:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:41:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:41:33 INFO - Contents: 06:41:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ef935d0c5468658c01b0f54034f0a5b8020d72be0a697bcdda0d7e8d587e2a68db7ca6fee14aa05a4467a703224040c78bb5bfdd34bb794cfde556571a01c80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/951fa16a420b12708613b65fdd98042be547403c9a018fe0771eda76485f4342018007f10e119fc7d2868233001348bcaa526f0e0a866e20bd1f2e1644417de4"} 06:41:33 INFO - Running post-run listener: copy_logs_to_upload_dir 06:41:33 INFO - Copying logs to upload dir... 06:41:33 INFO - mkdir: /builds/slave/test/build/upload/logs 06:41:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.975824 ========= master_lag: 0.54 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-09 06:41:33.974288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:33.978625) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209 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/2ef935d0c5468658c01b0f54034f0a5b8020d72be0a697bcdda0d7e8d587e2a68db7ca6fee14aa05a4467a703224040c78bb5bfdd34bb794cfde556571a01c80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/951fa16a420b12708613b65fdd98042be547403c9a018fe0771eda76485f4342018007f10e119fc7d2868233001348bcaa526f0e0a866e20bd1f2e1644417de4"} 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.011243 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/2ef935d0c5468658c01b0f54034f0a5b8020d72be0a697bcdda0d7e8d587e2a68db7ca6fee14aa05a4467a703224040c78bb5bfdd34bb794cfde556571a01c80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/951fa16a420b12708613b65fdd98042be547403c9a018fe0771eda76485f4342018007f10e119fc7d2868233001348bcaa526f0e0a866e20bd1f2e1644417de4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:34.005839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:34.006178) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1462800064.369031-1432131209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:34.056103) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:34.056405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:34.057287) ========= ========= Total master_lag: 0.69 =========