builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1462800065.18 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.181452) ========= 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.181875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.182143) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.198869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.199152) ========= 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=0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.8M=0.001s 2016-05-09 06:21:05 (10.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.326450) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.326727) ========= 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=0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015708 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.375951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:05.376251) ========= 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=0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 06:21:05,466 truncating revision to first 12 chars 2016-05-09 06:21:05,466 Setting DEBUG logging. 2016-05-09 06:21:05,466 attempt 1/10 2016-05-09 06:21:05,466 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:05,934 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=0.771884 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.161072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.161372) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.161781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.162045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 06:21:06.170950) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-09 06:21:06.171217) ========= /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=0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:21:06 INFO - MultiFileLogger online at 20160509 06:21:06 in /builds/slave/test 06:21:06 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:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:21:06 INFO - {'append_to_log': False, 06:21:06 INFO - 'base_work_dir': '/builds/slave/test', 06:21:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:21:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:21:06 INFO - 'branch': 'Mozilla-Aurora', 06:21:06 INFO - 'buildbot_json_path': 'buildprops.json', 06:21:06 INFO - 'config_files': ('talos/linux_config.py',), 06:21:06 INFO - 'default_actions': ('clobber', 06:21:06 INFO - 'read-buildbot-config', 06:21:06 INFO - 'download-and-extract', 06:21:06 INFO - 'populate-webroot', 06:21:06 INFO - 'create-virtualenv', 06:21:06 INFO - 'install', 06:21:06 INFO - 'run-tests'), 06:21:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:21:06 INFO - 'download_minidump_stackwalk': True, 06:21:06 INFO - 'download_symbols': 'ondemand', 06:21:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:21:06 INFO - 'tooltool.py': '/tools/tooltool.py', 06:21:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:21:06 INFO - '/tools/misc-python/virtualenv.py')}, 06:21:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:21:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:21:06 INFO - 'installer_path': 'installer.exe', 06:21:06 INFO - 'log_level': 'info', 06:21:06 INFO - 'log_name': 'talos', 06:21:06 INFO - 'log_to_console': True, 06:21:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:21:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:21:06 INFO - 'opt_config_files': (), 06:21:06 INFO - 'pip_index': False, 06:21:06 INFO - 'sps_profile': False, 06:21:06 INFO - 'sps_profile_interval': 0, 06:21:06 INFO - 'suite': 'dromaeojs', 06:21:06 INFO - 'system_bits': '32', 06:21:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:21:06 INFO - 'title': 'talos-linux64-ix-029', 06:21:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:21:06 INFO - 'use_talos_json': True, 06:21:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:21:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:21:06 INFO - 'work_dir': 'build'} 06:21:06 INFO - ##### 06:21:06 INFO - ##### Running clobber step. 06:21:06 INFO - ##### 06:21:06 INFO - Running pre-action listener: _resource_record_pre_action 06:21:06 INFO - Running main action method: clobber 06:21:06 INFO - rmtree: /builds/slave/test/build 06:21:06 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": 317, 06:21:07 INFO - "slavename": "talos-linux64-ix-029", 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:13 INFO - Downloaded 23798585 bytes. 06:21:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:21:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:21:14 INFO - Return code: 0 06:21:14 INFO - 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.talos.tests.zip matches https://queue.taskcluster.net 06:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.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:15 INFO - Downloaded 10840145 bytes. 06:21:15 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:15 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:16 INFO - Return code: 0 06:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:16 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:16 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:16 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:16 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:16 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:17 INFO - Downloaded 62704189 bytes. 06:21:17 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:17 INFO - mkdir: /builds/slave/test/properties 06:21:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:17 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:17 INFO - Contents: 06:21:17 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:18 INFO - Running post-action listener: _resource_record_post_action 06:21:18 INFO - Running post-action listener: set_extra_try_arguments 06:21:18 INFO - ##### 06:21:18 INFO - ##### Running populate-webroot step. 06:21:18 INFO - ##### 06:21:18 INFO - Running pre-action listener: _resource_record_pre_action 06:21:18 INFO - Running main action method: populate_webroot 06:21:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:18 INFO - '--tppagecycles', 06:21:18 INFO - '7'], 06:21:18 INFO - 'tests': ['tsvgm']}}, 06:21:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:21:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:21:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:18 INFO - 'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:18 INFO - 'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['damp', 'tps']}, 06:21:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:18 INFO - 'tests': ['damp', 'tps']}, 06:21:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['dromaeo_dom']}, 06:21:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['a11yr', 06:21:18 INFO - 'ts_paint', 06:21:18 INFO - 'tpaint', 06:21:18 INFO - 'sessionrestore', 06:21:18 INFO - 'sessionrestore_no_auto_restore', 06:21:18 INFO - 'tabpaint']}, 06:21:18 INFO - 'other-e10s': {'tests': ['a11yr', 06:21:18 INFO - 'ts_paint', 06:21:18 INFO - 'tpaint', 06:21:18 INFO - 'sessionrestore', 06:21:18 INFO - 'sessionrestore_no_auto_restore', 06:21:18 INFO - 'tabpaint']}, 06:21:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:21:18 INFO - 'ts_paint', 06:21:18 INFO - 'tpaint', 06:21:18 INFO - 'sessionrestore', 06:21:18 INFO - 'sessionrestore_no_auto_restore', 06:21:18 INFO - 'tabpaint']}, 06:21:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:21:18 INFO - 'ts_paint', 06:21:18 INFO - 'tpaint', 06:21:18 INFO - 'sessionrestore', 06:21:18 INFO - 'sessionrestore_no_auto_restore', 06:21:18 INFO - 'tabpaint']}, 06:21:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['a11yr', 06:21:18 INFO - 'ts_paint', 06:21:18 INFO - 'tpaint', 06:21:18 INFO - 'sessionrestore', 06:21:18 INFO - 'sessionrestore_no_auto_restore', 06:21:18 INFO - 'tabpaint']}, 06:21:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['a11yr', 06:21:18 INFO - 'ts_paint', 06:21:18 INFO - 'tpaint', 06:21:18 INFO - 'sessionrestore', 06:21:18 INFO - 'sessionrestore_no_auto_restore', 06:21:18 INFO - 'tabpaint']}, 06:21:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['tsvgx', 06:21:18 INFO - 'tsvgr_opacity', 06:21:18 INFO - 'tart', 06:21:18 INFO - 'tscrollx', 06:21:18 INFO - 'cart']}, 06:21:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:21:18 INFO - 'tsvgr_opacity', 06:21:18 INFO - 'tart', 06:21:18 INFO - 'tscrollx', 06:21:18 INFO - 'cart']}, 06:21:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:18 INFO - 'talos_options': ['--disable-e10s'], 06:21:18 INFO - 'tests': ['tp5o']}, 06:21:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:18 INFO - 'tests': ['tp5o']}, 06:21:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:18 INFO - 'talos_options': ['--disable-e10s', 06:21:18 INFO - '--xperf_path', 06:21:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:18 INFO - 'tests': ['tp5n']}, 06:21:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:18 INFO - 'talos_options': ['--xperf_path', 06:21:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:18 INFO - 'tests': ['tp5n']}}, 06:21:18 INFO - 'talos.zip': {'path': '', 06:21:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:18 INFO - Running post-action listener: _resource_record_post_action 06:21:18 INFO - ##### 06:21:18 INFO - ##### Running create-virtualenv step. 06:21:18 INFO - ##### 06:21:18 INFO - Running pre-action listener: _resource_record_pre_action 06:21:18 INFO - Running main action method: create_virtualenv 06:21:18 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:18 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:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:18 INFO - Using real prefix '/usr' 06:21:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:18 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:20 INFO - Installing pip.................done. 06:21:20 INFO - Return code: 0 06:21:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:20 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 0x7fa2fa3ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, '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': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 06:21:20 INFO - 'HOME': '/home/cltbld', 06:21:20 INFO - 'LANG': 'en_US.UTF-8', 06:21:20 INFO - 'LANGUAGE': 'en_US:en', 06:21:20 INFO - 'LOGNAME': 'cltbld', 06:21:20 INFO - 'MAIL': '/var/mail/cltbld', 06:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:20 INFO - 'MOZ_NO_REMOTE': '1', 06:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:20 INFO - 'NO_EM_RESTART': '1', 06:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:20 INFO - 'PWD': '/builds/slave/test', 06:21:20 INFO - 'SHELL': '/bin/bash', 06:21:20 INFO - 'SHLVL': '1', 06:21:20 INFO - 'TERM': 'linux', 06:21:20 INFO - 'TMOUT': '86400', 06:21:20 INFO - 'USER': 'cltbld', 06:21:20 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:20 INFO - '_': '/tools/buildbot/bin/python'} 06:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:20 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:20 INFO - Cleaning up... 06:21:21 INFO - Return code: 0 06:21:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:21:21 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:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:21 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:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:21 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 0x7fa2fa3ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, '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': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', '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:21 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:21 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:21 INFO - Using env: {'DISPLAY': ':0', 06:21:21 INFO - 'HOME': '/home/cltbld', 06:21:21 INFO - 'LANG': 'en_US.UTF-8', 06:21:21 INFO - 'LANGUAGE': 'en_US:en', 06:21:21 INFO - 'LOGNAME': 'cltbld', 06:21:21 INFO - 'MAIL': '/var/mail/cltbld', 06:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:21 INFO - 'MOZ_NO_REMOTE': '1', 06:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:21 INFO - 'NO_EM_RESTART': '1', 06:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:21 INFO - 'PWD': '/builds/slave/test', 06:21:21 INFO - 'SHELL': '/bin/bash', 06:21:21 INFO - 'SHLVL': '1', 06:21:21 INFO - 'TERM': 'linux', 06:21:21 INFO - 'TMOUT': '86400', 06:21:21 INFO - 'USER': 'cltbld', 06:21:21 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:21 INFO - '_': '/tools/buildbot/bin/python'} 06:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:21 INFO - Downloading/unpacking psutil>=0.7.1 06:21:21 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:21 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 - 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:21 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:21 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:21 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:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:23 INFO - Installing collected packages: psutil 06:21:23 INFO - Running setup.py install for psutil 06:21:23 INFO - building 'psutil._psutil_linux' extension 06:21:23 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:23 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:23 INFO - building 'psutil._psutil_posix' extension 06:21:23 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:23 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:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:23 INFO - Successfully installed psutil 06:21:23 INFO - Cleaning up... 06:21:23 INFO - Return code: 0 06:21:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:23 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 0x7fa2fa3ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, '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': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', '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:23 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:23 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:23 INFO - Using env: {'DISPLAY': ':0', 06:21:23 INFO - 'HOME': '/home/cltbld', 06:21:23 INFO - 'LANG': 'en_US.UTF-8', 06:21:23 INFO - 'LANGUAGE': 'en_US:en', 06:21:23 INFO - 'LOGNAME': 'cltbld', 06:21:23 INFO - 'MAIL': '/var/mail/cltbld', 06:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:23 INFO - 'MOZ_NO_REMOTE': '1', 06:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:23 INFO - 'NO_EM_RESTART': '1', 06:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:23 INFO - 'PWD': '/builds/slave/test', 06:21:23 INFO - 'SHELL': '/bin/bash', 06:21:23 INFO - 'SHLVL': '1', 06:21:23 INFO - 'TERM': 'linux', 06:21:23 INFO - 'TMOUT': '86400', 06:21:23 INFO - 'USER': 'cltbld', 06:21:23 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:23 INFO - '_': '/tools/buildbot/bin/python'} 06:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:21:23 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:23 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:23 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:23 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:23 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:23 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:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:21:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:25 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:25 INFO - Installing collected packages: mozsystemmonitor 06:21:25 INFO - Running setup.py install for mozsystemmonitor 06:21:25 INFO - Successfully installed mozsystemmonitor 06:21:25 INFO - Cleaning up... 06:21:26 INFO - Return code: 0 06:21:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa2fa3ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, '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': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', '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:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:21:26 INFO - Using env: {'DISPLAY': ':0', 06:21:26 INFO - 'HOME': '/home/cltbld', 06:21:26 INFO - 'LANG': 'en_US.UTF-8', 06:21:26 INFO - 'LANGUAGE': 'en_US:en', 06:21:26 INFO - 'LOGNAME': 'cltbld', 06:21:26 INFO - 'MAIL': '/var/mail/cltbld', 06:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:26 INFO - 'MOZ_NO_REMOTE': '1', 06:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:26 INFO - 'NO_EM_RESTART': '1', 06:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:26 INFO - 'PWD': '/builds/slave/test', 06:21:26 INFO - 'SHELL': '/bin/bash', 06:21:26 INFO - 'SHLVL': '1', 06:21:26 INFO - 'TERM': 'linux', 06:21:26 INFO - 'TMOUT': '86400', 06:21:26 INFO - 'USER': 'cltbld', 06:21:26 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:26 INFO - '_': '/tools/buildbot/bin/python'} 06:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:26 INFO - Downloading/unpacking 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:28 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:28 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:28 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:28 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:28 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:28 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:28 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:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:28 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:28 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:28 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:28 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:28 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:28 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:28 INFO - Downloading docopt-0.6.1.tar.gz 06:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:28 INFO - Running setup.py install for blobuploader 06:21:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:28 INFO - Running setup.py install for requests 06:21:29 INFO - Running setup.py install for docopt 06:21:29 INFO - Successfully installed blobuploader requests docopt 06:21:29 INFO - Cleaning up... 06:21:29 INFO - Return code: 0 06:21:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fa2fa3ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, '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': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 06:21:29 INFO - 'HOME': '/home/cltbld', 06:21:29 INFO - 'LANG': 'en_US.UTF-8', 06:21:29 INFO - 'LANGUAGE': 'en_US:en', 06:21:29 INFO - 'LOGNAME': 'cltbld', 06:21:29 INFO - 'MAIL': '/var/mail/cltbld', 06:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:29 INFO - 'MOZ_NO_REMOTE': '1', 06:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:29 INFO - 'NO_EM_RESTART': '1', 06:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:29 INFO - 'PWD': '/builds/slave/test', 06:21:29 INFO - 'SHELL': '/bin/bash', 06:21:29 INFO - 'SHLVL': '1', 06:21:29 INFO - 'TERM': 'linux', 06:21:29 INFO - 'TMOUT': '86400', 06:21:29 INFO - 'USER': 'cltbld', 06:21:29 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:29 INFO - '_': '/tools/buildbot/bin/python'} 06:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:29 INFO - Running setup.py (path:/tmp/pip-6xyOcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:29 INFO - Running setup.py (path:/tmp/pip-eevVIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:29 INFO - Running setup.py (path:/tmp/pip-ONBpVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:29 INFO - Running setup.py (path:/tmp/pip-jzC1sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:29 INFO - Running setup.py (path:/tmp/pip-X23Ies-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:30 INFO - Running setup.py (path:/tmp/pip-cmQKll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:30 INFO - Running setup.py (path:/tmp/pip-JsZIpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:30 INFO - Running setup.py (path:/tmp/pip-ha_N46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:30 INFO - Running setup.py (path:/tmp/pip-MiSkeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:30 INFO - Running setup.py (path:/tmp/pip-SDP30x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:30 INFO - Running setup.py (path:/tmp/pip-NCbrY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:30 INFO - Running setup.py (path:/tmp/pip-nSZt63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:30 INFO - Running setup.py (path:/tmp/pip-h_XYc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:30 INFO - Running setup.py (path:/tmp/pip-TXIAj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:30 INFO - Running setup.py (path:/tmp/pip-iWVWoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:30 INFO - Running setup.py (path:/tmp/pip-hYGrl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:30 INFO - Running setup.py (path:/tmp/pip-TjmIq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:30 INFO - Running setup.py install for manifestparser 06:21:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozcrash 06:21:31 INFO - Running setup.py install for mozdebug 06:21:31 INFO - Running setup.py install for mozdevice 06:21:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozfile 06:21:31 INFO - Running setup.py install for mozhttpd 06:21:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozinfo 06:21:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozInstall 06:21:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for mozleak 06:21:31 INFO - Running setup.py install for mozlog 06:21:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:31 INFO - Running setup.py install for moznetwork 06:21:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Running setup.py install for mozprocess 06:21:32 INFO - Running setup.py install for mozprofile 06:21:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Running setup.py install for mozrunner 06:21:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Running setup.py install for mozscreenshot 06:21:32 INFO - Running setup.py install for moztest 06:21:32 INFO - Running setup.py install for mozversion 06:21:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:32 INFO - Cleaning up... 06:21:32 INFO - Return code: 0 06:21:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fa2fa3ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, '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': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:21:32 INFO - Using env: {'DISPLAY': ':0', 06:21:32 INFO - 'HOME': '/home/cltbld', 06:21:32 INFO - 'LANG': 'en_US.UTF-8', 06:21:32 INFO - 'LANGUAGE': 'en_US:en', 06:21:32 INFO - 'LOGNAME': 'cltbld', 06:21:32 INFO - 'MAIL': '/var/mail/cltbld', 06:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:32 INFO - 'MOZ_NO_REMOTE': '1', 06:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:32 INFO - 'NO_EM_RESTART': '1', 06:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:32 INFO - 'PWD': '/builds/slave/test', 06:21:32 INFO - 'SHELL': '/bin/bash', 06:21:32 INFO - 'SHLVL': '1', 06:21:32 INFO - 'TERM': 'linux', 06:21:32 INFO - 'TMOUT': '86400', 06:21:32 INFO - 'USER': 'cltbld', 06:21:32 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:32 INFO - '_': '/tools/buildbot/bin/python'} 06:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:32 INFO - Running setup.py (path:/tmp/pip-vUVMoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:32 INFO - Running setup.py (path:/tmp/pip-jo_n6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:33 INFO - Running setup.py (path:/tmp/pip-n978Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:33 INFO - Running setup.py (path:/tmp/pip-xDplgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:33 INFO - Running setup.py (path:/tmp/pip-n9jnlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:33 INFO - Running setup.py (path:/tmp/pip-5lmcBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:33 INFO - Running setup.py (path:/tmp/pip-uLPKTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:33 INFO - Running setup.py (path:/tmp/pip-VFQM0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:33 INFO - Running setup.py (path:/tmp/pip-L2jGmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:33 INFO - Running setup.py (path:/tmp/pip-xBx3fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:33 INFO - Running setup.py (path:/tmp/pip-0gL8ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:33 INFO - Running setup.py (path:/tmp/pip-6LTfGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:33 INFO - Running setup.py (path:/tmp/pip-q1Ke9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:33 INFO - Running setup.py (path:/tmp/pip-CpCXdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:33 INFO - Running setup.py (path:/tmp/pip-mp4Eab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:33 INFO - Running setup.py (path:/tmp/pip-QFAwQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:34 INFO - Running setup.py (path:/tmp/pip-k7VgZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:34 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:34 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:34 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:34 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:34 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:34 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:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21:34 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:34 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 - 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:34 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:34 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:34 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 - Downloading blessings-1.6.tar.gz 06:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:36 INFO - Installing collected packages: blessings 06:21:36 INFO - Running setup.py install for blessings 06:21:36 INFO - Successfully installed blessings 06:21:36 INFO - Cleaning up... 06:21:36 INFO - Return code: 0 06:21:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:36 INFO - Reading from file tmpfile_stdout 06:21:36 INFO - Current package versions: 06:21:36 INFO - argparse == 1.2.1 06:21:36 INFO - blessings == 1.6 06:21:36 INFO - blobuploader == 1.2.4 06:21:36 INFO - docopt == 0.6.1 06:21:36 INFO - manifestparser == 1.1 06:21:36 INFO - mozInstall == 1.12 06:21:36 INFO - mozcrash == 0.17 06:21:36 INFO - mozdebug == 0.1 06:21:36 INFO - mozdevice == 0.48 06:21:36 INFO - mozfile == 1.2 06:21:36 INFO - mozhttpd == 0.7 06:21:36 INFO - mozinfo == 0.9 06:21:36 INFO - mozleak == 0.1 06:21:36 INFO - mozlog == 3.1 06:21:36 INFO - moznetwork == 0.27 06:21:36 INFO - mozprocess == 0.22 06:21:36 INFO - mozprofile == 0.28 06:21:36 INFO - mozrunner == 6.11 06:21:36 INFO - mozscreenshot == 0.1 06:21:36 INFO - mozsystemmonitor == 0.0 06:21:36 INFO - moztest == 0.7 06:21:36 INFO - mozversion == 1.4 06:21:36 INFO - psutil == 3.1.1 06:21:36 INFO - requests == 1.2.3 06:21:36 INFO - wsgiref == 0.1.2 06:21:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fa2fa3ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, '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': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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:36 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:36 INFO - Using env: {'DISPLAY': ':0', 06:21:36 INFO - 'HOME': '/home/cltbld', 06:21:36 INFO - 'LANG': 'en_US.UTF-8', 06:21:36 INFO - 'LANGUAGE': 'en_US:en', 06:21:36 INFO - 'LOGNAME': 'cltbld', 06:21:36 INFO - 'MAIL': '/var/mail/cltbld', 06:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:36 INFO - 'MOZ_NO_REMOTE': '1', 06:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:36 INFO - 'NO_EM_RESTART': '1', 06:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:36 INFO - 'PWD': '/builds/slave/test', 06:21:36 INFO - 'SHELL': '/bin/bash', 06:21:36 INFO - 'SHLVL': '1', 06:21:36 INFO - 'TERM': 'linux', 06:21:36 INFO - 'TMOUT': '86400', 06:21:36 INFO - 'USER': 'cltbld', 06:21:36 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:36 INFO - '_': '/tools/buildbot/bin/python'} 06:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:36 INFO - 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:36 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:36 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:36 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:36 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:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Cleaning up... 06:21:36 INFO - Return code: 0 06:21:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x7fa2fa3ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, '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': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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:36 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:36 INFO - Using env: {'DISPLAY': ':0', 06:21:36 INFO - 'HOME': '/home/cltbld', 06:21:36 INFO - 'LANG': 'en_US.UTF-8', 06:21:36 INFO - 'LANGUAGE': 'en_US:en', 06:21:36 INFO - 'LOGNAME': 'cltbld', 06:21:36 INFO - 'MAIL': '/var/mail/cltbld', 06:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:36 INFO - 'MOZ_NO_REMOTE': '1', 06:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:36 INFO - 'NO_EM_RESTART': '1', 06:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:36 INFO - 'PWD': '/builds/slave/test', 06:21:36 INFO - 'SHELL': '/bin/bash', 06:21:36 INFO - 'SHLVL': '1', 06:21:36 INFO - 'TERM': 'linux', 06:21:36 INFO - 'TMOUT': '86400', 06:21:36 INFO - 'USER': 'cltbld', 06:21:36 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:36 INFO - '_': '/tools/buildbot/bin/python'} 06:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:36 INFO - Downloading/unpacking jsonschema 06:21:36 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:36 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:36 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:36 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:36 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:36 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:21:38 INFO - Downloading/unpacking functools32 (from jsonschema) 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:38 INFO - Downloading functools32-3.2.3-2.tar.gz 06:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:21:39 INFO - warning: no files found matching '*.txt' 06:21:39 INFO - no previously-included directories found matching 'build' 06:21:39 INFO - no previously-included directories found matching 'dist' 06:21:39 INFO - no previously-included directories found matching '.git*' 06:21:39 INFO - Installing collected packages: jsonschema, functools32 06:21:39 INFO - Running setup.py install for functools32 06:21:39 INFO - warning: no files found matching '*.txt' 06:21:39 INFO - no previously-included directories found matching 'build' 06:21:39 INFO - no previously-included directories found matching 'dist' 06:21:39 INFO - no previously-included directories found matching '.git*' 06:21:39 INFO - Successfully installed jsonschema functools32 06:21:39 INFO - Cleaning up... 06:21:39 INFO - Return code: 0 06:21:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x7fa2fa3ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, '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': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 06:21:39 INFO - 'HOME': '/home/cltbld', 06:21:39 INFO - 'LANG': 'en_US.UTF-8', 06:21:39 INFO - 'LANGUAGE': 'en_US:en', 06:21:39 INFO - 'LOGNAME': 'cltbld', 06:21:39 INFO - 'MAIL': '/var/mail/cltbld', 06:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:39 INFO - 'MOZ_NO_REMOTE': '1', 06:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:39 INFO - 'NO_EM_RESTART': '1', 06:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:39 INFO - 'PWD': '/builds/slave/test', 06:21:39 INFO - 'SHELL': '/bin/bash', 06:21:39 INFO - 'SHLVL': '1', 06:21:39 INFO - 'TERM': 'linux', 06:21:39 INFO - 'TMOUT': '86400', 06:21:39 INFO - 'USER': 'cltbld', 06:21:39 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:39 INFO - '_': '/tools/buildbot/bin/python'} 06:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:39 INFO - Downloading/unpacking flake8 06:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:21:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:21:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:21:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:42 INFO - no previously-included directories found matching 'docs/_build' 06:21:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:21:42 INFO - Running setup.py install for pep8 06:21:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:21:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:21:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:21:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:21:42 INFO - no previously-included directories found matching 'docs/_build' 06:21:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:21:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:21:42 INFO - Cleaning up... 06:21:42 INFO - Return code: 0 06:21:42 INFO - Running post-action listener: _resource_record_post_action 06:21:42 INFO - Running post-action listener: _start_resource_monitoring 06:21:42 INFO - Starting resource monitoring. 06:21:42 INFO - ##### 06:21:42 INFO - ##### Running install step. 06:21:42 INFO - ##### 06:21:42 INFO - Running pre-action listener: _resource_record_pre_action 06:21:42 INFO - Running main action method: install 06:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:42 INFO - Reading from file tmpfile_stdout 06:21:42 INFO - Detecting whether we're running mozinstall >=1.0... 06:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:21:42 INFO - Reading from file tmpfile_stdout 06:21:42 INFO - Output received: 06:21:42 INFO - Usage: mozinstall [options] installer 06:21:42 INFO - Options: 06:21:42 INFO - -h, --help show this help message and exit 06:21:42 INFO - -d DEST, --destination=DEST 06:21:42 INFO - Directory to install application into. [default: 06:21:42 INFO - "/builds/slave/test"] 06:21:42 INFO - --app=APP Application being installed. [default: firefox] 06:21:42 INFO - mkdir: /builds/slave/test/build/application 06:21:42 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:42 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:58 INFO - Reading from file tmpfile_stdout 06:21:58 INFO - Output received: 06:21:58 INFO - /builds/slave/test/build/application/firefox/firefox 06:21:58 INFO - Running post-action listener: _resource_record_post_action 06:21:58 INFO - ##### 06:21:58 INFO - ##### Running run-tests step. 06:21:58 INFO - ##### 06:21:58 INFO - Running pre-action listener: _resource_record_pre_action 06:21:58 INFO - Running main action method: run_tests 06:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:21:58 INFO - Python 2.7.3 06:21:58 INFO - Return code: 0 06:21:58 INFO - grabbing minidump binary from tooltool 06:21:58 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:58 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 0x1708410>, '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 0x1709310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17097a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:21:58 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:58 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:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:21:58 INFO - Return code: 0 06:21:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:21:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:21:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:21:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:21:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:21:59 INFO - Return code: 0 06:21:59 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-029', '--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:59 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-029 --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:59 INFO - Using env: {'DISPLAY': ':0', 06:21:59 INFO - 'HOME': '/home/cltbld', 06:21:59 INFO - 'LANG': 'en_US.UTF-8', 06:21:59 INFO - 'LANGUAGE': 'en_US:en', 06:21:59 INFO - 'LOGNAME': 'cltbld', 06:21:59 INFO - 'MAIL': '/var/mail/cltbld', 06:21:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:21:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:59 INFO - 'MOZ_NO_REMOTE': '1', 06:21:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:59 INFO - 'NO_EM_RESTART': '1', 06:21:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:59 INFO - 'PWD': '/builds/slave/test', 06:21:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:21:59 INFO - 'SHELL': '/bin/bash', 06:21:59 INFO - 'SHLVL': '1', 06:21:59 INFO - 'TERM': 'linux', 06:21:59 INFO - 'TMOUT': '86400', 06:21:59 INFO - 'USER': 'cltbld', 06:21:59 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492', 06:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:59 INFO - '_': '/tools/buildbot/bin/python'} 06:21:59 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-029', '--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:59 INFO - mozversion application_buildid: 20160509005049 06:21:59 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:21:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:21:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:21:59 INFO - mozversion application_name: Firefox 06:21:59 INFO - mozversion application_remotingname: firefox-dev 06:21:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:21:59 INFO - mozversion application_vendor: Mozilla 06:21:59 INFO - mozversion application_version: 48.0a2 06:21:59 INFO - mozversion platform_buildid: 20160509005049 06:21:59 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 06:21:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:21:59 INFO - mozversion platform_version: 48.0a2 06:21:59 INFO - using testdate: 1462800119 06:21:59 INFO - actual date: 1462800119 06:21:59 INFO - starting webserver on 'localhost:45979' 06:21:59 INFO - SUITE-START | Running 2 tests 06:21:59 INFO - TEST-START | dromaeo_css 06:21:59 INFO - operating with platform_type : linux_ 06:21:59 INFO - Initialising browser for dromaeo_css test... 06:21:59 INFO - TEST-INFO | started process 16763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnHwctG/profile http://localhost:45979/getInfo.html) 06:22:03 INFO - PROCESS | 16763 | __metrics Screen width/height:1600/1200 06:22:03 INFO - PROCESS | 16763 | colorDepth:24 06:22:03 INFO - PROCESS | 16763 | Browser inner width/height: 1024/697 06:22:03 INFO - PROCESS | 16763 | __metrics 06:22:04 ERROR - PROCESS | 16763 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:22:04 INFO - TEST-INFO | 16763: 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 16854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnHwctG/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 | 16854 | RSS: Main: 142098432 06:22:16 INFO - PROCESS | 16854 | 06:23:08 INFO - PROCESS | 16854 | 1462800188355 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 | 16854 | Cycle 1(1): loaded http://localhost:45979/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45979/tests/dromaeo/cssquery-ext.html) 06:25:16 INFO - PROCESS | 16854 | RSS: Main: 253714432 06:25:16 INFO - PROCESS | 16854 | 06:28:18 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45979/tests/dromaeo/cssquery-ext.html (next: http://localhost:45979/tests/dromaeo/cssquery-jquery.html) 06:28:19 INFO - PROCESS | 16854 | RSS: Main: 223924224 06:28:19 INFO - PROCESS | 16854 | 06:31:20 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45979/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45979/tests/dromaeo/cssquery-mootools.html) 06:31:21 INFO - PROCESS | 16854 | RSS: Main: 223252480 06:31:21 INFO - PROCESS | 16854 | 06:34:23 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45979/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45979/tests/dromaeo/cssquery-prototype.html) 06:34:23 INFO - PROCESS | 16854 | RSS: Main: 217743360 06:34:23 INFO - PROCESS | 16854 | 06:37:26 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45979/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45979/tests/dromaeo/cssquery-yui.html) 06:37:27 INFO - PROCESS | 16854 | RSS: Main: 210354176 06:37:27 INFO - PROCESS | 16854 | 06:40:29 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45979/tests/dromaeo/cssquery-yui.html (next: http://localhost:45979/tests/dromaeo/cssquery-dojo.html) 06:40:29 INFO - PROCESS | 16854 | RSS: Main: 255115264 06:40:29 INFO - PROCESS | 16854 | 06:40:29 INFO - PROCESS | 16854 | __start_tp_report 06:40:29 INFO - PROCESS | 16854 | _x_x_mozilla_page_load 06:40:29 INFO - PROCESS | 16854 | _x_x_mozilla_page_load_details 06:40:29 INFO - PROCESS | 16854 | |i|pagename|runs| 06:40:29 INFO - PROCESS | 16854 | |0;dojo.html;3315.1380641033334;3405.6083550391695;3421.4354631485808;3434.3646425411316;3440.7419443541726;5602.747876345564;5603.41164177761;5613.943860561393;5622.746976386057;5634.0703783875615;5594.720263986795;5606.859828504289;5623.578231632623;5643.6049476536655;5644.8024319148835;4931.43288521821;4954.628402869781;5126.820561280365;5192.844214673566;5250.606204534656;5070.036693028332;5104.387473503166;5111.7699703513435;5141.15170996785;5196.246544251081;5192.221166824968;5244.659097158673;5245.554127899133;5245.816396426126;5247.632665713401;5151.793928242866;5170.405403378584;5234.7120908350025;5235.240890070956;5245.029669511153;4971.751412429364;5018.447970723218;5076.619253555961;5077.822276220351;5109.6167787415725;5299.3905700844125;5472.50747432729;5480;5494.478024587658;5502.779888804483;5734.225879506255;5902.380250073724;5903.76384944606;5913.319968203668;5914.349421563625;5912.645241285493;5979.880402391971;6015.639061656315;6024.337322894478;6034.48706859913;5587.804426845041;5590.608657394025;5590.8043218487155;5591.552675785927;5593.272874526327;5963.075723262901;6035.698215089228;6078.848028799315;6082.148499210114;6090.33006369299;5882.705864706748;5940.168376427304;5940.851478713067;5949.553783466257;5976.910346344808;5912.881742365129;5923.911141332884;5932.614380065368;5933;5938.376470470625;5773.566982476331;5888.5289176865745;5895.67573783446;5897.852553686193;5907.409259074058;5884.558658100574;5923.437273459014;5927.8221653350465;5936.406359364116;5960.642361458326;4519.209138400766;4521.615662668644;4521.728696278234;4522.186006518792;4549.795259213343;3995.4805875236034;4009.4587230724064;4050.432939388488;4058.918821623551;4094.9385759213637;5580.804671836466;5598.832035038955;5616.634918730269;5630.887382252332;5659.292588426447;5930.140129681258;5932.139839723216;5938.524918006549;5943.58394912352;5943.970280148572;5491.423400542965;5546.972265138648;5642.887142257132;5643.887122257532;5646.85882852932;5079.517445842639;5108.131617625013;5109.8722531936255;5112.258722485219;5119.641625086283;6125.418085281891;6132.846678833065;6149.7847575335545;6158;6158.692065396802;5892.528597712173;5953.642781433128;6034.879302414015;6050.183225264533;6072.483838873745;6155.4767844731905;6178.474829639351;6181.96909015452;6182.783602573888;6186.690665466619;5747.856303592276;5830.62100963436;5832;5842.7078646066675;5848.152017957457;5896.380880007709;5947.6431414115295;5954.166416701579;5954.732037058429;5993.730282137227;5893.469587737124;5897.616654917417;5931.822045338647;5936.257967754031;5936.673482958478;5733.655980641175;5841.883162336814;5846.619969701956;5883.61756485827;5905.084711869667;5734.197212390352;5742.425757424224;5762.30852297727;5769.826905192851;5808.564357673107;5821;5866.149408335853;5877.73550190251;5880.029795083934;5880.088586269135;5640.802571909963;5729.799457018984;5734.54123670097;5775.797847075332;5804.245448091721 06:40:29 INFO - PROCESS | 16854 | |1;ext.html;663.2803408301993;663.9973639803894;665.8069159943617;678.5182520410508;687.1513680604454;34008.4898726519;40379;41156.79421602888;41207.969800754996;41251.174976500486;44082.77958610203;44975;44993;45026.549734502645;45069.774651126696;8264.090949995525;8901.154390332924;9094.454332740024;10495.790084198312;10679.893201068006;10481;10614.097801686867;10619;10620.628278010272;10639.202059845504;10607.575696972111;10654.200934929873;10664;10665.413402262911;10678.092362149187;8413.074561798197;10900.236983411203;11123.054540363997;11126.61056863006;11135.721606959809;10558.366498010144;10645.52095155712;10661.200409969206;10670.093042091432;10672.78654426907;40562.188756224714;40984.795076024726;40999.18001639951;41085.794571026956;41152;3883.2815929053218;3949.7037722170667;3960.32674445345;3999.960000399988;4043.7978101094827;32981.50527742086;33493.162670933176;34997.47503787445;36142;36158.45762313568;4320.82716691332;4334.869953901388;4416.205083085043;4427.180971520247;4428.623566996809;320558;326482;327061;328121;330210;70125.64937175282;71290.64354678194;71317.28682713106;71371.2862871375;71389.64305178545;73290.63354683193;74926.25073749301;74934.62532687411;75013;75049;18368.173432195585;19786.90106549487;19873.403797886087;20010.59978800445;20019.599608007757;14161.78757318641;14318.284085795669;14323.35544900482;15388.923055384876;15747.842521574867;21786;21794.673079903812;21851.344459666234;21933.561328773336;22080.558388832134;7841.843163136706;7934.56359900211;7967.84064318722;8114.715984940499;8143.42995990275;1131.3099009604134;1156.8727439981594;1168.4041139019162;1182.5388098641536;1188.9464974076188;33678.158046049044;34577.48133777995;34620.653793461744;35151.29697406037;35501.82249088738;1186.1341220908785;1203.4223572684984;1296.6804979253143;1323.2259128409987;1347.9595612131652;18215.63568728618;18442.63114737698;18542.721859172125;18571.25714971413;18594.349197778014;518559;520794;523305;524421;524464;65410.672946634964;65993;66145.66927165333;66224;66276.6686166566;1388.5417812121975;1432.9754225728445;1452.0271418149864;1506.0737646347418;1528.625486755752;31412.685873140977;34019.31961360809;34074.48888266629;34490.82754586211;34631.65368346284;51984.74007629938;52427.73786131045;52982.20526692025;52995.73502132465;53045;308214;308634;309316;310534;311760;28533.714662853105;31492.740290388127;31884.202894927814;32090.19774505656;32194.67805321917;46477.767611161726;54174.45825541694;54335.184972224655;54548;55015;42598.5740142607;42797.786011069744;43116.13767724565;43582.12835743204;44593.77703111593;42404;42810.14379712326;42833.57166428296;43982.78008610065;44083.779581103176;44201;44401.55598443974;44968.32547511724;45611;45822.31266530938;37191;38505.229895401375;38681.22637547177;38848.6115138845;38850.2229955405;29013.56479652849;29226.950602548644;29950.101496955125;30001;30022.24944376408 06:40:29 INFO - PROCESS | 16854 | |2;jquery.html;420.4072258116057;422.88582082837615;429.9505556860962;433.08402728229805;435.50135095315864;18972.525686857836;19565.413037608876;19571.021448927568;19636.41090767276;20459.079341429635;12567.685807854808;12781.360931953412;14090.64773380666;19634;19684.409467715956;5370.275012873251;5454.181872719084;5468.152436372348;5528.806491772789;5757.827265182052;5834.5915785895;5942.2869255689375;5958.076498142795;5968.761249550034;5990.73041713124;5672.290963629546;5919.615225010382;5934.673592952386;5939.643621382731;5944.048952167654;5789.536837053026;5792.942070579283;5814.302283725938;5819.82540523785;5830.970845145789;5624.71876406178;5662.094064949588;5666.206731057655;5666.348369937468;5730.68481233532;13931.303434828218;13993.650158746113;14199.78700319496;14204.289785510684;14826.925865370604;2550.744925507453;2609.021616893665;2624.6325514427995;2870.899518516863;3114.4082624301536;10276.07515323617;10278.486075696186;10438.843417348746;10484.494095243745;10520.94739526305;2011.0849563448742;2038.66362050263;2134.8398870084807;2162.13514594162;2219.212179676224;78838.60580697117;81908.59045704734;83685.58157209236;85770;87954.5602271991;10892.420599013258;11010.449477526092;11092.55629774816;11151.832722509169;11215.383153926612;14200.85799142016;14340.067895586753;14348.641283967985;14426.206558639165;14431;8763.824723505622;8915.910840891507;8941.821163576693;8989.910100899038;9024.954875225712;8780.209781119602;8823.514706691194;8871.911280887238;8895.066018068139;9012.909870901207;4873.074115918035;4917.409910810726;4927.630427717935;4944.950550494449;4983.0033993201505;1969.5076230942263;1978.6339527187517;1981.1773168684845;1984.9305274315618;2014.3755435814944;453.5849697526792;454.92948592968145;463.9605633521121;894.2667013049368;1073.2004656530935;11412.657620271406;11474.48364823585;11547.480363383667;11596.76806463866;11642.476088576035;479.15429267343166;480.28917202540435;481.76634332348783;489.33939182104587;497.0580749479716;4959.355283813081;6241.906371404432;6274.2784579773;6344.333844946306;6356.555041147168;559604;581785;583151;584072;590368;100137;102795;104423;104648.47675761572;106876.46561767296;503.43363715819703;506.8200788720025;509.37347063112577;510.57112025898425;511.0009930585696;11004.449777510932;11098.05666518355;11099.389533575732;11132.610358637408;11157.218994670295;38550.42174367331;39091.41362879616;40097.1980560393;40414.39378409385;40520.392194116524;63048.68475657592;63239;63252.367476326486;63492.36507635049;63632.36367636264;8824.161704638049;8988.640454381752;9009.594568244576;9039.143073308478;9146.222571081267;9688.031196880256;12942.482300707867;13662.453501859814;13738.450461981409;13983.720325593635;11564.248323858923;11614.88385116138;11946.76106477883;11982.58060967862;12544.811827822408;11646.184767066225;11661.183717139718;11709.771901122167;11947.462364193458;12097.516099356279;12084.818727718915;12125.575604853788;12160.574379896661;12261.938690306491;12327.568535101229;8766.254868336262;8884.156005179497;8922.68770593026;8990.370674052754;9044.638214471348;9196.494192819191;12225.816612750994;12355.32045737493;12463.189892656948;12477.438515266653 06:40:29 INFO - PROCESS | 16854 | |3;mootools.html;1429.89990700651;1564.9687006259876;1596.3614554178323;1798.1548672124106;1915.7892631810498;8002.239787220212;8235.299999500043;8238.382121340894;8252.257296843283;8267.173282671738;8152.592370381487;8308.459950103239;8323.25090741833;8323.33413326934;8335.416520843528;2120.5546835164632;2168.555446133547;2354.7174339079334;2411.5176964607062;2435.2694191742494;2415.855048697075;2430.647556104364;2436.6223235398543;2441.07239249086;2442.926712198637;2324.1516846351046;2338.871362075085;2373.1575290771784;2374.03851440167;2376.512814872947;2087.039961617658;2357.964630530535;2435.57377458944;2446.192756390387;2448.5347783920997;2325.7906788389128;2328.1153161798406;2354.2466410748566;2360.055977608953;2362.0315670574983;8125.634346454423;8177.713780017671;8177.9182208178345;8178.591070446454;8188.713395031145;5179.507946745053;5292.02097611943;5296.126139187029;5296.814611488618;5299.3905700844125;3643.0710168906758;3676.9632303677154;3704.1850792825535;3704.3887758519813;3716.163863130801;1232.3099064523894;1265.367316341829;1285.620741881138;1307.8430588329365;1313.441787240419;11695.35675537845;11719.94140029303;11724.472398741991;11728.237664551862;11759.882401175964;4564.2012647786505;4649.325847752057;4660.930086048712;4709.927631841979;4734.95265047352;10001.34991225568;10029.598816047277;10053.849192262122;10062.446565438824;10064.446455444875;5374.193870919394;5380.461953804588;5383.515483606494;5384.273123128406;5386.299781028441;4255.063885945087;4723.4331880174595;4835.8065677372515;4845.709257444564;4849.95150048495;4048.5344185419053;4057.091758847126;4135.875923722293;4135.97932010338;4163.10493243954;1332.8733770291806;1337.759203343388;1355.153029356652;1355.1733442600007;1355.6272025192955;1046.837740150278;1048.3605000949415;1050.8686414198226;1063.2238465919922;1079.1420820447606;5731.77072917087;5751;5787.768489260467;5976.462118409364;5991.400859913973;446.639981257073;461.97690115494765;465.20450030447637;470.67288234677255;472.3788218492671;4157.563455837154;4180.143070670505;4190.266703326905;4195.412642230091;4207.97896010518;10028.749281268027;10393.324433911772;10397.324173928822;10466.738331541772;10492.317999330018;10298.691039268833;10309.175265978703;10335.483225838678;10341.431221282752;10351.534180961875;8046.758597242092;8059.153788852086;8122.7157049502985;8138.552379619177;8142.511449312941;5788.044972579477;5842.357340692435;5863.73613187399;5871.7651293949475;6034.607750496204;8899.15458031486;8958.507282099547;8974;8986.19124278818;9200.585973631336;9098.272138229058;9242.584083716383;9247.86128208064;9349.813003740022;9353.625854965725;6852.211995620568;7043.612601306977;7211.71153153868;7520.473566850268;7654.311111999724;7969.402294827795;7999.640016199169;8090.231428014329;8106.554139522383;8108.635111419882;7265.782026539212;7363.963180184279;7394;7461.030066091374;7522.924770752441;7327.450441217036;7331;7333.816654583465;7425.851482970203;7441.516301440389;6594.241662208908;6614.933850661432;6625.536212465081;6673.833154171185;6716.294789047275;5074.314967479343;5116.692998420107;5138.640295179302;5208.25013976523;5229.215617657382;5354.839354819362;5372.167314066326;5470.681363025712;5533.833984980457;5556.777728890961 06:40:29 INFO - PROCESS | 16854 | |4;prototype.html;357.06983308481404;357.9212573233888;359.086125809814;364.1769600702412;369.45689835941175;6288.402601752832;6302.495800335973;6327.7785277515295;6378.904316435245;6397.680115994205;6319.526035547329;6321.683915804214;6337.651429171406;6351.682415879199;6359.491240700744;4584.724916505003;4717.292406139072;4804.25534042224;4810.278458231258;4844.079624871263;4826.7586620669;4828.372311599487;4855.951440485585;4863.36776219091;4888.144574699431;4580.152671755719;4825.034993001396;4825.324454576362;4832.492588278233;4832.782524786376;4689.929651055237;4786.688865223767;4812.1578723723205;4822.469528351879;4833.32333473314;4226.006888381258;4241.36379543068;4246.065865509583;4258.467691538558;4263.893402664927;6093.878122437571;6096.847578810521;6108;6113.480354169901;6118.583159651913;5629.746661400247;5634.577406694514;5634.7182640867795;5644.3508996465525;5644.576656750719;6400.231972163324;6632.436242919358;6653.4677225821815;6656.301088385698;6667.066610674509;4591.081783643252;4614.353990441341;4617.445906491243;4622.0293738314995;4623.144718227139;6893.655317234168;6973.267806880255;6975.441964642867;6980.127484064492;7001.194862590816;4711.057788442326;4713;4714.528547145258;4715.7642117893965;4722.126406614719;4776.593989510861;4780.259059845729;4783;4786.305985632064;4788.784504697297;5526.50261476469;5536.339098270502;5542.196381524656;5543.667379957215;5549.556035517149;6501.674916254168;6722.327767223336;6737.157855268091;6741.089952856301;6747.392734653905;1659.5021493551885;1674.4809109176194;1675.1959059651435;1676.9413070542716;1677.547062293174;1028.4806172882647;1081.491698901515;1086.2721976275914;1105.4417519152776;1131.6378758797107;6407.359264073649;6440.098386225932;6449.903251451232;6467.191601049869;6475.190601174853;6890.2076261229595;6891.965540172267;6893.7931862044215;6893.862122757517;6894.517383783187;6446.709898054599;6453.290138084807;6456.0961465394885;6458.773942911976;6464.353564643592;3689.797061161662;3727.235916637083;3728.850845966131;3729.5524537055185;3732.626737326246;7080.327368899946;7246.855062898712;7280.599567023759;7295.234000429985;7297.4891757577525;7090.149182098181;7126.643667816692;7148.070750802362;7231.168415632164;7233.674484648098;7247.855042899112;7275.272472752682;7287.562746235243;7287.963560182166;7289.287017550977;6841.384275415037;6991.580505169706;6994.055802466602;6996.510244282851;7012.088428504262;6894.827629309308;6895.896561551681;6897.689603967934;6897.7585784497305;6898.206706228647;7250.564966102051;7268;7271.781846544613;7273.636318183963;7274.527155734861;4738.715677059387;4774.021325628169;4778.402699662543;4779.044191161712;4784.425868895755;6957.8956315654295;6994.720211191496;6997.7200911962955;7012.403945664676;7036.437085033287;6634.635095069818;6781.38967492928;6810.182778066664;6819.556728812611;6843.657817109224;6731.360520750717;6772.52592318533;6778.389944904982;6784.559003664746;6786.457083433214;6650.268470468342;6665.200175978914;6666.733330666719;6672.266050734318;6676.465882729467;6715.429188518835;6838.521303508706;6845.178578570603;6847.349501797321;6851.177858656793;6414.262359828679;6516.771912983023;6600.669966501559;6634.270230274569;6708 06:40:29 INFO - PROCESS | 16854 | |5;yui.html;926.6849271247777;941.7739742461811;943.9244860411166;952.2144231009419;978.2467500024981;15286.92356538217;15559.144247066435;15657.686846263068;15673.843261567396;15674.216289185551;14227.217503037355;14276.143431394124;14347.569572912804;14357.497487587936;14384.208868512227;763.6143747407565;915.7115508614766;938.5729493080632;940.6002448959165;944.1832814615343;921.5484412637793;925.8842644669417;930.0931591698074;930.1024511346583;930.5905401623298;984.5421878826344;989.9703008909744;991.9652812151576;992.1071036067525;992.4392718114242;796.4305521552089;965.8647789309503;979.8775153105862;980.9068138526828;981.0924894472585;720.531654424623;721.9241979592172;724.543537571332;725.6045455226914;726.8946002829613;14674.413023479048;14677.853221467756;14723.484678036324;14726.779098313427;14756.852431475763;14569.053011554215;14792.630184245372;14881.33034013472;14901.925490372587;15092.924535377362;12080;12115.697107572381;12360.320182389965;12372.13395062346;12479.31363774992;4053.898652533681;4064.1871625674985;4082.142750022499;4092.7953602319767;4132.297509423405;52922.20616690714;53112.46887531114;53234;53667.19499207515;53701.46298537004;11221;11883.584074557522;11894.167408281337;12205.694857628452;12229.082818788627;21301.573968520544;21414.78585214159;21667.024983875763;21756.89121554382;21774.23790167368;8557.187067228604;8568.400211985101;8684.913150868411;8691.174338437964;8800.295976322006;4976.527229913152;5109.156989096832;5140.640155189176;5170.948290517047;5299.4435584263865;3411.0790086676457;3445.1903802606867;3448.9482657760154;3451.9816654087103;3452;628.4030171337248;629.0972454527767;633.4425705379236;643.0482885329739;644.320242144542;729.3217307903594;757.8560073586001;783.4476693930765;800.5356893002045;800.8078061265371;10150.847737283946;10526.31578947366;10535.894641053492;10586.89413105859;10634.680959571226;715.7065603102807;718.7807718645759;789.3014682006351;846.7375113714768;855.149126619018;4709.105269998689;4792.904141917212;4833.589144922721;4863.003084367696;4873.512648735169;63716;63736;64572;64771.35228647653;64863;52091.218631720556;53999.730001349744;54917.45082549203;55339;55383.72308138514;49946;50250;50446.99106017859;51499.48500515022;51734.48265517372;10370.844437333597;10503.212259080752;10512.684619461428;10530.26288159852;10607.098396636373;36514.08714782152;36554.8172259137;37644.2471150581;37671.43492847664;38653.226935461695;48430.273545897544;48971.02057958892;49424.25863612121;49458.752706236235;49613.75193124011;12425.13024088305;12680;12719;12786.104972651825;12826.486940522274;11432.06713949806;13736.725265494833;14331.283435828376;14396.568102956928;14419.42322307096;12870;13280.867191328349;13314.866851331362;13710.588682339545;13773.793393098911;13245.602631921058;13360.93319533396;13593.932030339785;13660.65848353799;13718.65703357424;13244.27156506363;13348.666283342995;13366.064375493623;13645.79531307051;13708.93145534266;9880.308378413729;9939.204863611038;9970.800583988424;10028.946960569036;10104.89895101069;9670.951645241728;9946.801063978824;9992.300538962494;10035.548400321857;10054 06:40:29 INFO - PROCESS | 16854 | __end_tp_report 06:40:29 INFO - PROCESS | 16854 | __start_cc_report 06:40:29 INFO - PROCESS | 16854 | _x_x_mozilla_cycle_collect,839 06:40:29 INFO - PROCESS | 16854 | __end_cc_report 06:40:29 INFO - PROCESS | 16854 | __startTimestamp1462801229611__endTimestamp 06:40:29 INFO - PROCESS | 16854 | 06:40:29 INFO - PROCESS | 16854 | ------- Summary: start ------- 06:40:29 INFO - PROCESS | 16854 | Number of tests: 6 06:40:29 INFO - PROCESS | 16854 | 06:40:29 INFO - PROCESS | 16854 | [#0] dojo.html Cycles:165 Average:5545.98 Median:5747.86 stddev:602.37 (10.5%) stddev-sans-first:578.24 06:40:29 INFO - PROCESS | 16854 | Values: 3315.1 3405.6 3421.4 3434.4 3440.7 5602.7 5603.4 5613.9 5622.7 5634.1 5594.7 5606.9 5623.6 5643.6 5644.8 4931.4 4954.6 5126.8 5192.8 5250.6 5070.0 5104.4 5111.8 5141.2 5196.2 5192.2 5244.7 5245.6 5245.8 5247.6 5151.8 5170.4 5234.7 5235.2 5245.0 4971.8 5018.4 5076.6 5077.8 5109.6 5299.4 5472.5 5480.0 5494.5 5502.8 5734.2 5902.4 5903.8 5913.3 5914.3 5912.6 5979.9 6015.6 6024.3 6034.5 5587.8 5590.6 5590.8 5591.6 5593.3 5963.1 6035.7 6078.8 6082.1 6090.3 5882.7 5940.2 5940.9 5949.6 5976.9 5912.9 5923.9 5932.6 5933.0 5938.4 5773.6 5888.5 5895.7 5897.9 5907.4 5884.6 5923.4 5927.8 5936.4 5960.6 4519.2 4521.6 4521.7 4522.2 4549.8 3995.5 4009.5 4050.4 4058.9 4094.9 5580.8 5598.8 5616.6 5630.9 5659.3 5930.1 5932.1 5938.5 5943.6 5944.0 5491.4 5547.0 5642.9 5643.9 5646.9 5079.5 5108.1 5109.9 5112.3 5119.6 6125.4 6132.8 6149.8 6158.0 6158.7 5892.5 5953.6 6034.9 6050.2 6072.5 6155.5 6178.5 6182.0 6182.8 6186.7 5747.9 5830.6 5832.0 5842.7 5848.2 5896.4 5947.6 5954.2 5954.7 5993.7 5893.5 5897.6 5931.8 5936.3 5936.7 5733.7 5841.9 5846.6 5883.6 5905.1 5734.2 5742.4 5762.3 5769.8 5808.6 5821.0 5866.1 5877.7 5880.0 5880.1 5640.8 5729.8 5734.5 5775.8 5804.2 06:40:29 INFO - PROCESS | 16854 | 06:40:29 INFO - PROCESS | 16854 | [#1] ext.html Cycles:180 Average:57857.51 Median:36150.23 stddev:105091.15 (290.7%) stddev-sans-first:105298.22 06:40:29 INFO - PROCESS | 16854 | Values: 663.3 664.0 665.8 678.5 687.2 34008.5 40379.0 41156.8 41208.0 41251.2 44082.8 44975.0 44993.0 45026.5 45069.8 8264.1 8901.2 9094.5 10495.8 10679.9 10481.0 10614.1 10619.0 10620.6 10639.2 10607.6 10654.2 10664.0 10665.4 10678.1 8413.1 10900.2 11123.1 11126.6 11135.7 10558.4 10645.5 10661.2 10670.1 10672.8 40562.2 40984.8 40999.2 41085.8 41152.0 3883.3 3949.7 3960.3 4000.0 4043.8 32981.5 33493.2 34997.5 36142.0 36158.5 4320.8 4334.9 4416.2 4427.2 4428.6 320558.0 326482.0 327061.0 328121.0 330210.0 70125.6 71290.6 71317.3 71371.3 71389.6 73290.6 74926.3 74934.6 75013.0 75049.0 18368.2 19786.9 19873.4 20010.6 20019.6 14161.8 14318.3 14323.4 15388.9 15747.8 21786.0 21794.7 21851.3 21933.6 22080.6 7841.8 7934.6 7967.8 8114.7 8143.4 1131.3 1156.9 1168.4 1182.5 1188.9 33678.2 34577.5 34620.7 35151.3 35501.8 1186.1 1203.4 1296.7 1323.2 1348.0 18215.6 18442.6 18542.7 18571.3 18594.3 518559.0 520794.0 523305.0 524421.0 524464.0 65410.7 65993.0 66145.7 66224.0 66276.7 1388.5 1433.0 1452.0 1506.1 1528.6 31412.7 34019.3 34074.5 34490.8 34631.7 51984.7 52427.7 52982.2 52995.7 53045.0 308214.0 308634.0 309316.0 310534.0 311760.0 28533.7 31492.7 31884.2 32090.2 32194.7 46477.8 54174.5 54335.2 54548.0 55015.0 42598.6 42797.8 43116.1 43582.1 44593.8 42404.0 42810.1 42833.6 43982.8 44083.8 44201.0 44401.6 44968.3 45611.0 45822.3 37191.0 38505.2 38681.2 38848.6 38850.2 29013.6 29227.0 29950.1 30001.0 30022.2 06:40:29 INFO - PROCESS | 16854 | 06:40:29 INFO - PROCESS | 16854 | [#2] jquery.html Cycles:180 Average:31202.29 Median:426.42 stddev:95635.85 (22427.7%) stddev-sans-first:95876.20 06:40:29 INFO - PROCESS | 16854 | Values: 420.4 422.9 430.0 433.1 435.5 18972.5 19565.4 19571.0 19636.4 20459.1 12567.7 12781.4 14090.6 19634.0 19684.4 5370.3 5454.2 5468.2 5528.8 5757.8 5834.6 5942.3 5958.1 5968.8 5990.7 5672.3 5919.6 5934.7 5939.6 5944.0 5789.5 5792.9 5814.3 5819.8 5831.0 5624.7 5662.1 5666.2 5666.3 5730.7 13931.3 13993.7 14199.8 14204.3 14826.9 2550.7 2609.0 2624.6 2870.9 3114.4 10276.1 10278.5 10438.8 10484.5 10520.9 2011.1 2038.7 2134.8 2162.1 2219.2 78838.6 81908.6 83685.6 85770.0 87954.6 10892.4 11010.4 11092.6 11151.8 11215.4 14200.9 14340.1 14348.6 14426.2 14431.0 8763.8 8915.9 8941.8 8989.9 9025.0 8780.2 8823.5 8871.9 8895.1 9012.9 4873.1 4917.4 4927.6 4945.0 4983.0 1969.5 1978.6 1981.2 1984.9 2014.4 453.6 454.9 464.0 894.3 1073.2 11412.7 11474.5 11547.5 11596.8 11642.5 479.2 480.3 481.8 489.3 497.1 4959.4 6241.9 6274.3 6344.3 6356.6 559604.0 581785.0 583151.0 584072.0 590368.0 100137.0 102795.0 104423.0 104648.5 106876.5 503.4 506.8 509.4 510.6 511.0 11004.4 11098.1 11099.4 11132.6 11157.2 38550.4 39091.4 40097.2 40414.4 40520.4 63048.7 63239.0 63252.4 63492.4 63632.4 8824.2 8988.6 9009.6 9039.1 9146.2 9688.0 12942.5 13662.5 13738.5 13983.7 11564.2 11614.9 11946.8 11982.6 12544.8 11646.2 11661.2 11709.8 11947.5 12097.5 12084.8 12125.6 12160.6 12261.9 12327.6 8766.3 8884.2 8922.7 8990.4 9044.6 9196.5 12225.8 12355.3 12463.2 12477.4 06:40:29 INFO - PROCESS | 16854 | 06:40:29 INFO - PROCESS | 16854 | [#3] mootools.html Cycles:180 Average:5615.14 Median:4729.19 stddev:3047.63 (64.4%) stddev-sans-first:3039.94 06:40:29 INFO - PROCESS | 16854 | Values: 1429.9 1565.0 1596.4 1798.2 1915.8 8002.2 8235.3 8238.4 8252.3 8267.2 8152.6 8308.5 8323.3 8323.3 8335.4 2120.6 2168.6 2354.7 2411.5 2435.3 2415.9 2430.6 2436.6 2441.1 2442.9 2324.2 2338.9 2373.2 2374.0 2376.5 2087.0 2358.0 2435.6 2446.2 2448.5 2325.8 2328.1 2354.2 2360.1 2362.0 8125.6 8177.7 8177.9 8178.6 8188.7 5179.5 5292.0 5296.1 5296.8 5299.4 3643.1 3677.0 3704.2 3704.4 3716.2 1232.3 1265.4 1285.6 1307.8 1313.4 11695.4 11719.9 11724.5 11728.2 11759.9 4564.2 4649.3 4660.9 4709.9 4735.0 10001.3 10029.6 10053.8 10062.4 10064.4 5374.2 5380.5 5383.5 5384.3 5386.3 4255.1 4723.4 4835.8 4845.7 4850.0 4048.5 4057.1 4135.9 4136.0 4163.1 1332.9 1337.8 1355.2 1355.2 1355.6 1046.8 1048.4 1050.9 1063.2 1079.1 5731.8 5751.0 5787.8 5976.5 5991.4 446.6 462.0 465.2 470.7 472.4 4157.6 4180.1 4190.3 4195.4 4208.0 10028.7 10393.3 10397.3 10466.7 10492.3 10298.7 10309.2 10335.5 10341.4 10351.5 8046.8 8059.2 8122.7 8138.6 8142.5 5788.0 5842.4 5863.7 5871.8 6034.6 8899.2 8958.5 8974.0 8986.2 9200.6 9098.3 9242.6 9247.9 9349.8 9353.6 6852.2 7043.6 7211.7 7520.5 7654.3 7969.4 7999.6 8090.2 8106.6 8108.6 7265.8 7364.0 7394.0 7461.0 7522.9 7327.5 7331.0 7333.8 7425.9 7441.5 6594.2 6614.9 6625.5 6673.8 6716.3 5074.3 5116.7 5138.6 5208.3 5229.2 5354.8 5372.2 5470.7 5533.8 5556.8 06:40:29 INFO - PROCESS | 16854 | 06:40:29 INFO - PROCESS | 16854 | [#4] prototype.html Cycles:180 Average:5627.31 Median:6403.80 stddev:1716.48 (26.8%) stddev-sans-first:1675.09 06:40:29 INFO - PROCESS | 16854 | Values: 357.1 357.9 359.1 364.2 369.5 6288.4 6302.5 6327.8 6378.9 6397.7 6319.5 6321.7 6337.7 6351.7 6359.5 4584.7 4717.3 4804.3 4810.3 4844.1 4826.8 4828.4 4856.0 4863.4 4888.1 4580.2 4825.0 4825.3 4832.5 4832.8 4689.9 4786.7 4812.2 4822.5 4833.3 4226.0 4241.4 4246.1 4258.5 4263.9 6093.9 6096.8 6108.0 6113.5 6118.6 5629.7 5634.6 5634.7 5644.4 5644.6 6400.2 6632.4 6653.5 6656.3 6667.1 4591.1 4614.4 4617.4 4622.0 4623.1 6893.7 6973.3 6975.4 6980.1 7001.2 4711.1 4713.0 4714.5 4715.8 4722.1 4776.6 4780.3 4783.0 4786.3 4788.8 5526.5 5536.3 5542.2 5543.7 5549.6 6501.7 6722.3 6737.2 6741.1 6747.4 1659.5 1674.5 1675.2 1676.9 1677.5 1028.5 1081.5 1086.3 1105.4 1131.6 6407.4 6440.1 6449.9 6467.2 6475.2 6890.2 6892.0 6893.8 6893.9 6894.5 6446.7 6453.3 6456.1 6458.8 6464.4 3689.8 3727.2 3728.9 3729.6 3732.6 7080.3 7246.9 7280.6 7295.2 7297.5 7090.1 7126.6 7148.1 7231.2 7233.7 7247.9 7275.3 7287.6 7288.0 7289.3 6841.4 6991.6 6994.1 6996.5 7012.1 6894.8 6895.9 6897.7 6897.8 6898.2 7250.6 7268.0 7271.8 7273.6 7274.5 4738.7 4774.0 4778.4 4779.0 4784.4 6957.9 6994.7 6997.7 7012.4 7036.4 6634.6 6781.4 6810.2 6819.6 6843.7 6731.4 6772.5 6778.4 6784.6 6786.5 6650.3 6665.2 6666.7 6672.3 6676.5 6715.4 6838.5 6845.2 6847.3 6851.2 6414.3 6516.8 6600.7 6634.3 6708.0 06:40:29 INFO - PROCESS | 16854 | 06:40:29 INFO - PROCESS | 16854 | [#5] yui.html Cycles:180 Average:15443.64 Median:4813.25 stddev:17419.03 (361.9%) stddev-sans-first:17433.78 06:40:29 INFO - PROCESS | 16854 | Values: 926.7 941.8 943.9 952.2 978.2 15286.9 15559.1 15657.7 15673.8 15674.2 14227.2 14276.1 14347.6 14357.5 14384.2 763.6 915.7 938.6 940.6 944.2 921.5 925.9 930.1 930.1 930.6 984.5 990.0 992.0 992.1 992.4 796.4 965.9 979.9 980.9 981.1 720.5 721.9 724.5 725.6 726.9 14674.4 14677.9 14723.5 14726.8 14756.9 14569.1 14792.6 14881.3 14901.9 15092.9 12080.0 12115.7 12360.3 12372.1 12479.3 4053.9 4064.2 4082.1 4092.8 4132.3 52922.2 53112.5 53234.0 53667.2 53701.5 11221.0 11883.6 11894.2 12205.7 12229.1 21301.6 21414.8 21667.0 21756.9 21774.2 8557.2 8568.4 8684.9 8691.2 8800.3 4976.5 5109.2 5140.6 5170.9 5299.4 3411.1 3445.2 3448.9 3452.0 3452.0 628.4 629.1 633.4 643.0 644.3 729.3 757.9 783.4 800.5 800.8 10150.8 10526.3 10535.9 10586.9 10634.7 715.7 718.8 789.3 846.7 855.1 4709.1 4792.9 4833.6 4863.0 4873.5 63716.0 63736.0 64572.0 64771.4 64863.0 52091.2 53999.7 54917.5 55339.0 55383.7 49946.0 50250.0 50447.0 51499.5 51734.5 10370.8 10503.2 10512.7 10530.3 10607.1 36514.1 36554.8 37644.2 37671.4 38653.2 48430.3 48971.0 49424.3 49458.8 49613.8 12425.1 12680.0 12719.0 12786.1 12826.5 11432.1 13736.7 14331.3 14396.6 14419.4 12870.0 13280.9 13314.9 13710.6 13773.8 13245.6 13360.9 13593.9 13660.7 13718.7 13244.3 13348.7 13366.1 13645.8 13708.9 9880.3 9939.2 9970.8 10028.9 10104.9 9671.0 9946.8 9992.3 10035.5 10054.0 06:40:29 INFO - PROCESS | 16854 | -------- Summary: end -------- 06:40:29 INFO - PROCESS | 16854 | 06:40:30 INFO - TEST-INFO | 16854: exit 0 06:40:30 INFO - TEST-OK | dromaeo_css | took 1110735ms 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 17041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgbqL2t/profile http://localhost:45979/getInfo.html) 06:40:33 INFO - PROCESS | 17041 | __metrics Screen width/height:1600/1200 06:40:33 INFO - PROCESS | 17041 | colorDepth:24 06:40:33 INFO - PROCESS | 17041 | Browser inner width/height: 1024/697 06:40:33 INFO - PROCESS | 17041 | __metrics 06:40:34 ERROR - PROCESS | 17041 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:40:35 INFO - TEST-INFO | 17041: exit 0 06:40:35 INFO - Browser initialized. 06:40:35 INFO - Running cycle 1/1 for kraken test... 06:40:35 INFO - TEST-INFO | started process 17132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgbqL2t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:47 INFO - PROCESS | 17132 | RSS: Main: 142024704 06:40:47 INFO - PROCESS | 17132 | 06:40:49 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45979/tests/kraken/driver.html?testName=audio-beat-detection) 06:40:50 INFO - PROCESS | 17132 | RSS: Main: 196898816 06:40:50 INFO - PROCESS | 17132 | 06:40:53 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45979/tests/kraken/driver.html?testName=audio-dft) 06:40:53 INFO - PROCESS | 17132 | RSS: Main: 182415360 06:40:53 INFO - PROCESS | 17132 | 06:40:56 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45979/tests/kraken/driver.html?testName=audio-fft) 06:40:57 INFO - PROCESS | 17132 | RSS: Main: 272801792 06:40:57 INFO - PROCESS | 17132 | 06:40:59 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45979/tests/kraken/driver.html?testName=audio-oscillator) 06:40:59 INFO - PROCESS | 17132 | RSS: Main: 178610176 06:40:59 INFO - PROCESS | 17132 | 06:41:01 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45979/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:02 INFO - PROCESS | 17132 | RSS: Main: 176742400 06:41:02 INFO - PROCESS | 17132 | 06:41:05 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45979/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:05 INFO - PROCESS | 17132 | RSS: Main: 212819968 06:41:05 INFO - PROCESS | 17132 | 06:41:09 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45979/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:09 INFO - PROCESS | 17132 | RSS: Main: 212066304 06:41:09 INFO - PROCESS | 17132 | 06:41:12 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45979/tests/kraken/driver.html?testName=json-parse-financial) 06:41:13 INFO - PROCESS | 17132 | RSS: Main: 212668416 06:41:13 INFO - PROCESS | 17132 | 06:41:14 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45979/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:15 INFO - PROCESS | 17132 | RSS: Main: 192360448 06:41:15 INFO - PROCESS | 17132 | 06:41:17 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45979/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:41:17 INFO - PROCESS | 17132 | RSS: Main: 198213632 06:41:17 INFO - PROCESS | 17132 | 06:41:19 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45979/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:41:20 INFO - PROCESS | 17132 | RSS: Main: 209723392 06:41:20 INFO - PROCESS | 17132 | 06:41:22 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:23 INFO - PROCESS | 17132 | RSS: Main: 214077440 06:41:23 INFO - PROCESS | 17132 | 06:41:25 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:26 INFO - PROCESS | 17132 | RSS: Main: 210690048 06:41:26 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | Cycle 1(1): loaded http://localhost:45979/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45979/tests/kraken/driver.html?testName=ai-astar) 06:41:28 INFO - PROCESS | 17132 | RSS: Main: 274759680 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | __start_tp_report 06:41:28 INFO - PROCESS | 17132 | _x_x_mozilla_page_load 06:41:28 INFO - PROCESS | 17132 | _x_x_mozilla_page_load_details 06:41:28 INFO - PROCESS | 17132 | |i|pagename|runs| 06:41:28 INFO - PROCESS | 17132 | |0;ai-astar;111;111;112;110;110;112;105;109;109;110 06:41:28 INFO - PROCESS | 17132 | |1;audio-beat-detection;167;126;151;174;131;147;159;130;174;125 06:41:28 INFO - PROCESS | 17132 | |2;audio-dft;160;159;162;167;160;160;159;160;159;159 06:41:28 INFO - PROCESS | 17132 | |3;audio-fft;75;73;75;176;77;77;73;76;161;75 06:41:28 INFO - PROCESS | 17132 | |4;audio-oscillator;92;92;154;93;92;92;143;91;92;142 06:41:28 INFO - PROCESS | 17132 | |5;imaging-gaussian-blur;117;116;116;117;116;118;119;118;117;117 06:41:28 INFO - PROCESS | 17132 | |6;imaging-darkroom;146;146;145;145;145;145;145;146;145;145 06:41:28 INFO - PROCESS | 17132 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 06:41:28 INFO - PROCESS | 17132 | |8;json-parse-financial;53;53;54;52;53;53;55;73;53;51 06:41:28 INFO - PROCESS | 17132 | |9;json-stringify-tinderbox;57;56;57;57;57;57;57;56;57;57 06:41:28 INFO - PROCESS | 17132 | |10;stanford-crypto-aes;72;73;72;72;73;72;73;73;81;73 06:41:28 INFO - PROCESS | 17132 | |11;stanford-crypto-ccm;114;122;116;111;119;118;109;112;139;133 06:41:28 INFO - PROCESS | 17132 | |12;stanford-crypto-pbkdf2;159;161;158;159;159;161;156;157;164;159 06:41:28 INFO - PROCESS | 17132 | |13;stanford-crypto-sha256-iterative;68;67;67;68;66;65;67;67;68;66 06:41:28 INFO - PROCESS | 17132 | __end_tp_report 06:41:28 INFO - PROCESS | 17132 | __start_cc_report 06:41:28 INFO - PROCESS | 17132 | _x_x_mozilla_cycle_collect,1554 06:41:28 INFO - PROCESS | 17132 | __end_cc_report 06:41:28 INFO - PROCESS | 17132 | __startTimestamp1462801288412__endTimestamp 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | ------- Summary: start ------- 06:41:28 INFO - PROCESS | 17132 | Number of tests: 14 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.02 (1.8%) stddev-sans-first:2.11 06:41:28 INFO - PROCESS | 17132 | Values: 111.0 111.0 112.0 110.0 110.0 112.0 105.0 109.0 109.0 110.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:155.00 stddev:19.63 (12.7%) stddev-sans-first:19.63 06:41:28 INFO - PROCESS | 17132 | Values: 167.0 126.0 151.0 174.0 131.0 147.0 159.0 130.0 174.0 125.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.00 stddev:2.46 (1.5%) stddev-sans-first:2.60 06:41:28 INFO - PROCESS | 17132 | Values: 160.0 159.0 162.0 167.0 160.0 160.0 159.0 160.0 159.0 159.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:39.55 (52.7%) stddev-sans-first:41.36 06:41:28 INFO - PROCESS | 17132 | Values: 75.0 73.0 75.0 176.0 77.0 77.0 73.0 76.0 161.0 75.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.00 stddev:26.44 (28.7%) stddev-sans-first:27.37 06:41:28 INFO - PROCESS | 17132 | Values: 92.0 92.0 154.0 93.0 92.0 92.0 143.0 91.0 92.0 142.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 06:41:28 INFO - PROCESS | 17132 | Values: 117.0 116.0 116.0 117.0 116.0 118.0 119.0 118.0 117.0 117.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 06:41:28 INFO - PROCESS | 17132 | Values: 146.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:41:28 INFO - PROCESS | 17132 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:53.00 stddev:6.41 (12.1%) stddev-sans-first:6.76 06:41:28 INFO - PROCESS | 17132 | Values: 53.0 53.0 54.0 52.0 53.0 53.0 55.0 73.0 53.0 51.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 06:41:28 INFO - PROCESS | 17132 | Values: 57.0 56.0 57.0 57.0 57.0 57.0 57.0 56.0 57.0 57.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:73.00 stddev:2.72 (3.7%) stddev-sans-first:2.83 06:41:28 INFO - PROCESS | 17132 | Values: 72.0 73.0 72.0 72.0 73.0 72.0 73.0 73.0 81.0 73.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:118.50 stddev:9.73 (8.2%) stddev-sans-first:10.13 06:41:28 INFO - PROCESS | 17132 | Values: 114.0 122.0 116.0 111.0 119.0 118.0 109.0 112.0 139.0 133.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.00 stddev:2.26 (1.4%) stddev-sans-first:2.40 06:41:28 INFO - PROCESS | 17132 | Values: 159.0 161.0 158.0 159.0 159.0 161.0 156.0 157.0 164.0 159.0 06:41:28 INFO - PROCESS | 17132 | 06:41:28 INFO - PROCESS | 17132 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 06:41:28 INFO - PROCESS | 17132 | Values: 68.0 67.0 67.0 68.0 66.0 65.0 67.0 67.0 68.0 66.0 06:41:28 INFO - PROCESS | 17132 | -------- Summary: end -------- 06:41:28 INFO - PROCESS | 17132 | 06:41:29 INFO - TEST-INFO | 17132: exit 0 06:41:29 INFO - TEST-OK | kraken | took 59053ms 06:41:29 INFO - SUITE-END | took 1169s 06:41:29 INFO - Completed test suite (00:19:30) 06:41:29 INFO - javascript benchmark 06:41:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3315.1380641033334, 3405.6083550391695, 3421.4354631485808, 3434.3646425411316, 3440.7419443541726, 5602.747876345564, 5603.41164177761, 5613.943860561393, 5622.746976386057, 5634.0703783875615, 5594.720263986795, 5606.859828504289, 5623.578231632623, 5643.6049476536655, 5644.8024319148835, 4931.43288521821, 4954.628402869781, 5126.820561280365, 5192.844214673566, 5250.606204534656, 5070.036693028332, 5104.387473503166, 5111.7699703513435, 5141.15170996785, 5196.246544251081, 5192.221166824968, 5244.659097158673, 5245.554127899133, 5245.816396426126, 5247.632665713401, 5151.793928242866, 5170.405403378584, 5234.7120908350025, 5235.240890070956, 5245.029669511153, 4971.751412429364, 5018.447970723218, 5076.619253555961, 5077.822276220351, 5109.6167787415725, 5299.3905700844125, 5472.50747432729, 5480.0, 5494.478024587658, 5502.779888804483, 5734.225879506255, 5902.380250073724, 5903.76384944606, 5913.319968203668, 5914.349421563625, 5912.645241285493, 5979.880402391971, 6015.639061656315, 6024.337322894478, 6034.48706859913, 5587.804426845041, 5590.608657394025, 5590.8043218487155, 5591.552675785927, 5593.272874526327, 5963.075723262901, 6035.698215089228, 6078.848028799315, 6082.148499210114, 6090.33006369299, 5882.705864706748, 5940.168376427304, 5940.851478713067, 5949.553783466257, 5976.910346344808, 5912.881742365129, 5923.911141332884, 5932.614380065368, 5933.0, 5938.376470470625, 5773.566982476331, 5888.5289176865745, 5895.67573783446, 5897.852553686193, 5907.409259074058, 5884.558658100574, 5923.437273459014, 5927.8221653350465, 5936.406359364116, 5960.642361458326, 4519.209138400766, 4521.615662668644, 4521.728696278234, 4522.186006518792, 4549.795259213343, 3995.4805875236034, 4009.4587230724064, 4050.432939388488, 4058.918821623551, 4094.9385759213637, 5580.804671836466, 5598.832035038955, 5616.634918730269, 5630.887382252332, 5659.292588426447, 5930.140129681258, 5932.139839723216, 5938.524918006549, 5943.58394912352, 5943.970280148572, 5491.423400542965, 5546.972265138648, 5642.887142257132, 5643.887122257532, 5646.85882852932, 5079.517445842639, 5108.131617625013, 5109.8722531936255, 5112.258722485219, 5119.641625086283, 6125.418085281891, 6132.846678833065, 6149.7847575335545, 6158.0, 6158.692065396802, 5892.528597712173, 5953.642781433128, 6034.879302414015, 6050.183225264533, 6072.483838873745, 6155.4767844731905, 6178.474829639351, 6181.96909015452, 6182.783602573888, 6186.690665466619, 5747.856303592276, 5830.62100963436, 5832.0, 5842.7078646066675, 5848.152017957457, 5896.380880007709, 5947.6431414115295, 5954.166416701579, 5954.732037058429, 5993.730282137227, 5893.469587737124, 5897.616654917417, 5931.822045338647, 5936.257967754031, 5936.673482958478, 5733.655980641175, 5841.883162336814, 5846.619969701956, 5883.61756485827, 5905.084711869667, 5734.197212390352, 5742.425757424224, 5762.30852297727, 5769.826905192851, 5808.564357673107, 5821.0, 5866.149408335853, 5877.73550190251, 5880.029795083934, 5880.088586269135, 5640.802571909963, 5729.799457018984, 5734.54123670097, 5775.797847075332, 5804.245448091721], "value": 5507.621320926834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.2803408301993, 663.9973639803894, 665.8069159943617, 678.5182520410508, 687.1513680604454, 34008.4898726519, 40379.0, 41156.79421602888, 41207.969800754996, 41251.174976500486, 44082.77958610203, 44975.0, 44993.0, 45026.549734502645, 45069.774651126696, 8264.090949995525, 8901.154390332924, 9094.454332740024, 10495.790084198312, 10679.893201068006, 10481.0, 10614.097801686867, 10619.0, 10620.628278010272, 10639.202059845504, 10607.575696972111, 10654.200934929873, 10664.0, 10665.413402262911, 10678.092362149187, 8413.074561798197, 10900.236983411203, 11123.054540363997, 11126.61056863006, 11135.721606959809, 10558.366498010144, 10645.52095155712, 10661.200409969206, 10670.093042091432, 10672.78654426907, 40562.188756224714, 40984.795076024726, 40999.18001639951, 41085.794571026956, 41152.0, 3883.2815929053218, 3949.7037722170667, 3960.32674445345, 3999.960000399988, 4043.7978101094827, 32981.50527742086, 33493.162670933176, 34997.47503787445, 36142.0, 36158.45762313568, 4320.82716691332, 4334.869953901388, 4416.205083085043, 4427.180971520247, 4428.623566996809, 320558.0, 326482.0, 327061.0, 328121.0, 330210.0, 70125.64937175282, 71290.64354678194, 71317.28682713106, 71371.2862871375, 71389.64305178545, 73290.63354683193, 74926.25073749301, 74934.62532687411, 75013.0, 75049.0, 18368.173432195585, 19786.90106549487, 19873.403797886087, 20010.59978800445, 20019.599608007757, 14161.78757318641, 14318.284085795669, 14323.35544900482, 15388.923055384876, 15747.842521574867, 21786.0, 21794.673079903812, 21851.344459666234, 21933.561328773336, 22080.558388832134, 7841.843163136706, 7934.56359900211, 7967.84064318722, 8114.715984940499, 8143.42995990275, 1131.3099009604134, 1156.8727439981594, 1168.4041139019162, 1182.5388098641536, 1188.9464974076188, 33678.158046049044, 34577.48133777995, 34620.653793461744, 35151.29697406037, 35501.82249088738, 1186.1341220908785, 1203.4223572684984, 1296.6804979253143, 1323.2259128409987, 1347.9595612131652, 18215.63568728618, 18442.63114737698, 18542.721859172125, 18571.25714971413, 18594.349197778014, 518559.0, 520794.0, 523305.0, 524421.0, 524464.0, 65410.672946634964, 65993.0, 66145.66927165333, 66224.0, 66276.6686166566, 1388.5417812121975, 1432.9754225728445, 1452.0271418149864, 1506.0737646347418, 1528.625486755752, 31412.685873140977, 34019.31961360809, 34074.48888266629, 34490.82754586211, 34631.65368346284, 51984.74007629938, 52427.73786131045, 52982.20526692025, 52995.73502132465, 53045.0, 308214.0, 308634.0, 309316.0, 310534.0, 311760.0, 28533.714662853105, 31492.740290388127, 31884.202894927814, 32090.19774505656, 32194.67805321917, 46477.767611161726, 54174.45825541694, 54335.184972224655, 54548.0, 55015.0, 42598.5740142607, 42797.786011069744, 43116.13767724565, 43582.12835743204, 44593.77703111593, 42404.0, 42810.14379712326, 42833.57166428296, 43982.78008610065, 44083.779581103176, 44201.0, 44401.55598443974, 44968.32547511724, 45611.0, 45822.31266530938, 37191.0, 38505.229895401375, 38681.22637547177, 38848.6115138845, 38850.2229955405, 29013.56479652849, 29226.950602548644, 29950.101496955125, 30001.0, 30022.24944376408], "value": 21706.632675618643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.4072258116057, 422.88582082837615, 429.9505556860962, 433.08402728229805, 435.50135095315864, 18972.525686857836, 19565.413037608876, 19571.021448927568, 19636.41090767276, 20459.079341429635, 12567.685807854808, 12781.360931953412, 14090.64773380666, 19634.0, 19684.409467715956, 5370.275012873251, 5454.181872719084, 5468.152436372348, 5528.806491772789, 5757.827265182052, 5834.5915785895, 5942.2869255689375, 5958.076498142795, 5968.761249550034, 5990.73041713124, 5672.290963629546, 5919.615225010382, 5934.673592952386, 5939.643621382731, 5944.048952167654, 5789.536837053026, 5792.942070579283, 5814.302283725938, 5819.82540523785, 5830.970845145789, 5624.71876406178, 5662.094064949588, 5666.206731057655, 5666.348369937468, 5730.68481233532, 13931.303434828218, 13993.650158746113, 14199.78700319496, 14204.289785510684, 14826.925865370604, 2550.744925507453, 2609.021616893665, 2624.6325514427995, 2870.899518516863, 3114.4082624301536, 10276.07515323617, 10278.486075696186, 10438.843417348746, 10484.494095243745, 10520.94739526305, 2011.0849563448742, 2038.66362050263, 2134.8398870084807, 2162.13514594162, 2219.212179676224, 78838.60580697117, 81908.59045704734, 83685.58157209236, 85770.0, 87954.5602271991, 10892.420599013258, 11010.449477526092, 11092.55629774816, 11151.832722509169, 11215.383153926612, 14200.85799142016, 14340.067895586753, 14348.641283967985, 14426.206558639165, 14431.0, 8763.824723505622, 8915.910840891507, 8941.821163576693, 8989.910100899038, 9024.954875225712, 8780.209781119602, 8823.514706691194, 8871.911280887238, 8895.066018068139, 9012.909870901207, 4873.074115918035, 4917.409910810726, 4927.630427717935, 4944.950550494449, 4983.0033993201505, 1969.5076230942263, 1978.6339527187517, 1981.1773168684845, 1984.9305274315618, 2014.3755435814944, 453.5849697526792, 454.92948592968145, 463.9605633521121, 894.2667013049368, 1073.2004656530935, 11412.657620271406, 11474.48364823585, 11547.480363383667, 11596.76806463866, 11642.476088576035, 479.15429267343166, 480.28917202540435, 481.76634332348783, 489.33939182104587, 497.0580749479716, 4959.355283813081, 6241.906371404432, 6274.2784579773, 6344.333844946306, 6356.555041147168, 559604.0, 581785.0, 583151.0, 584072.0, 590368.0, 100137.0, 102795.0, 104423.0, 104648.47675761572, 106876.46561767296, 503.43363715819703, 506.8200788720025, 509.37347063112577, 510.57112025898425, 511.0009930585696, 11004.449777510932, 11098.05666518355, 11099.389533575732, 11132.610358637408, 11157.218994670295, 38550.42174367331, 39091.41362879616, 40097.1980560393, 40414.39378409385, 40520.392194116524, 63048.68475657592, 63239.0, 63252.367476326486, 63492.36507635049, 63632.36367636264, 8824.161704638049, 8988.640454381752, 9009.594568244576, 9039.143073308478, 9146.222571081267, 9688.031196880256, 12942.482300707867, 13662.453501859814, 13738.450461981409, 13983.720325593635, 11564.248323858923, 11614.88385116138, 11946.76106477883, 11982.58060967862, 12544.811827822408, 11646.184767066225, 11661.183717139718, 11709.771901122167, 11947.462364193458, 12097.516099356279, 12084.818727718915, 12125.575604853788, 12160.574379896661, 12261.938690306491, 12327.568535101229, 8766.254868336262, 8884.156005179497, 8922.68770593026, 8990.370674052754, 9044.638214471348, 9196.494192819191, 12225.816612750994, 12355.32045737493, 12463.189892656948, 12477.438515266653], "value": 8510.646090028647, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.89990700651, 1564.9687006259876, 1596.3614554178323, 1798.1548672124106, 1915.7892631810498, 8002.239787220212, 8235.299999500043, 8238.382121340894, 8252.257296843283, 8267.173282671738, 8152.592370381487, 8308.459950103239, 8323.25090741833, 8323.33413326934, 8335.416520843528, 2120.5546835164632, 2168.555446133547, 2354.7174339079334, 2411.5176964607062, 2435.2694191742494, 2415.855048697075, 2430.647556104364, 2436.6223235398543, 2441.07239249086, 2442.926712198637, 2324.1516846351046, 2338.871362075085, 2373.1575290771784, 2374.03851440167, 2376.512814872947, 2087.039961617658, 2357.964630530535, 2435.57377458944, 2446.192756390387, 2448.5347783920997, 2325.7906788389128, 2328.1153161798406, 2354.2466410748566, 2360.055977608953, 2362.0315670574983, 8125.634346454423, 8177.713780017671, 8177.9182208178345, 8178.591070446454, 8188.713395031145, 5179.507946745053, 5292.02097611943, 5296.126139187029, 5296.814611488618, 5299.3905700844125, 3643.0710168906758, 3676.9632303677154, 3704.1850792825535, 3704.3887758519813, 3716.163863130801, 1232.3099064523894, 1265.367316341829, 1285.620741881138, 1307.8430588329365, 1313.441787240419, 11695.35675537845, 11719.94140029303, 11724.472398741991, 11728.237664551862, 11759.882401175964, 4564.2012647786505, 4649.325847752057, 4660.930086048712, 4709.927631841979, 4734.95265047352, 10001.34991225568, 10029.598816047277, 10053.849192262122, 10062.446565438824, 10064.446455444875, 5374.193870919394, 5380.461953804588, 5383.515483606494, 5384.273123128406, 5386.299781028441, 4255.063885945087, 4723.4331880174595, 4835.8065677372515, 4845.709257444564, 4849.95150048495, 4048.5344185419053, 4057.091758847126, 4135.875923722293, 4135.97932010338, 4163.10493243954, 1332.8733770291806, 1337.759203343388, 1355.153029356652, 1355.1733442600007, 1355.6272025192955, 1046.837740150278, 1048.3605000949415, 1050.8686414198226, 1063.2238465919922, 1079.1420820447606, 5731.77072917087, 5751.0, 5787.768489260467, 5976.462118409364, 5991.400859913973, 446.639981257073, 461.97690115494765, 465.20450030447637, 470.67288234677255, 472.3788218492671, 4157.563455837154, 4180.143070670505, 4190.266703326905, 4195.412642230091, 4207.97896010518, 10028.749281268027, 10393.324433911772, 10397.324173928822, 10466.738331541772, 10492.317999330018, 10298.691039268833, 10309.175265978703, 10335.483225838678, 10341.431221282752, 10351.534180961875, 8046.758597242092, 8059.153788852086, 8122.7157049502985, 8138.552379619177, 8142.511449312941, 5788.044972579477, 5842.357340692435, 5863.73613187399, 5871.7651293949475, 6034.607750496204, 8899.15458031486, 8958.507282099547, 8974.0, 8986.19124278818, 9200.585973631336, 9098.272138229058, 9242.584083716383, 9247.86128208064, 9349.813003740022, 9353.625854965725, 6852.211995620568, 7043.612601306977, 7211.71153153868, 7520.473566850268, 7654.311111999724, 7969.402294827795, 7999.640016199169, 8090.231428014329, 8106.554139522383, 8108.635111419882, 7265.782026539212, 7363.963180184279, 7394.0, 7461.030066091374, 7522.924770752441, 7327.450441217036, 7331.0, 7333.816654583465, 7425.851482970203, 7441.516301440389, 6594.241662208908, 6614.933850661432, 6625.536212465081, 6673.833154171185, 6716.294789047275, 5074.314967479343, 5116.692998420107, 5138.640295179302, 5208.25013976523, 5229.215617657382, 5354.839354819362, 5372.167314066326, 5470.681363025712, 5533.833984980457, 5556.777728890961], "value": 4522.506419507504, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.06983308481404, 357.9212573233888, 359.086125809814, 364.1769600702412, 369.45689835941175, 6288.402601752832, 6302.495800335973, 6327.7785277515295, 6378.904316435245, 6397.680115994205, 6319.526035547329, 6321.683915804214, 6337.651429171406, 6351.682415879199, 6359.491240700744, 4584.724916505003, 4717.292406139072, 4804.25534042224, 4810.278458231258, 4844.079624871263, 4826.7586620669, 4828.372311599487, 4855.951440485585, 4863.36776219091, 4888.144574699431, 4580.152671755719, 4825.034993001396, 4825.324454576362, 4832.492588278233, 4832.782524786376, 4689.929651055237, 4786.688865223767, 4812.1578723723205, 4822.469528351879, 4833.32333473314, 4226.006888381258, 4241.36379543068, 4246.065865509583, 4258.467691538558, 4263.893402664927, 6093.878122437571, 6096.847578810521, 6108.0, 6113.480354169901, 6118.583159651913, 5629.746661400247, 5634.577406694514, 5634.7182640867795, 5644.3508996465525, 5644.576656750719, 6400.231972163324, 6632.436242919358, 6653.4677225821815, 6656.301088385698, 6667.066610674509, 4591.081783643252, 4614.353990441341, 4617.445906491243, 4622.0293738314995, 4623.144718227139, 6893.655317234168, 6973.267806880255, 6975.441964642867, 6980.127484064492, 7001.194862590816, 4711.057788442326, 4713.0, 4714.528547145258, 4715.7642117893965, 4722.126406614719, 4776.593989510861, 4780.259059845729, 4783.0, 4786.305985632064, 4788.784504697297, 5526.50261476469, 5536.339098270502, 5542.196381524656, 5543.667379957215, 5549.556035517149, 6501.674916254168, 6722.327767223336, 6737.157855268091, 6741.089952856301, 6747.392734653905, 1659.5021493551885, 1674.4809109176194, 1675.1959059651435, 1676.9413070542716, 1677.547062293174, 1028.4806172882647, 1081.491698901515, 1086.2721976275914, 1105.4417519152776, 1131.6378758797107, 6407.359264073649, 6440.098386225932, 6449.903251451232, 6467.191601049869, 6475.190601174853, 6890.2076261229595, 6891.965540172267, 6893.7931862044215, 6893.862122757517, 6894.517383783187, 6446.709898054599, 6453.290138084807, 6456.0961465394885, 6458.773942911976, 6464.353564643592, 3689.797061161662, 3727.235916637083, 3728.850845966131, 3729.5524537055185, 3732.626737326246, 7080.327368899946, 7246.855062898712, 7280.599567023759, 7295.234000429985, 7297.4891757577525, 7090.149182098181, 7126.643667816692, 7148.070750802362, 7231.168415632164, 7233.674484648098, 7247.855042899112, 7275.272472752682, 7287.562746235243, 7287.963560182166, 7289.287017550977, 6841.384275415037, 6991.580505169706, 6994.055802466602, 6996.510244282851, 7012.088428504262, 6894.827629309308, 6895.896561551681, 6897.689603967934, 6897.7585784497305, 6898.206706228647, 7250.564966102051, 7268.0, 7271.781846544613, 7273.636318183963, 7274.527155734861, 4738.715677059387, 4774.021325628169, 4778.402699662543, 4779.044191161712, 4784.425868895755, 6957.8956315654295, 6994.720211191496, 6997.7200911962955, 7012.403945664676, 7036.437085033287, 6634.635095069818, 6781.38967492928, 6810.182778066664, 6819.556728812611, 6843.657817109224, 6731.360520750717, 6772.52592318533, 6778.389944904982, 6784.559003664746, 6786.457083433214, 6650.268470468342, 6665.200175978914, 6666.733330666719, 6672.266050734318, 6676.465882729467, 6715.429188518835, 6838.521303508706, 6845.178578570603, 6847.349501797321, 6851.177858656793, 6414.262359828679, 6516.771912983023, 6600.669966501559, 6634.270230274569, 6708.0], "value": 5066.1986934089555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [926.6849271247777, 941.7739742461811, 943.9244860411166, 952.2144231009419, 978.2467500024981, 15286.92356538217, 15559.144247066435, 15657.686846263068, 15673.843261567396, 15674.216289185551, 14227.217503037355, 14276.143431394124, 14347.569572912804, 14357.497487587936, 14384.208868512227, 763.6143747407565, 915.7115508614766, 938.5729493080632, 940.6002448959165, 944.1832814615343, 921.5484412637793, 925.8842644669417, 930.0931591698074, 930.1024511346583, 930.5905401623298, 984.5421878826344, 989.9703008909744, 991.9652812151576, 992.1071036067525, 992.4392718114242, 796.4305521552089, 965.8647789309503, 979.8775153105862, 980.9068138526828, 981.0924894472585, 720.531654424623, 721.9241979592172, 724.543537571332, 725.6045455226914, 726.8946002829613, 14674.413023479048, 14677.853221467756, 14723.484678036324, 14726.779098313427, 14756.852431475763, 14569.053011554215, 14792.630184245372, 14881.33034013472, 14901.925490372587, 15092.924535377362, 12080.0, 12115.697107572381, 12360.320182389965, 12372.13395062346, 12479.31363774992, 4053.898652533681, 4064.1871625674985, 4082.142750022499, 4092.7953602319767, 4132.297509423405, 52922.20616690714, 53112.46887531114, 53234.0, 53667.19499207515, 53701.46298537004, 11221.0, 11883.584074557522, 11894.167408281337, 12205.694857628452, 12229.082818788627, 21301.573968520544, 21414.78585214159, 21667.024983875763, 21756.89121554382, 21774.23790167368, 8557.187067228604, 8568.400211985101, 8684.913150868411, 8691.174338437964, 8800.295976322006, 4976.527229913152, 5109.156989096832, 5140.640155189176, 5170.948290517047, 5299.4435584263865, 3411.0790086676457, 3445.1903802606867, 3448.9482657760154, 3451.9816654087103, 3452.0, 628.4030171337248, 629.0972454527767, 633.4425705379236, 643.0482885329739, 644.320242144542, 729.3217307903594, 757.8560073586001, 783.4476693930765, 800.5356893002045, 800.8078061265371, 10150.847737283946, 10526.31578947366, 10535.894641053492, 10586.89413105859, 10634.680959571226, 715.7065603102807, 718.7807718645759, 789.3014682006351, 846.7375113714768, 855.149126619018, 4709.105269998689, 4792.904141917212, 4833.589144922721, 4863.003084367696, 4873.512648735169, 63716.0, 63736.0, 64572.0, 64771.35228647653, 64863.0, 52091.218631720556, 53999.730001349744, 54917.45082549203, 55339.0, 55383.72308138514, 49946.0, 50250.0, 50446.99106017859, 51499.48500515022, 51734.48265517372, 10370.844437333597, 10503.212259080752, 10512.684619461428, 10530.26288159852, 10607.098396636373, 36514.08714782152, 36554.8172259137, 37644.2471150581, 37671.43492847664, 38653.226935461695, 48430.273545897544, 48971.02057958892, 49424.25863612121, 49458.752706236235, 49613.75193124011, 12425.13024088305, 12680.0, 12719.0, 12786.104972651825, 12826.486940522274, 11432.06713949806, 13736.725265494833, 14331.283435828376, 14396.568102956928, 14419.42322307096, 12870.0, 13280.867191328349, 13314.866851331362, 13710.588682339545, 13773.793393098911, 13245.602631921058, 13360.93319533396, 13593.932030339785, 13660.65848353799, 13718.65703357424, 13244.27156506363, 13348.666283342995, 13366.064375493623, 13645.79531307051, 13708.93145534266, 9880.308378413729, 9939.204863611038, 9970.800583988424, 10028.946960569036, 10104.89895101069, 9670.951645241728, 9946.801063978824, 9992.300538962494, 10035.548400321857, 10054.0], "value": 7211.488795230783, "unit": "score"}], "name": "dromaeo_css", "value": 7429.18350004934, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 112.0, 110.0, 110.0, 112.0, 105.0, 109.0, 109.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 126.0, 151.0, 174.0, 131.0, 147.0, 159.0, 130.0, 174.0, 125.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 162.0, 167.0, 160.0, 160.0, 159.0, 160.0, 159.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 176.0, 77.0, 77.0, 73.0, 76.0, 161.0, 75.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 154.0, 93.0, 92.0, 92.0, 143.0, 91.0, 92.0, 142.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 118.0, 119.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 52.0, 53.0, 53.0, 55.0, 73.0, 53.0, 51.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 73.0, 72.0, 73.0, 73.0, 81.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 122.0, 116.0, 111.0, 119.0, 118.0, 109.0, 112.0, 139.0, 133.0], "value": 119.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 158.0, 159.0, 159.0, 161.0, 156.0, 157.0, 164.0, 159.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 66.0, 65.0, 67.0, 67.0, 68.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1508.8999999999999, "alertThreshold": 2.0}]} 06:41:29 INFO - Return code: 0 06:41:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:41:29 ERROR - # TBPL SUCCESS # 06:41:29 INFO - Running post-action listener: _resource_record_post_action 06:41:29 INFO - Running post-run listener: _resource_record_post_run 06:41:30 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 270336; Write bytes: 489123840; Read time: 160; Write time: 412884 06:41:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248926208; Read time: 0; Write time: 259588 06:41:30 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 270336; Write bytes: 240197632; Read time: 160; Write time: 153296 06:41:30 INFO - Running post-run listener: _upload_blobber_files 06:41:30 INFO - Blob upload gear active. 06:41:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:30 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:30 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:30 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:31 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:41:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:32 INFO - (blobuploader) - INFO - Done attempting. 06:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:32 INFO - (blobuploader) - INFO - Done attempting. 06:41:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:41:32 INFO - Return code: 0 06:41:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:41:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:41:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f7911dc6eaa594792353e3f80ef5aa9e9840e07c00537e9b2c31a5ff6e918fbccc7cbc998a32afb073149f31618f9ced7531584174aafd86e0ba77bfb3ac318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/007a03f903cb947922139049b87ea09571a700a389a5538468d57cf5d3bee50e897d1a5b016905282032da364c7331b23e7c8dca8cc882eb5e1d4a769d335633"} 06:41:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:41:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:41:32 INFO - Contents: 06:41:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f7911dc6eaa594792353e3f80ef5aa9e9840e07c00537e9b2c31a5ff6e918fbccc7cbc998a32afb073149f31618f9ced7531584174aafd86e0ba77bfb3ac318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/007a03f903cb947922139049b87ea09571a700a389a5538468d57cf5d3bee50e897d1a5b016905282032da364c7331b23e7c8dca8cc882eb5e1d4a769d335633"} 06:41:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:41:32 INFO - Copying logs to upload dir... 06:41:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:41:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.767549 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-09 06:41:32.951698) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:32.954833) ========= 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=0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492 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/5f7911dc6eaa594792353e3f80ef5aa9e9840e07c00537e9b2c31a5ff6e918fbccc7cbc998a32afb073149f31618f9ced7531584174aafd86e0ba77bfb3ac318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/007a03f903cb947922139049b87ea09571a700a389a5538468d57cf5d3bee50e897d1a5b016905282032da364c7331b23e7c8dca8cc882eb5e1d4a769d335633"} 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.011175 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/5f7911dc6eaa594792353e3f80ef5aa9e9840e07c00537e9b2c31a5ff6e918fbccc7cbc998a32afb073149f31618f9ced7531584174aafd86e0ba77bfb3ac318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/007a03f903cb947922139049b87ea09571a700a389a5538468d57cf5d3bee50e897d1a5b016905282032da364c7331b23e7c8dca8cc882eb5e1d4a769d335633"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:32.982069) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:32.982354) ========= 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=0274524eba3bdaad075c2247000001d4-1462800064.148959-1527253492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:41:33.065472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:33.065780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:41:33.066121) ========= ========= Total master_lag: 0.17 =========