builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1462838313.36 results: success (0) buildid: 20160509140655 builduid: 51fec580243d478c9aa09015fb798427 revision: 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.357549) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.357923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.358204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.400335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.400595) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 16:58:33-- 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% 46.6M=0s 2016-05-09 16:58:33 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182240 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.615818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.616100) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.067756 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.693267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.693572) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 --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 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 --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=edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 16:58:33,704 truncating revision to first 12 chars 2016-05-09 16:58:33,704 Setting DEBUG logging. 2016-05-09 16:58:33,704 attempt 1/10 2016-05-09 16:58:33,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a31ddc2411f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 16:58:33,953 unpacking tar archive at: mozilla-aurora-1a31ddc2411f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.220374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.220672) ========= script_repo_revision: 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.221025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.221280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.229350) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-05-09 16:58:34.229629) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:34 INFO - MultiFileLogger online at 20160509 16:58:34 in /builds/slave/test 16:58:34 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 16:58:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:58:34 INFO - {'append_to_log': False, 16:58:34 INFO - 'base_work_dir': '/builds/slave/test', 16:58:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:58:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:58:34 INFO - 'branch': 'Mozilla-Aurora', 16:58:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:34 INFO - 'config_files': ('talos/linux_config.py',), 16:58:34 INFO - 'default_actions': ('clobber', 16:58:34 INFO - 'read-buildbot-config', 16:58:34 INFO - 'download-and-extract', 16:58:34 INFO - 'populate-webroot', 16:58:34 INFO - 'create-virtualenv', 16:58:34 INFO - 'install', 16:58:34 INFO - 'run-tests'), 16:58:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:34 INFO - 'download_minidump_stackwalk': True, 16:58:34 INFO - 'download_symbols': 'ondemand', 16:58:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:34 INFO - 'installer_path': 'installer.exe', 16:58:34 INFO - 'log_level': 'info', 16:58:34 INFO - 'log_name': 'talos', 16:58:34 INFO - 'log_to_console': True, 16:58:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:34 INFO - 'opt_config_files': (), 16:58:34 INFO - 'pip_index': False, 16:58:34 INFO - 'sps_profile': False, 16:58:34 INFO - 'sps_profile_interval': 0, 16:58:34 INFO - 'suite': 'dromaeojs', 16:58:34 INFO - 'system_bits': '32', 16:58:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:34 INFO - 'title': 'talos-linux64-ix-033', 16:58:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:34 INFO - 'use_talos_json': True, 16:58:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:58:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:34 INFO - 'work_dir': 'build'} 16:58:34 INFO - ##### 16:58:34 INFO - ##### Running clobber step. 16:58:34 INFO - ##### 16:58:34 INFO - Running pre-action listener: _resource_record_pre_action 16:58:34 INFO - Running main action method: clobber 16:58:34 INFO - rmtree: /builds/slave/test/build 16:58:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:58:36 INFO - Running post-action listener: _resource_record_post_action 16:58:36 INFO - ##### 16:58:36 INFO - ##### Running read-buildbot-config step. 16:58:36 INFO - ##### 16:58:36 INFO - Running pre-action listener: _resource_record_pre_action 16:58:36 INFO - Running main action method: read_buildbot_config 16:58:36 INFO - Using buildbot properties: 16:58:36 INFO - { 16:58:36 INFO - "project": "", 16:58:36 INFO - "product": "firefox", 16:58:36 INFO - "script_repo_revision": "production", 16:58:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:58:36 INFO - "repository": "", 16:58:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:58:36 INFO - "buildid": "20160509140655", 16:58:36 INFO - "pgo_build": "True", 16:58:36 INFO - "basedir": "/builds/slave/test", 16:58:36 INFO - "buildnumber": 319, 16:58:36 INFO - "slavename": "talos-linux64-ix-033", 16:58:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:58:36 INFO - "platform": "ubuntu64_hw", 16:58:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:58:36 INFO - "branch": "mozilla-aurora", 16:58:36 INFO - "repo_path": "releases/mozilla-aurora", 16:58:36 INFO - "revision": "1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27", 16:58:36 INFO - "stage_platform": "linux64-pgo", 16:58:36 INFO - "builduid": "51fec580243d478c9aa09015fb798427", 16:58:36 INFO - "slavebuilddir": "test" 16:58:36 INFO - } 16:58:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 16:58:36 INFO - Running post-action listener: _resource_record_post_action 16:58:36 INFO - ##### 16:58:36 INFO - ##### Running download-and-extract step. 16:58:36 INFO - ##### 16:58:36 INFO - Running pre-action listener: _resource_record_pre_action 16:58:36 INFO - Running main action method: download_and_extract 16:58:36 INFO - mkdir: /builds/slave/test/build/tests 16:58: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')]} 16:58:36 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:58:45 INFO - Downloaded 1361 bytes. 16:58:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:58:45 INFO - Using the following test package requirements: 16:58:45 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:58:45 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:58:45 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:58:45 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:45 INFO - u'jsshell-linux-x86_64.zip'], 16:58:45 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:58:45 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:58:45 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:58:45 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:58:45 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:58:45 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:45 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:58:45 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:45 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:58:57 INFO - Downloaded 23799958 bytes. 16:58:57 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'] 16:58:57 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 16:58:58 INFO - Return code: 0 16:58:58 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 16:58: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')]} 16:58:58 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:58:59 INFO - Downloaded 23799958 bytes. 16:58:59 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'] 16:58:59 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 16:59:01 INFO - Return code: 0 16:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:01 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:59:02 INFO - Downloaded 10840145 bytes. 16:59:02 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'] 16:59:02 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 16:59:02 INFO - Return code: 0 16:59:02 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')]} 16:59:02 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:59:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:59:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:59:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:59:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/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 16:59:04 INFO - Downloaded 62692819 bytes. 16:59:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:59:04 INFO - mkdir: /builds/slave/test/properties 16:59:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:59:04 INFO - Writing to file /builds/slave/test/properties/build_url 16:59:04 INFO - Contents: 16:59:04 INFO - build_url:https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:59:04 INFO - Running post-action listener: _resource_record_post_action 16:59:04 INFO - Running post-action listener: set_extra_try_arguments 16:59:04 INFO - ##### 16:59:04 INFO - ##### Running populate-webroot step. 16:59:04 INFO - ##### 16:59:04 INFO - Running pre-action listener: _resource_record_pre_action 16:59:04 INFO - Running main action method: populate_webroot 16:59:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:59:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:59:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:59:04 INFO - '--tppagecycles', 16:59:04 INFO - '7'], 16:59:04 INFO - 'tests': ['tsvgm']}}, 16:59:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:59:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:59:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:59:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:59:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:04 INFO - 'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:04 INFO - 'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['damp', 'tps']}, 16:59:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:04 INFO - 'tests': ['damp', 'tps']}, 16:59:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['dromaeo_dom']}, 16:59:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['a11yr', 16:59:04 INFO - 'ts_paint', 16:59:04 INFO - 'tpaint', 16:59:04 INFO - 'sessionrestore', 16:59:04 INFO - 'sessionrestore_no_auto_restore', 16:59:04 INFO - 'tabpaint']}, 16:59:04 INFO - 'other-e10s': {'tests': ['a11yr', 16:59:04 INFO - 'ts_paint', 16:59:04 INFO - 'tpaint', 16:59:04 INFO - 'sessionrestore', 16:59:04 INFO - 'sessionrestore_no_auto_restore', 16:59:04 INFO - 'tabpaint']}, 16:59:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:59:04 INFO - 'ts_paint', 16:59:04 INFO - 'tpaint', 16:59:04 INFO - 'sessionrestore', 16:59:04 INFO - 'sessionrestore_no_auto_restore', 16:59:04 INFO - 'tabpaint']}, 16:59:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:59:04 INFO - 'ts_paint', 16:59:04 INFO - 'tpaint', 16:59:04 INFO - 'sessionrestore', 16:59:04 INFO - 'sessionrestore_no_auto_restore', 16:59:04 INFO - 'tabpaint']}, 16:59:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['a11yr', 16:59:04 INFO - 'ts_paint', 16:59:04 INFO - 'tpaint', 16:59:04 INFO - 'sessionrestore', 16:59:04 INFO - 'sessionrestore_no_auto_restore', 16:59:04 INFO - 'tabpaint']}, 16:59:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['a11yr', 16:59:04 INFO - 'ts_paint', 16:59:04 INFO - 'tpaint', 16:59:04 INFO - 'sessionrestore', 16:59:04 INFO - 'sessionrestore_no_auto_restore', 16:59:04 INFO - 'tabpaint']}, 16:59:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['tsvgx', 16:59:04 INFO - 'tsvgr_opacity', 16:59:04 INFO - 'tart', 16:59:04 INFO - 'tscrollx', 16:59:04 INFO - 'cart']}, 16:59:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:59:04 INFO - 'tsvgr_opacity', 16:59:04 INFO - 'tart', 16:59:04 INFO - 'tscrollx', 16:59:04 INFO - 'cart']}, 16:59:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:04 INFO - 'talos_options': ['--disable-e10s'], 16:59:04 INFO - 'tests': ['tp5o']}, 16:59:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:04 INFO - 'tests': ['tp5o']}, 16:59:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:04 INFO - 'talos_options': ['--disable-e10s', 16:59:04 INFO - '--xperf_path', 16:59:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:04 INFO - 'tests': ['tp5n']}, 16:59:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:04 INFO - 'talos_options': ['--xperf_path', 16:59:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:04 INFO - 'tests': ['tp5n']}}, 16:59:04 INFO - 'talos.zip': {'path': '', 16:59:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:59:04 INFO - Running post-action listener: _resource_record_post_action 16:59:04 INFO - ##### 16:59:04 INFO - ##### Running create-virtualenv step. 16:59:04 INFO - ##### 16:59:04 INFO - Running pre-action listener: _resource_record_pre_action 16:59:04 INFO - Running main action method: create_virtualenv 16:59:04 INFO - Creating virtualenv /builds/slave/test/build/venv 16:59:04 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 16:59:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:59:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:05 INFO - Using real prefix '/usr' 16:59:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:59:07 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:09 INFO - Installing pip.................done. 16:59:09 INFO - Return code: 0 16:59:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:09 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 0x7fd1c7257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', '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 16:59:09 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 16:59:09 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 16:59:09 INFO - Using env: {'DISPLAY': ':0', 16:59:09 INFO - 'HOME': '/home/cltbld', 16:59:09 INFO - 'LANG': 'en_US.UTF-8', 16:59:09 INFO - 'LANGUAGE': 'en_US:en', 16:59:09 INFO - 'LOGNAME': 'cltbld', 16:59:09 INFO - 'MAIL': '/var/mail/cltbld', 16:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:09 INFO - 'MOZ_NO_REMOTE': '1', 16:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:09 INFO - 'NO_EM_RESTART': '1', 16:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:09 INFO - 'PWD': '/builds/slave/test', 16:59:09 INFO - 'SHELL': '/bin/bash', 16:59:09 INFO - 'SHLVL': '1', 16:59:09 INFO - 'TERM': 'linux', 16:59:09 INFO - 'TMOUT': '86400', 16:59:09 INFO - 'USER': 'cltbld', 16:59:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:09 INFO - '_': '/tools/buildbot/bin/python'} 16:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:10 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 16:59:10 INFO - Cleaning up... 16:59:10 INFO - Return code: 0 16:59:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:10 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 0x7fd1c7257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', '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 16:59:10 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 16:59:10 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 16:59:10 INFO - Using env: {'DISPLAY': ':0', 16:59:10 INFO - 'HOME': '/home/cltbld', 16:59:10 INFO - 'LANG': 'en_US.UTF-8', 16:59:10 INFO - 'LANGUAGE': 'en_US:en', 16:59:10 INFO - 'LOGNAME': 'cltbld', 16:59:10 INFO - 'MAIL': '/var/mail/cltbld', 16:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:10 INFO - 'MOZ_NO_REMOTE': '1', 16:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:10 INFO - 'NO_EM_RESTART': '1', 16:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:10 INFO - 'PWD': '/builds/slave/test', 16:59:10 INFO - 'SHELL': '/bin/bash', 16:59:10 INFO - 'SHLVL': '1', 16:59:10 INFO - 'TERM': 'linux', 16:59:10 INFO - 'TMOUT': '86400', 16:59:10 INFO - 'USER': 'cltbld', 16:59:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:10 INFO - '_': '/tools/buildbot/bin/python'} 16:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:10 INFO - Downloading/unpacking psutil>=0.7.1 16:59:10 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 16:59:10 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 16:59:10 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 16:59:10 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 16:59:10 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 16:59:10 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 16:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:59:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:13 INFO - Installing collected packages: psutil 16:59:13 INFO - Running setup.py install for psutil 16:59:13 INFO - building 'psutil._psutil_linux' extension 16:59:13 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 16:59:14 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 16:59:14 INFO - building 'psutil._psutil_posix' extension 16:59:14 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 16:59:14 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 16:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:14 INFO - Successfully installed psutil 16:59:14 INFO - Cleaning up... 16:59:14 INFO - Return code: 0 16:59:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:14 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 0x7fd1c7257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', '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 16:59:14 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 16:59:14 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 16:59:14 INFO - Using env: {'DISPLAY': ':0', 16:59:14 INFO - 'HOME': '/home/cltbld', 16:59:14 INFO - 'LANG': 'en_US.UTF-8', 16:59:14 INFO - 'LANGUAGE': 'en_US:en', 16:59:14 INFO - 'LOGNAME': 'cltbld', 16:59:14 INFO - 'MAIL': '/var/mail/cltbld', 16:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:14 INFO - 'MOZ_NO_REMOTE': '1', 16:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:14 INFO - 'NO_EM_RESTART': '1', 16:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:14 INFO - 'PWD': '/builds/slave/test', 16:59:14 INFO - 'SHELL': '/bin/bash', 16:59:14 INFO - 'SHLVL': '1', 16:59:14 INFO - 'TERM': 'linux', 16:59:14 INFO - 'TMOUT': '86400', 16:59:14 INFO - 'USER': 'cltbld', 16:59:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:14 INFO - '_': '/tools/buildbot/bin/python'} 16:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:59:15 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 16:59:15 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 16:59:15 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 16:59:15 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 16:59:15 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 16:59:15 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 16:59:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:59:16 INFO - Installing collected packages: mozsystemmonitor 16:59:16 INFO - Running setup.py install for mozsystemmonitor 16:59:17 INFO - Successfully installed mozsystemmonitor 16:59:17 INFO - Cleaning up... 16:59:17 INFO - Return code: 0 16:59:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:17 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 0x7fd1c7257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', '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 16:59:17 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 16:59:17 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 16:59:17 INFO - Using env: {'DISPLAY': ':0', 16:59:17 INFO - 'HOME': '/home/cltbld', 16:59:17 INFO - 'LANG': 'en_US.UTF-8', 16:59:17 INFO - 'LANGUAGE': 'en_US:en', 16:59:17 INFO - 'LOGNAME': 'cltbld', 16:59:17 INFO - 'MAIL': '/var/mail/cltbld', 16:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:17 INFO - 'MOZ_NO_REMOTE': '1', 16:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:17 INFO - 'NO_EM_RESTART': '1', 16:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:17 INFO - 'PWD': '/builds/slave/test', 16:59:17 INFO - 'SHELL': '/bin/bash', 16:59:17 INFO - 'SHLVL': '1', 16:59:17 INFO - 'TERM': 'linux', 16:59:17 INFO - 'TMOUT': '86400', 16:59:17 INFO - 'USER': 'cltbld', 16:59:17 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:17 INFO - '_': '/tools/buildbot/bin/python'} 16:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:17 INFO - Downloading/unpacking blobuploader==1.2.4 16:59:17 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 16:59:17 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 16:59:17 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 16:59:17 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 16:59:17 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 16:59:17 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 16:59:19 INFO - Downloading blobuploader-1.2.4.tar.gz 16:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:59:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:59:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:19 INFO - Downloading docopt-0.6.1.tar.gz 16:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:59:19 INFO - Installing collected packages: blobuploader, requests, docopt 16:59:19 INFO - Running setup.py install for blobuploader 16:59:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:59:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:59:20 INFO - Running setup.py install for requests 16:59:20 INFO - Running setup.py install for docopt 16:59:20 INFO - Successfully installed blobuploader requests docopt 16:59:20 INFO - Cleaning up... 16:59:20 INFO - Return code: 0 16:59:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:20 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 0x7fd1c7257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', '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 16:59:20 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 16:59:20 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 16:59:20 INFO - Using env: {'DISPLAY': ':0', 16:59:20 INFO - 'HOME': '/home/cltbld', 16:59:20 INFO - 'LANG': 'en_US.UTF-8', 16:59:20 INFO - 'LANGUAGE': 'en_US:en', 16:59:20 INFO - 'LOGNAME': 'cltbld', 16:59:20 INFO - 'MAIL': '/var/mail/cltbld', 16:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:20 INFO - 'MOZ_NO_REMOTE': '1', 16:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:20 INFO - 'NO_EM_RESTART': '1', 16:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:20 INFO - 'PWD': '/builds/slave/test', 16:59:20 INFO - 'SHELL': '/bin/bash', 16:59:20 INFO - 'SHLVL': '1', 16:59:20 INFO - 'TERM': 'linux', 16:59:20 INFO - 'TMOUT': '86400', 16:59:20 INFO - 'USER': 'cltbld', 16:59:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:20 INFO - '_': '/tools/buildbot/bin/python'} 16:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:20 INFO - Running setup.py (path:/tmp/pip-l6HLzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:20 INFO - Running setup.py (path:/tmp/pip-5qnR4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:20 INFO - Running setup.py (path:/tmp/pip-XvZ6ME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:21 INFO - Running setup.py (path:/tmp/pip-4GGDJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:21 INFO - Running setup.py (path:/tmp/pip-weMp4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:21 INFO - Running setup.py (path:/tmp/pip-bxTzeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:21 INFO - Running setup.py (path:/tmp/pip-Cjjcyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:21 INFO - Running setup.py (path:/tmp/pip-KsYtzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:21 INFO - Running setup.py (path:/tmp/pip-wFtUfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:21 INFO - Running setup.py (path:/tmp/pip-KIZaCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:21 INFO - Running setup.py (path:/tmp/pip-w6Nnuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:21 INFO - Running setup.py (path:/tmp/pip-8d4UFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:21 INFO - Running setup.py (path:/tmp/pip-m9k3yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:21 INFO - Running setup.py (path:/tmp/pip-jAcBmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:21 INFO - Running setup.py (path:/tmp/pip-KIxfgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:21 INFO - Running setup.py (path:/tmp/pip-lr4K7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:21 INFO - Running setup.py (path:/tmp/pip-I7EjoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:59:22 INFO - Running setup.py install for manifestparser 16:59:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:59:22 INFO - Running setup.py install for mozcrash 16:59:22 INFO - Running setup.py install for mozdebug 16:59:22 INFO - Running setup.py install for mozdevice 16:59:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:59:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:59:22 INFO - Running setup.py install for mozfile 16:59:22 INFO - Running setup.py install for mozhttpd 16:59:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:59:22 INFO - Running setup.py install for mozinfo 16:59:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:59:22 INFO - Running setup.py install for mozInstall 16:59:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:59:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:59:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:59:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:59:22 INFO - Running setup.py install for mozleak 16:59:22 INFO - Running setup.py install for mozlog 16:59:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:59:23 INFO - Running setup.py install for moznetwork 16:59:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:59:23 INFO - Running setup.py install for mozprocess 16:59:23 INFO - Running setup.py install for mozprofile 16:59:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:59:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:59:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:59:23 INFO - Running setup.py install for mozrunner 16:59:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:59:23 INFO - Running setup.py install for mozscreenshot 16:59:23 INFO - Running setup.py install for moztest 16:59:23 INFO - Running setup.py install for mozversion 16:59:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:59:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:59:23 INFO - Cleaning up... 16:59:23 INFO - Return code: 0 16:59:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:23 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 0x7fd1c7257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', '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 16:59:23 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 16:59:23 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 16:59:23 INFO - Using env: {'DISPLAY': ':0', 16:59:23 INFO - 'HOME': '/home/cltbld', 16:59:23 INFO - 'LANG': 'en_US.UTF-8', 16:59:23 INFO - 'LANGUAGE': 'en_US:en', 16:59:23 INFO - 'LOGNAME': 'cltbld', 16:59:23 INFO - 'MAIL': '/var/mail/cltbld', 16:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:23 INFO - 'MOZ_NO_REMOTE': '1', 16:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:23 INFO - 'NO_EM_RESTART': '1', 16:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:23 INFO - 'PWD': '/builds/slave/test', 16:59:23 INFO - 'SHELL': '/bin/bash', 16:59:23 INFO - 'SHLVL': '1', 16:59:23 INFO - 'TERM': 'linux', 16:59:23 INFO - 'TMOUT': '86400', 16:59:23 INFO - 'USER': 'cltbld', 16:59:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:23 INFO - '_': '/tools/buildbot/bin/python'} 16:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:24 INFO - Running setup.py (path:/tmp/pip-_eTy2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:24 INFO - Running setup.py (path:/tmp/pip-_rKaq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:24 INFO - Running setup.py (path:/tmp/pip-midNkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:24 INFO - Running setup.py (path:/tmp/pip-Pv0iMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:24 INFO - Running setup.py (path:/tmp/pip-j3ZLZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:24 INFO - Running setup.py (path:/tmp/pip-GAxfTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:24 INFO - Running setup.py (path:/tmp/pip-4K241S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:24 INFO - Running setup.py (path:/tmp/pip-PQKzsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:24 INFO - Running setup.py (path:/tmp/pip-WmueVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:24 INFO - Running setup.py (path:/tmp/pip-JZYqLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:24 INFO - Running setup.py (path:/tmp/pip-0FsQ3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:24 INFO - Running setup.py (path:/tmp/pip-UvACZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:24 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)) 16:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:24 INFO - Running setup.py (path:/tmp/pip-woOWs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:25 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)) 16:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:25 INFO - Running setup.py (path:/tmp/pip-WLaxWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:25 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)) 16:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:25 INFO - Running setup.py (path:/tmp/pip-wuM68T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:25 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)) 16:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:25 INFO - Running setup.py (path:/tmp/pip-qk22pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:25 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)) 16:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:25 INFO - Running setup.py (path:/tmp/pip-FTw_Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:25 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)) 16:59:25 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)) 16:59:25 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)) 16:59:25 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)) 16:59:25 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)) 16:59:25 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)) 16:59:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:59:25 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 16:59:25 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 16:59:25 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 16:59:25 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 16:59:25 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 16:59:25 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 16:59:27 INFO - Downloading blessings-1.6.tar.gz 16:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:59:27 INFO - Installing collected packages: blessings 16:59:27 INFO - Running setup.py install for blessings 16:59:27 INFO - Successfully installed blessings 16:59:27 INFO - Cleaning up... 16:59:27 INFO - Return code: 0 16:59:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:59:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:27 INFO - Reading from file tmpfile_stdout 16:59:27 INFO - Current package versions: 16:59:27 INFO - argparse == 1.2.1 16:59:27 INFO - blessings == 1.6 16:59:27 INFO - blobuploader == 1.2.4 16:59:27 INFO - docopt == 0.6.1 16:59:27 INFO - manifestparser == 1.1 16:59:27 INFO - mozInstall == 1.12 16:59:27 INFO - mozcrash == 0.17 16:59:27 INFO - mozdebug == 0.1 16:59:27 INFO - mozdevice == 0.48 16:59:27 INFO - mozfile == 1.2 16:59:27 INFO - mozhttpd == 0.7 16:59:27 INFO - mozinfo == 0.9 16:59:27 INFO - mozleak == 0.1 16:59:27 INFO - mozlog == 3.1 16:59:27 INFO - moznetwork == 0.27 16:59:27 INFO - mozprocess == 0.22 16:59:27 INFO - mozprofile == 0.28 16:59:27 INFO - mozrunner == 6.11 16:59:27 INFO - mozscreenshot == 0.1 16:59:27 INFO - mozsystemmonitor == 0.0 16:59:27 INFO - moztest == 0.7 16:59:27 INFO - mozversion == 1.4 16:59:27 INFO - psutil == 3.1.1 16:59:27 INFO - requests == 1.2.3 16:59:27 INFO - wsgiref == 0.1.2 16:59:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:27 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 0x7fd1c7257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', '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 16:59:27 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 16:59:27 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 16:59:27 INFO - Using env: {'DISPLAY': ':0', 16:59:27 INFO - 'HOME': '/home/cltbld', 16:59:27 INFO - 'LANG': 'en_US.UTF-8', 16:59:27 INFO - 'LANGUAGE': 'en_US:en', 16:59:27 INFO - 'LOGNAME': 'cltbld', 16:59:27 INFO - 'MAIL': '/var/mail/cltbld', 16:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:27 INFO - 'MOZ_NO_REMOTE': '1', 16:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:27 INFO - 'NO_EM_RESTART': '1', 16:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:27 INFO - 'PWD': '/builds/slave/test', 16:59:27 INFO - 'SHELL': '/bin/bash', 16:59:27 INFO - 'SHLVL': '1', 16:59:27 INFO - 'TERM': 'linux', 16:59:27 INFO - 'TMOUT': '86400', 16:59:27 INFO - 'USER': 'cltbld', 16:59:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:27 INFO - '_': '/tools/buildbot/bin/python'} 16:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:27 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)) 16:59:27 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)) 16:59:27 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)) 16:59:27 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)) 16:59:27 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)) 16:59:27 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)) 16:59:27 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)) 16:59:27 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)) 16:59:27 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)) 16:59:27 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)) 16:59:27 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)) 16:59:27 INFO - Cleaning up... 16:59:27 INFO - Return code: 0 16:59:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c7257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', '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 16:59:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:59:27 INFO - Using env: {'DISPLAY': ':0', 16:59:27 INFO - 'HOME': '/home/cltbld', 16:59:27 INFO - 'LANG': 'en_US.UTF-8', 16:59:27 INFO - 'LANGUAGE': 'en_US:en', 16:59:27 INFO - 'LOGNAME': 'cltbld', 16:59:27 INFO - 'MAIL': '/var/mail/cltbld', 16:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:27 INFO - 'MOZ_NO_REMOTE': '1', 16:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:27 INFO - 'NO_EM_RESTART': '1', 16:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:27 INFO - 'PWD': '/builds/slave/test', 16:59:27 INFO - 'SHELL': '/bin/bash', 16:59:27 INFO - 'SHLVL': '1', 16:59:27 INFO - 'TERM': 'linux', 16:59:27 INFO - 'TMOUT': '86400', 16:59:27 INFO - 'USER': 'cltbld', 16:59:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:27 INFO - '_': '/tools/buildbot/bin/python'} 16:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:28 INFO - Downloading/unpacking jsonschema 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:59:29 INFO - Downloading/unpacking functools32 (from jsonschema) 16:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:30 INFO - Downloading functools32-3.2.3-2.tar.gz 16:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:59:30 INFO - warning: no files found matching '*.txt' 16:59:30 INFO - no previously-included directories found matching 'build' 16:59:30 INFO - no previously-included directories found matching 'dist' 16:59:30 INFO - no previously-included directories found matching '.git*' 16:59:30 INFO - Installing collected packages: jsonschema, functools32 16:59:30 INFO - Running setup.py install for functools32 16:59:30 INFO - warning: no files found matching '*.txt' 16:59:30 INFO - no previously-included directories found matching 'build' 16:59:30 INFO - no previously-included directories found matching 'dist' 16:59:30 INFO - no previously-included directories found matching '.git*' 16:59:30 INFO - Successfully installed jsonschema functools32 16:59:30 INFO - Cleaning up... 16:59:30 INFO - Return code: 0 16:59:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:59:30 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')]} 16:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:30 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')]} 16:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:30 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 0x7fd1c7257f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c715a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', '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 16:59:30 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 16:59:30 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 16:59:30 INFO - Using env: {'DISPLAY': ':0', 16:59:30 INFO - 'HOME': '/home/cltbld', 16:59:30 INFO - 'LANG': 'en_US.UTF-8', 16:59:30 INFO - 'LANGUAGE': 'en_US:en', 16:59:30 INFO - 'LOGNAME': 'cltbld', 16:59:30 INFO - 'MAIL': '/var/mail/cltbld', 16:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:30 INFO - 'MOZ_NO_REMOTE': '1', 16:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:30 INFO - 'NO_EM_RESTART': '1', 16:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:30 INFO - 'PWD': '/builds/slave/test', 16:59:30 INFO - 'SHELL': '/bin/bash', 16:59:30 INFO - 'SHLVL': '1', 16:59:30 INFO - 'TERM': 'linux', 16:59:30 INFO - 'TMOUT': '86400', 16:59:30 INFO - 'USER': 'cltbld', 16:59:30 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:30 INFO - '_': '/tools/buildbot/bin/python'} 16:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:30 INFO - Downloading/unpacking flake8 16:59:30 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 16:59:30 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 16:59:30 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 16:59:30 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 16:59:30 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 16:59:30 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 16:59:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:59:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:59:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:59:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:33 INFO - no previously-included directories found matching 'docs/_build' 16:59:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:59:33 INFO - Running setup.py install for pep8 16:59:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:33 INFO - no previously-included directories found matching 'docs/_build' 16:59:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:59:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:59:33 INFO - Cleaning up... 16:59:33 INFO - Return code: 0 16:59:33 INFO - Running post-action listener: _resource_record_post_action 16:59:33 INFO - Running post-action listener: _start_resource_monitoring 16:59:33 INFO - Starting resource monitoring. 16:59:33 INFO - ##### 16:59:33 INFO - ##### Running install step. 16:59:33 INFO - ##### 16:59:33 INFO - Running pre-action listener: _resource_record_pre_action 16:59:33 INFO - Running main action method: install 16:59:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:33 INFO - Reading from file tmpfile_stdout 16:59:33 INFO - Detecting whether we're running mozinstall >=1.0... 16:59:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:59:33 INFO - Reading from file tmpfile_stdout 16:59:33 INFO - Output received: 16:59:33 INFO - Usage: mozinstall [options] installer 16:59:33 INFO - Options: 16:59:33 INFO - -h, --help show this help message and exit 16:59:33 INFO - -d DEST, --destination=DEST 16:59:33 INFO - Directory to install application into. [default: 16:59:33 INFO - "/builds/slave/test"] 16:59:33 INFO - --app=APP Application being installed. [default: firefox] 16:59:33 INFO - mkdir: /builds/slave/test/build/application 16:59:33 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'] 16:59:33 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 16:59:49 INFO - Reading from file tmpfile_stdout 16:59:49 INFO - Output received: 16:59:49 INFO - /builds/slave/test/build/application/firefox/firefox 16:59:49 INFO - Running post-action listener: _resource_record_post_action 16:59:49 INFO - ##### 16:59:49 INFO - ##### Running run-tests step. 16:59:49 INFO - ##### 16:59:49 INFO - Running pre-action listener: _resource_record_pre_action 16:59:49 INFO - Running main action method: run_tests 16:59:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:59:49 INFO - Python 2.7.3 16:59:49 INFO - Return code: 0 16:59:49 INFO - grabbing minidump binary from tooltool 16:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:49 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 0x1d00410>, '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 0x1d01310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d017a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:59:49 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 16:59:49 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 16:59:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:59:49 INFO - Return code: 0 16:59:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:59:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:59:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:59:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:59:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:59:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:59:50 INFO - Return code: 0 16:59:50 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/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 16:59:50 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/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 16:59:50 INFO - Using env: {'DISPLAY': ':0', 16:59:50 INFO - 'HOME': '/home/cltbld', 16:59:50 INFO - 'LANG': 'en_US.UTF-8', 16:59:50 INFO - 'LANGUAGE': 'en_US:en', 16:59:50 INFO - 'LOGNAME': 'cltbld', 16:59:50 INFO - 'MAIL': '/var/mail/cltbld', 16:59:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:59:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:50 INFO - 'MOZ_NO_REMOTE': '1', 16:59:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:50 INFO - 'NO_EM_RESTART': '1', 16:59:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:50 INFO - 'PWD': '/builds/slave/test', 16:59:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:59:50 INFO - 'SHELL': '/bin/bash', 16:59:50 INFO - 'SHLVL': '1', 16:59:50 INFO - 'TERM': 'linux', 16:59:50 INFO - 'TMOUT': '86400', 16:59:50 INFO - 'USER': 'cltbld', 16:59:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366', 16:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:50 INFO - '_': '/tools/buildbot/bin/python'} 16:59:50 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/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 16:59:50 INFO - mozversion application_buildid: 20160509140655 16:59:50 INFO - mozversion application_changeset: 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 16:59:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:59:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:59:50 INFO - mozversion application_name: Firefox 16:59:50 INFO - mozversion application_remotingname: firefox-dev 16:59:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:59:50 INFO - mozversion application_vendor: Mozilla 16:59:50 INFO - mozversion application_version: 48.0a2 16:59:50 INFO - mozversion platform_buildid: 20160509140655 16:59:50 INFO - mozversion platform_changeset: 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 16:59:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:59:50 INFO - mozversion platform_version: 48.0a2 16:59:50 INFO - using testdate: 1462838390 16:59:50 INFO - actual date: 1462838390 16:59:50 INFO - starting webserver on 'localhost:53324' 16:59:50 INFO - SUITE-START | Running 2 tests 16:59:50 INFO - TEST-START | dromaeo_css 16:59:50 INFO - operating with platform_type : linux_ 16:59:50 INFO - Initialising browser for dromaeo_css test... 16:59:50 INFO - TEST-INFO | started process 3282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmjCqw5/profile http://localhost:53324/getInfo.html) 16:59:58 INFO - PROCESS | 3282 | __metrics Screen width/height:1600/1200 16:59:58 INFO - PROCESS | 3282 | colorDepth:24 16:59:58 INFO - PROCESS | 3282 | Browser inner width/height: 1024/697 16:59:58 INFO - PROCESS | 3282 | __metrics 17:00:00 ERROR - PROCESS | 3282 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:00:01 INFO - TEST-INFO | 3282: exit 0 17:00:01 INFO - Browser initialized. 17:00:01 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:01 INFO - TEST-INFO | started process 3375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmjCqw5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:12 INFO - PROCESS | 3375 | RSS: Main: 142086144 17:00:12 INFO - PROCESS | 3375 | 17:01:04 INFO - PROCESS | 3375 | 1462838464268 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] 17:03:11 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:53324/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53324/tests/dromaeo/cssquery-ext.html) 17:03:12 INFO - PROCESS | 3375 | RSS: Main: 250281984 17:03:12 INFO - PROCESS | 3375 | 17:06:14 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:53324/tests/dromaeo/cssquery-ext.html (next: http://localhost:53324/tests/dromaeo/cssquery-jquery.html) 17:06:14 INFO - PROCESS | 3375 | RSS: Main: 224972800 17:06:14 INFO - PROCESS | 3375 | 17:09:16 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:53324/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53324/tests/dromaeo/cssquery-mootools.html) 17:09:17 INFO - PROCESS | 3375 | RSS: Main: 214237184 17:09:17 INFO - PROCESS | 3375 | 17:12:19 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:53324/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53324/tests/dromaeo/cssquery-prototype.html) 17:12:19 INFO - PROCESS | 3375 | RSS: Main: 213512192 17:12:19 INFO - PROCESS | 3375 | 17:15:22 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:53324/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53324/tests/dromaeo/cssquery-yui.html) 17:15:22 INFO - PROCESS | 3375 | RSS: Main: 212221952 17:15:22 INFO - PROCESS | 3375 | 17:18:25 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:53324/tests/dromaeo/cssquery-yui.html (next: http://localhost:53324/tests/dromaeo/cssquery-dojo.html) 17:18:25 INFO - PROCESS | 3375 | RSS: Main: 253992960 17:18:25 INFO - PROCESS | 3375 | 17:18:25 INFO - PROCESS | 3375 | __start_tp_report 17:18:25 INFO - PROCESS | 3375 | _x_x_mozilla_page_load 17:18:25 INFO - PROCESS | 3375 | _x_x_mozilla_page_load_details 17:18:25 INFO - PROCESS | 3375 | |i|pagename|runs| 17:18:25 INFO - PROCESS | 3375 | |0;dojo.html;3287.5397444357786;3343.314620502797;3373.4771110477886;3373.949390759138;3377.1894745261143;5454.318210223722;5462.180672899067;5476.698781567012;5482.314710661168;5492.697901615409;5453;5489.149181876805;5506.079338232721;5511.3937466878615;5552.694601796909;4792.472827988919;4925.384326959139;4994.051130285252;5072.568831649296;5102.974485127569;4752.833650822222;4819.180739274332;4910.484399138093;4919.13915064864;4922.753862306889;4961.05739909416;5007.37407824022;5010.899782004358;5012;5045.217991211368;4951.257311403282;4980.750962451899;4998.875028124289;5002.224655178435;5015.398152221756;4775.641826863;4880.707157570557;4927.334809800667;4945.431275403303;4952.925706114411;5251.6061295403;5255.185446255837;5260.00059988601;5263.8420847374255;5311.814086506954;5489.64317319373;5703.40114288002;5704.515116215127;5707.942920570783;5725.541956643458;5705.857353566194;5742.196092547047;5782.7397767100165;5794.246747922743;5806.04200306953;5405.054115529767;5407.188921661743;5411.026015317241;5417.079096553595;5417.999999999961;5697.572682048863;5881.323647780475;5885.676287804212;5888.911666325009;5894.852628684317;5701.885962280731;5704.600677952587;5709.05800542914;5709.457601527848;5747.85630359236;5734.541236701138;5739.885202295931;5742.799002034993;5768.711564421762;5771.249737534094;5554.972225138848;5706.229658996065;5728.369879313273;5761.164631128547;5789.681567513827;5682.659040457585;5689.743961521742;5706.144078388192;5712.371639119693;5733.025385684444;4346.500152482442;4352.477702675699;4359;4368.475782906072;4369.3227549729845;3893.260280546687;3951.545572259227;3952.051507638146;4026.899327516777;4033.798310084484;5365.651232669864;5381.54256888161;5383.596230282745;5405;5424.050791111618;5708.429157084258;5711.857203569861;5720.8283751487525;5726.169705392695;5731.140328950607;5336.359636843604;5445.319335083114;5493.697846618475;5521.061419558685;5543.584231182677;4841.515848415201;4842.394700662418;4846.127697014571;4846.466888642247;4875.536824001785;5784.652920824764;5953.255843019622;5961.374055724174;5963.5825492216;5964.910526342108;5648.5481161507805;5744.195812586157;5759.769609215752;5766.481016708516;5785.074388097884;5951.58338916289;5966.254218222723;5966.612170208922;5968.313643931004;5978.4021597839865;5529.364123125892;5640.633358831663;5647.20939068539;5650.858728531655;5660.773569057356;5700.25896633435;5703.8859222816145;5704.80033198836;5715.628484148683;5741.655500669973;5556.805511807229;5597.160425936142;5601.831945041656;5603.327600687943;5606.355269143937;5493.066178749542;5578.721063946868;5598.076317407582;5626.943730562642;5709.115087161496;5437.945620543744;5441.183822426668;5451.536619387238;5460.34475862899;5483.7806487740045;5531.059719847716;5544.889102218014;5550.111982082847;5552.833414997556;5590.552755779447;5419.918701219563;5485.369182544058;5521.309836270466;5557.1664250361155;5608.158776183605 17:18:25 INFO - PROCESS | 3375 | |1;ext.html;596.2844586496203;648.3710800523494;648.9383508566686;655.9508036897234;659.6240143118422;40601.18797624049;41229;41241.79379103108;41276.587234127684;41292.17415651689;47529.52470475294;48197.51802481974;48292;48358.75820620901;48374.75812620941;9130.589123489442;9313.860292095624;9323.160915517603;9325.347225694204;9327.16055555;9011.594478248462;9126.406783559047;9137.68018119366;9140.771480713001;9141.451512909247;9128.132827381422;9194.402363846328;9197.678081267157;9199.632014719436;9202.76993075175;9083.636654533811;9130.589123489426;9152.267818574564;9154.221891139261;9155.450672959643;9046.638134474613;9095.31785116119;9124.361294709373;9137.177654011104;9159;42577.36133957993;42963.35554966678;43031.7848410756;43047.784761076306;43105.35341969873;3845.1156234066043;3907.355286377744;3961.1483531040676;4020.4170395292517;4216.093539888939;31877;32929.506057409155;33183.502247466306;33426.1643458913;34526.48210276848;4227.661787057028;4233.111046680201;4293.355996600504;4299.656027517823;4341.674374421899;326097;326147.9999999976;326247;326369;326920;60480.69759651174;60577.09134362988;60684.393156067876;61027;61083.694581526805;64446.67776661087;69163.3083669167;70110;70510.64744676347;70731;16419.343226270816;16563.503094907173;16577.83422165787;16593.087380193963;16598.25307861149;12430.689232769073;12494.125411221126;12505.74988500225;12506.18709783861;12507.249565026128;20369.2870749526;20507.974601269878;20671.793282067287;20783;21135.8943205283;7592.52801992528;7658.324004477882;7697.805410754586;7750;7809.687612495437;1121.9439028048564;1191.559123124432;1212.4543955220186;1255.9497620095094;1275.5216793702361;34335.48861277469;34988.47517287243;35095;35237.82381088078;35435.468467973;1210.152892974921;1222.2422098299112;1270.142653708743;1285.9228446293253;1354.4446776821455;17712.55718607045;17942.551436213937;18036.368727094752;18038.729419058724;18041.548961276072;569354;582321;585553;586215;586270;53688.194677079875;53973.73013134909;54198.729006355505;54233.1865022025;54235.18647220295;1377.4627895120911;1481.7851411545266;1482.7405204089457;1527.6104593328407;1528.1900592685672;30751.384972300875;31551.36897262088;32246.83876580602;32329.19177020499;32657.34685306328;46248.30627540657;46398.53601464077;46940.295895562274;46981.530184697716;47040;240564;244954;246739;247753;518225;29918.551221731257;30065.398692026476;30471.390572188877;31009.224769380948;31051.223719407197;44731.552684472736;44778;44988.55011449844;45600.31599526076;46030.53969460396;37555.436668449445;38175;38634.22731545297;38927;39412;36828.631713682524;37231.6276837239;37331.81334093312;39247.80376098101;40164.39753403643;41796.79101604473;42366.36450453184;42470.362944555236;42796.14407711891;43194;34511.82744086264;35738;36114.45828312525;36331;36458.8177059113;28260.71739282581;28560;28714.42571148607;28717.28206794847;29071.854640726662 17:18:25 INFO - PROCESS | 3375 | |2;jquery.html;417.98328066877326;432.1853306517214;437.4990635722098;441.50988425281406;448.86534039788074;18715.532111697197;18912.432627021193;19460.51348716281;19945;20285.797142028576;19167;19408.126634301454;20053.398398048044;20110.497237569067;20153;5635.943640563582;5675.631083979539;5897.11543268511;5903.970480147594;5911.793087241947;4279.186954478655;5791.449812267828;5843.035899076647;6166.321704612489;6437.356264373549;6388.105665206875;6422.068800023993;6426.871462570746;6430.421262086411;6434.6782660867;6065.909011364833;6331.588446750947;6349.714262858182;6350.523710721714;6363.5863668861375;3866.4780254665543;4286.957130428687;5602.943970560283;5721.971390143064;5740.225069615591;12953.158044727063;13030.478780848754;13196.208227506284;13213.075084744072;13256.602301930958;2359.97640023601;2479.1446950801947;2480.06997375984;2541.1614167324738;2666.4800363929044;9912.752181195456;9950.800983980353;10000.149987251092;10078.748031299203;10140.89859101407;2046.8055534724178;2087.6346639338053;2089.101686274901;2099.5381016176416;2122.342073957063;74589.62705186494;75545.99999999945;76197;77319;80410.19589804085;10998.505067271992;11256.831147532794;11265.605703800491;11321.886781132249;11358.148138889452;15574.532764017098;15671.451499197474;15820.683586328209;15862.127582982816;15868.682626347409;8005.159458256916;8036.196380361917;8042.83914321722;8120.390970677223;8140.185981401931;7581.090269167735;7626;7638.69445222196;7642.159362470124;7717.2668596483245;4769.594584460359;4811.975940120277;4812.663113582085;4816.470188279286;4897.632677549198;1808.8299591760735;1842.3367587668429;1866.5800194956298;2032.1566549881634;2045.2943734411604;1041.9010194031555;1084.7505073833063;1093.1254996003165;1096.6490722968574;1097.6981330134117;17471.737923931152;18867.339643112424;18894.149763260688;18952.905235473736;19225.711614325795;1043.9112675422523;1086.147374311162;1089.7493576477455;1110.6334909479851;1178.8585369755513;10344.896551034544;10809.94690919619;10842.132629389629;10901.672949811518;11012.834807477895;502161;520336;520753;524015;551238;96373;100572.49713751531;101884;102437.97562024284;102633;1127.3236058364917;1148.1388958281289;1182.775272698202;1227.4231111377637;1229.610540089693;16963.321467141177;17058.65882682364;17123.22945467432;17183.3985810496;17278.136093195542;38467.23065538618;38940.41589376105;39043.609563904;39080.80459597798;39396;59082;59741.10388344265;59880.70059649674;60069.39930600813;60770.392296076476;8636.697715579925;8687.39188256816;8776.429532080394;8833.205011548991;9046.321525885453;8929.955350223207;12264.405627268397;13046.347682615642;13522.459101635824;13588.79616805729;10198.592056317664;11349.959582048456;11410.201285909907;11558.768824623628;11944.76110477803;5479.479449452455;10090.899091009289;10594.417307048187;11616.593419230287;11830.881691183322;11973.221740586834;12008.459619317326;12011.339376334385;12025.699357516132;12114.515419383479;7973.441859070042;8615.181557752254;8781.297496200417;8921.018687944192;9186.40288381253;10269.229807764297;11243.718907027063;11263.943680281875;11298.49156787963;11703.180777345504 17:18:25 INFO - PROCESS | 3375 | |3;mootools.html;1407.7466056109897;1568.7176308264516;1579.7077540654984;1743.08488043777;1843.4930394141618;7960.761177164687;8185.263326300632;8198.877016844745;8215.26062654361;8218.671253149867;8115.797105072376;8259.752207433772;8266.132056134109;8273.91726082739;8287.005559332874;2016.7781544030217;2065.163608738463;2230.631945728961;2271.250487339174;2291.140822191678;2284.6573014047945;2294.1167650454613;2298.4598619324447;2301.620232661609;2301.9309420717323;1804.5759246577045;1822;1841.6869132247482;1848.4731851422348;1849.8335149836512;1971.3198946363552;2186.606410846047;2189.5292512109895;2237.8881055947136;2247.9438014049615;2187.3984654220217;2208.2491952736145;2251.8648881067024;2255.210676263311;2258.8080013198896;8272.545010024447;8310.044344900292;8357.080721120672;8365.498070115751;8380.413371064027;4895.534924182232;5016.874578135539;5059.671121377099;5061.468545802674;5064.164412871909;3238.4008958342783;3278.5737854079057;3289.0626171541235;3309.93380132396;3311;1079.1852151625471;1098.9230753847235;1106.1869525898458;1140.8345789860423;1153.9826902596467;11905.345206013666;11951.880481195163;11960.760784784343;11972.940135299355;11991.460384282727;4250.4899412070135;4259.914801704011;4353.804078816461;4361.9127617447475;4364.8254069837485;10058.647947321808;10095.192384609214;10116.089551940213;10124.291299609104;10182.643607473703;4851.078295123915;4879.853604391874;4889.168841296988;4893.168161412568;4896.118698634209;4040.6565441937764;4441;4464.374987501752;4517.09658068381;4521.502634710179;3870.7871067091583;3942.64516193544;3991.8004099794894;3997.7401468904427;4051.8987025324604;1195.635331223985;1198.2451055834767;1209.2744353387898;1217.0628615965657;1240.3054289597853;871.3856731004627;897.9281657467387;956.1967946924617;983.0562659846628;986.807572523351;5566.276384070045;5585.692786896679;5712.028955077647;5805.88388232233;5812.041013232769;982.1700662939804;994.5176589354157;1033.1270076785104;1110.3781882145863;1126.3861195648392;3802.2585595809105;3810.3096062945096;3843.442700808367;3857.8263978121054;3918.7844668542934;10296.691099267035;10606.840897386546;10648.627298044532;10719.571217151382;10728.034476897117;10455.68632941013;10549.47252637365;10551.314164579278;10569.207309451822;10586.947065264778;7560.470767046364;7958.08482024563;7981.521108733495;8012.278894899487;8112.067112282045;5836.387179346108;5893.9115913260475;5914.526837852875;5943.257092863392;5982.401759824157;9414.717558473258;9449.14957653787;9570.56932438028;9578.712638620853;9694.709158724967;9517.238620910171;9824.115829575372;9846.852297215404;9849.064338887794;10023.097921187129;6705.497087718343;7056.894146587908;7250.456215783732;7295.781126566211;7448.217937116525;7933.60331983387;7940.245676660708;7943.086545047394;7967.681292748225;7981.40139489529;7072.3634872861685;7167.462440316893;7197.388222000979;7321.59731214767;7387.9261207387235;7018.192907815666;7078.327558882104;7146.964265178641;7147.142342918883;7162.319579639926;6118.082287656887;6233.812985610439;6244.843878903063;6245.0320200369015;6250.343713909974;4994;4995.750212489434;5000.000000000087;5025.447200807835;5100.132977393778;5052.8989420210655;5053.216751403538;5087.016063735072;5098.923516147187;5272.103742363884 17:18:25 INFO - PROCESS | 3375 | |4;prototype.html;317.44130330618106;338.55987216618405;342.6231145739687;346.2089126346299;354.42936871636647;5847.356790753014;6199.814005579834;6204.4416002559765;6222.128901953724;6301.968490157555;6186.814395568129;6198.752049917998;6228.003519436891;6237.189165408502;6241.531885108612;4610.170169369512;4623.560761727647;4632.559906808848;4634.2353511670535;4638.141943740402;4628.884277893046;4632.4672662643725;4635.304704294349;4640.211164102111;4644.767761611923;4576.748278844679;4585.977070114644;4587.059652771174;4593.586577208051;4595.080983803236;4500.324951257305;4583.54164583539;4592.586667199951;4593.081383723252;4596.655250856183;3959.544652364986;3964.5044369453817;3966.127451960564;3968;3969.3252147134767;6007.068904319837;6019.277686677583;6022.277326720821;6028.728707208186;6048.576599638027;5307.6019298552765;5310.495502927216;5345.3852806926925;5345.438728933484;5345.946540534623;6536.803895883131;6561.376669216417;6590.308017658125;6609.3390660934;6616.437602803768;4370.300751879716;4376.606105450493;4393.538678438782;4394.714343567658;4395.912081758379;6534.901976470357;6570.310117437696;6682.599044057372;6806.685726852894;6822.692978815916;4310.50429200646;4324.070324880166;4330.069035157457;4337.175936572041;4337.501187363494;4379.1241751649795;4382.123575284956;4384.605385515319;4385.956140438619;4387.648988080946;5118.872028199325;5181.145111056633;5284.894302114013;5297.735113244323;5304.867378315573;6504.869902601921;6519.250286217051;6532;6534.346565343428;6544.541882068304;1580.7707882356995;1593.7689035089847;1595.1465965708521;1596.640755829929;1600.3838522169049;1008.1732978957185;1019.7246743379394;1028.4857571214393;1034.6844212515105;1054.3252318516156;6335.651539165298;6370.076338930921;6375.489960803217;6383.765682011352;6393.296737358887;6730.461563074942;6735.797926062128;6738.258791532928;6750.257471678112;6769.559978601375;6342.873142537123;6364.299927008025;6364.554481186365;6366.395192456802;6377.617342959437;3600.0459878132315;3616.8734094306574;3618.2401695644207;3622.185008373095;3627.6009638939695;6922.376986071277;6943.791686249319;7102.112235970504;7128.251533589002;7136.429085673134;6896.172459304916;6922.342377474132;6927.445804335641;6932.549384290005;6942.895856562156;7103.822404439827;7106.289371062852;7114.786556403316;7118.608476533736;7122.074130363019;6780.898286525608;6791.573769508459;6799.11611490503;6813.829654258683;6816.727330906709;6467.159269294962;6680.532362734756;6681.532292739462;6688.899666504909;6698.961660942562;7087.149542054986;7100.005999160225;7109.857802844018;7112.893306600302;7128.607926564089;4362.323839804835;4391.912161756683;4393.143337049245;4395.472543294825;4396.758178300224;6774.796756097325;6778.813707601052;6779.186497620317;6780.830479238059;6782.69477873487;6485.805425837232;6635.8009259722285;6639.170103737033;6639.435647969976;6640.701168447335;6584.50616203777;6586.045023471665;6599.109120268702;6600.768973085919;6601.966990165019;6499.7400103995315;6544.443722283469;6550.050242714684;6554.573952693059;6559.573627714183;6658.9667051666365;6660.666966651551;6663.866722665616;6668.166479190101;6670.466362691071;6327.525435592441;6485.416312531895;6489.415952564292;6491.805245842632;6498.740050397932 17:18:25 INFO - PROCESS | 3375 | |5;yui.html;826.2527097401139;857.4126723194612;858.7895965488455;864.2524216552682;912.9589168487418;13819.585412437618;14719.484818031371;14853.331600077996;14869.92565037176;14886.255687215624;13467.191968481873;13496.055276130675;13499.999999999976;13553.93223033886;13554.457821687145;733.9486235963485;884.486997541426;895.1943251074052;909.6634245329237;915.9954200229023;912.406935491929;914.7758799094231;916.138829500271;916.1662886773038;917.4724533393293;954.3176628710471;955.350361754007;956.3926906414407;956.4978386347188;957.5164541906328;783.5377127494777;932.69687351611;944.5796620503878;945.191860958884;947.4788866123673;686.6120641837346;693.4106009891602;693.4417793676089;693.8716337477532;693.8785712500343;13843.723125537534;13995.720085598332;14018.92990535051;14038.92980535101;14066.296685165804;14508.968744375796;14953.40186392543;14985.175815330153;15036;15060.698786024219;11394.237007315987;11693.181477296592;11696.23974441667;11800.291982481078;12186.146969712123;3983.3029219886403;4001.899952501211;4061.9187616247805;4136.9793151034355;4137.81379837908;57196.428035719946;57733.7113314435;57882;57955.710221449044;58035.70982145105;11511.942440287745;11519.596814111634;11839.28964262147;11857.644270671894;11913.702157446132;20863.895680521804;20905.268315608882;20916.581668366547;20954.685679714818;20961.161553537993;7664.11862635804;7752.573608451589;7768.844623107506;7792.571408572583;7794.688212471551;4786.1624215762795;4807.182778927521;4841.419029716457;4842.055799119208;4934.037862616827;3346.1634591352163;3436.7250619950346;3438.707709844641;3439;3439.6560343965402;589.1163255117324;616.8149555133442;619.0683022051874;633.6704913444983;650.8047585724264;673.8955461903413;753.8228516298666;754.3889449545885;762.8359902620963;763.8701420758484;8638.568071596395;8956.373053886166;8959.148880856308;9138.314626403046;9155.725328240163;662.5097427903413;701.4633805139073;763.4884627299723;772.5557804262571;774.8101715079841;4259.23333799919;4352.238358287287;4464.843730469418;4476.932846007313;4511.278195488771;67863.3213667857;68481;68886.9666954996;68925.31074689189;68982;55901;55990.440095598526;57015.714921425955;60150;60643.39356606466;51809;53522.73238633704;53707;54143.18785218225;54576.72711636416;8585.09856465087;8666.566671666518;8734.673933096296;9100.089991001112;9134.22359099484;40226.59773402345;40231.798841005606;41627;41657.58342416537;42786.14427711491;50109.24836127534;52193.21710174427;52797.7360113197;52929;54259;11690.76618467643;11842.407879605813;12716.173448725804;13011.154274972096;13021.460337674664;14385.496507622183;14423.134611923319;14481.131132132106;14820.851791482379;14861.777073344125;10536.367817930948;12830.16603920742;13155.736885262433;13158.01314901367;13480.258585777485;13517.459301628218;13660.863391366356;13764.068735644878;13909.165450073027;14193.29033548339;13188.670283242996;13245.27151006704;13316.533921312708;13467.461301547828;13808;11415.942920285346;11495.195336326376;11520;11765.294082355085;11806.291622502677;11234.887651123385;11268.661940141808;11444.370559619301;11622.418879055844;11627.941860290644 17:18:25 INFO - PROCESS | 3375 | __end_tp_report 17:18:25 INFO - PROCESS | 3375 | __start_cc_report 17:18:25 INFO - PROCESS | 3375 | _x_x_mozilla_cycle_collect,878 17:18:25 INFO - PROCESS | 3375 | __end_cc_report 17:18:25 INFO - PROCESS | 3375 | __startTimestamp1462839505390__endTimestamp 17:18:25 INFO - PROCESS | 3375 | 17:18:25 INFO - PROCESS | 3375 | ------- Summary: start ------- 17:18:25 INFO - PROCESS | 3375 | Number of tests: 6 17:18:25 INFO - PROCESS | 3375 | 17:18:25 INFO - PROCESS | 3375 | [#0] dojo.html Cycles:165 Average:5344.18 Median:5521.31 stddev:567.87 (10.3%) stddev-sans-first:546.21 17:18:25 INFO - PROCESS | 3375 | Values: 3287.5 3343.3 3373.5 3373.9 3377.2 5454.3 5462.2 5476.7 5482.3 5492.7 5453.0 5489.1 5506.1 5511.4 5552.7 4792.5 4925.4 4994.1 5072.6 5103.0 4752.8 4819.2 4910.5 4919.1 4922.8 4961.1 5007.4 5010.9 5012.0 5045.2 4951.3 4980.8 4998.9 5002.2 5015.4 4775.6 4880.7 4927.3 4945.4 4952.9 5251.6 5255.2 5260.0 5263.8 5311.8 5489.6 5703.4 5704.5 5707.9 5725.5 5705.9 5742.2 5782.7 5794.2 5806.0 5405.1 5407.2 5411.0 5417.1 5418.0 5697.6 5881.3 5885.7 5888.9 5894.9 5701.9 5704.6 5709.1 5709.5 5747.9 5734.5 5739.9 5742.8 5768.7 5771.2 5555.0 5706.2 5728.4 5761.2 5789.7 5682.7 5689.7 5706.1 5712.4 5733.0 4346.5 4352.5 4359.0 4368.5 4369.3 3893.3 3951.5 3952.1 4026.9 4033.8 5365.7 5381.5 5383.6 5405.0 5424.1 5708.4 5711.9 5720.8 5726.2 5731.1 5336.4 5445.3 5493.7 5521.1 5543.6 4841.5 4842.4 4846.1 4846.5 4875.5 5784.7 5953.3 5961.4 5963.6 5964.9 5648.5 5744.2 5759.8 5766.5 5785.1 5951.6 5966.3 5966.6 5968.3 5978.4 5529.4 5640.6 5647.2 5650.9 5660.8 5700.3 5703.9 5704.8 5715.6 5741.7 5556.8 5597.2 5601.8 5603.3 5606.4 5493.1 5578.7 5598.1 5626.9 5709.1 5437.9 5441.2 5451.5 5460.3 5483.8 5531.1 5544.9 5550.1 5552.8 5590.6 5419.9 5485.4 5521.3 5557.2 5608.2 17:18:25 INFO - PROCESS | 3375 | 17:18:25 INFO - PROCESS | 3375 | [#1] ext.html Cycles:180 Average:57343.68 Median:41259.19 stddev:113706.97 (275.6%) stddev-sans-first:113946.13 17:18:25 INFO - PROCESS | 3375 | Values: 596.3 648.4 648.9 656.0 659.6 40601.2 41229.0 41241.8 41276.6 41292.2 47529.5 48197.5 48292.0 48358.8 48374.8 9130.6 9313.9 9323.2 9325.3 9327.2 9011.6 9126.4 9137.7 9140.8 9141.5 9128.1 9194.4 9197.7 9199.6 9202.8 9083.6 9130.6 9152.3 9154.2 9155.5 9046.6 9095.3 9124.4 9137.2 9159.0 42577.4 42963.4 43031.8 43047.8 43105.4 3845.1 3907.4 3961.1 4020.4 4216.1 31877.0 32929.5 33183.5 33426.2 34526.5 4227.7 4233.1 4293.4 4299.7 4341.7 326097.0 326148.0 326247.0 326369.0 326920.0 60480.7 60577.1 60684.4 61027.0 61083.7 64446.7 69163.3 70110.0 70510.6 70731.0 16419.3 16563.5 16577.8 16593.1 16598.3 12430.7 12494.1 12505.7 12506.2 12507.2 20369.3 20508.0 20671.8 20783.0 21135.9 7592.5 7658.3 7697.8 7750.0 7809.7 1121.9 1191.6 1212.5 1255.9 1275.5 34335.5 34988.5 35095.0 35237.8 35435.5 1210.2 1222.2 1270.1 1285.9 1354.4 17712.6 17942.6 18036.4 18038.7 18041.5 569354.0 582321.0 585553.0 586215.0 586270.0 53688.2 53973.7 54198.7 54233.2 54235.2 1377.5 1481.8 1482.7 1527.6 1528.2 30751.4 31551.4 32246.8 32329.2 32657.3 46248.3 46398.5 46940.3 46981.5 47040.0 240564.0 244954.0 246739.0 247753.0 518225.0 29918.6 30065.4 30471.4 31009.2 31051.2 44731.6 44778.0 44988.6 45600.3 46030.5 37555.4 38175.0 38634.2 38927.0 39412.0 36828.6 37231.6 37331.8 39247.8 40164.4 41796.8 42366.4 42470.4 42796.1 43194.0 34511.8 35738.0 36114.5 36331.0 36458.8 28260.7 28560.0 28714.4 28717.3 29071.9 17:18:25 INFO - PROCESS | 3375 | 17:18:25 INFO - PROCESS | 3375 | [#2] jquery.html Cycles:180 Average:29734.29 Median:2067.22 stddev:86389.58 (4179.0%) stddev-sans-first:86603.88 17:18:25 INFO - PROCESS | 3375 | Values: 418.0 432.2 437.5 441.5 448.9 18715.5 18912.4 19460.5 19945.0 20285.8 19167.0 19408.1 20053.4 20110.5 20153.0 5635.9 5675.6 5897.1 5904.0 5911.8 4279.2 5791.4 5843.0 6166.3 6437.4 6388.1 6422.1 6426.9 6430.4 6434.7 6065.9 6331.6 6349.7 6350.5 6363.6 3866.5 4287.0 5602.9 5722.0 5740.2 12953.2 13030.5 13196.2 13213.1 13256.6 2360.0 2479.1 2480.1 2541.2 2666.5 9912.8 9950.8 10000.1 10078.7 10140.9 2046.8 2087.6 2089.1 2099.5 2122.3 74589.6 75546.0 76197.0 77319.0 80410.2 10998.5 11256.8 11265.6 11321.9 11358.1 15574.5 15671.5 15820.7 15862.1 15868.7 8005.2 8036.2 8042.8 8120.4 8140.2 7581.1 7626.0 7638.7 7642.2 7717.3 4769.6 4812.0 4812.7 4816.5 4897.6 1808.8 1842.3 1866.6 2032.2 2045.3 1041.9 1084.8 1093.1 1096.6 1097.7 17471.7 18867.3 18894.1 18952.9 19225.7 1043.9 1086.1 1089.7 1110.6 1178.9 10344.9 10809.9 10842.1 10901.7 11012.8 502161.0 520336.0 520753.0 524015.0 551238.0 96373.0 100572.5 101884.0 102438.0 102633.0 1127.3 1148.1 1182.8 1227.4 1229.6 16963.3 17058.7 17123.2 17183.4 17278.1 38467.2 38940.4 39043.6 39080.8 39396.0 59082.0 59741.1 59880.7 60069.4 60770.4 8636.7 8687.4 8776.4 8833.2 9046.3 8930.0 12264.4 13046.3 13522.5 13588.8 10198.6 11350.0 11410.2 11558.8 11944.8 5479.5 10090.9 10594.4 11616.6 11830.9 11973.2 12008.5 12011.3 12025.7 12114.5 7973.4 8615.2 8781.3 8921.0 9186.4 10269.2 11243.7 11263.9 11298.5 11703.2 17:18:25 INFO - PROCESS | 3375 | 17:18:25 INFO - PROCESS | 3375 | [#3] mootools.html Cycles:180 Average:5527.87 Median:4884.51 stddev:3155.80 (64.6%) stddev-sans-first:3149.47 17:18:25 INFO - PROCESS | 3375 | Values: 1407.7 1568.7 1579.7 1743.1 1843.5 7960.8 8185.3 8198.9 8215.3 8218.7 8115.8 8259.8 8266.1 8273.9 8287.0 2016.8 2065.2 2230.6 2271.3 2291.1 2284.7 2294.1 2298.5 2301.6 2301.9 1804.6 1822.0 1841.7 1848.5 1849.8 1971.3 2186.6 2189.5 2237.9 2247.9 2187.4 2208.2 2251.9 2255.2 2258.8 8272.5 8310.0 8357.1 8365.5 8380.4 4895.5 5016.9 5059.7 5061.5 5064.2 3238.4 3278.6 3289.1 3309.9 3311.0 1079.2 1098.9 1106.2 1140.8 1154.0 11905.3 11951.9 11960.8 11972.9 11991.5 4250.5 4259.9 4353.8 4361.9 4364.8 10058.6 10095.2 10116.1 10124.3 10182.6 4851.1 4879.9 4889.2 4893.2 4896.1 4040.7 4441.0 4464.4 4517.1 4521.5 3870.8 3942.6 3991.8 3997.7 4051.9 1195.6 1198.2 1209.3 1217.1 1240.3 871.4 897.9 956.2 983.1 986.8 5566.3 5585.7 5712.0 5805.9 5812.0 982.2 994.5 1033.1 1110.4 1126.4 3802.3 3810.3 3843.4 3857.8 3918.8 10296.7 10606.8 10648.6 10719.6 10728.0 10455.7 10549.5 10551.3 10569.2 10586.9 7560.5 7958.1 7981.5 8012.3 8112.1 5836.4 5893.9 5914.5 5943.3 5982.4 9414.7 9449.1 9570.6 9578.7 9694.7 9517.2 9824.1 9846.9 9849.1 10023.1 6705.5 7056.9 7250.5 7295.8 7448.2 7933.6 7940.2 7943.1 7967.7 7981.4 7072.4 7167.5 7197.4 7321.6 7387.9 7018.2 7078.3 7147.0 7147.1 7162.3 6118.1 6233.8 6244.8 6245.0 6250.3 4994.0 4995.8 5000.0 5025.4 5100.1 5052.9 5053.2 5087.0 5098.9 5272.1 17:18:25 INFO - PROCESS | 3375 | 17:18:25 INFO - PROCESS | 3375 | [#4] prototype.html Cycles:180 Average:5443.83 Median:6331.59 stddev:1704.94 (26.9%) stddev-sans-first:1665.74 17:18:25 INFO - PROCESS | 3375 | Values: 317.4 338.6 342.6 346.2 354.4 5847.4 6199.8 6204.4 6222.1 6302.0 6186.8 6198.8 6228.0 6237.2 6241.5 4610.2 4623.6 4632.6 4634.2 4638.1 4628.9 4632.5 4635.3 4640.2 4644.8 4576.7 4586.0 4587.1 4593.6 4595.1 4500.3 4583.5 4592.6 4593.1 4596.7 3959.5 3964.5 3966.1 3968.0 3969.3 6007.1 6019.3 6022.3 6028.7 6048.6 5307.6 5310.5 5345.4 5345.4 5345.9 6536.8 6561.4 6590.3 6609.3 6616.4 4370.3 4376.6 4393.5 4394.7 4395.9 6534.9 6570.3 6682.6 6806.7 6822.7 4310.5 4324.1 4330.1 4337.2 4337.5 4379.1 4382.1 4384.6 4386.0 4387.6 5118.9 5181.1 5284.9 5297.7 5304.9 6504.9 6519.3 6532.0 6534.3 6544.5 1580.8 1593.8 1595.1 1596.6 1600.4 1008.2 1019.7 1028.5 1034.7 1054.3 6335.7 6370.1 6375.5 6383.8 6393.3 6730.5 6735.8 6738.3 6750.3 6769.6 6342.9 6364.3 6364.6 6366.4 6377.6 3600.0 3616.9 3618.2 3622.2 3627.6 6922.4 6943.8 7102.1 7128.3 7136.4 6896.2 6922.3 6927.4 6932.5 6942.9 7103.8 7106.3 7114.8 7118.6 7122.1 6780.9 6791.6 6799.1 6813.8 6816.7 6467.2 6680.5 6681.5 6688.9 6699.0 7087.1 7100.0 7109.9 7112.9 7128.6 4362.3 4391.9 4393.1 4395.5 4396.8 6774.8 6778.8 6779.2 6780.8 6782.7 6485.8 6635.8 6639.2 6639.4 6640.7 6584.5 6586.0 6599.1 6600.8 6602.0 6499.7 6544.4 6550.1 6554.6 6559.6 6659.0 6660.7 6663.9 6668.2 6670.5 6327.5 6485.4 6489.4 6491.8 6498.7 17:18:25 INFO - PROCESS | 3375 | 17:18:25 INFO - PROCESS | 3375 | [#5] yui.html Cycles:180 Average:15906.72 Median:4796.67 stddev:18773.80 (391.4%) stddev-sans-first:18792.31 17:18:25 INFO - PROCESS | 3375 | Values: 826.3 857.4 858.8 864.3 913.0 13819.6 14719.5 14853.3 14869.9 14886.3 13467.2 13496.1 13500.0 13553.9 13554.5 733.9 884.5 895.2 909.7 916.0 912.4 914.8 916.1 916.2 917.5 954.3 955.4 956.4 956.5 957.5 783.5 932.7 944.6 945.2 947.5 686.6 693.4 693.4 693.9 693.9 13843.7 13995.7 14018.9 14038.9 14066.3 14509.0 14953.4 14985.2 15036.0 15060.7 11394.2 11693.2 11696.2 11800.3 12186.1 3983.3 4001.9 4061.9 4137.0 4137.8 57196.4 57733.7 57882.0 57955.7 58035.7 11511.9 11519.6 11839.3 11857.6 11913.7 20863.9 20905.3 20916.6 20954.7 20961.2 7664.1 7752.6 7768.8 7792.6 7794.7 4786.2 4807.2 4841.4 4842.1 4934.0 3346.2 3436.7 3438.7 3439.0 3439.7 589.1 616.8 619.1 633.7 650.8 673.9 753.8 754.4 762.8 763.9 8638.6 8956.4 8959.1 9138.3 9155.7 662.5 701.5 763.5 772.6 774.8 4259.2 4352.2 4464.8 4476.9 4511.3 67863.3 68481.0 68887.0 68925.3 68982.0 55901.0 55990.4 57015.7 60150.0 60643.4 51809.0 53522.7 53707.0 54143.2 54576.7 8585.1 8666.6 8734.7 9100.1 9134.2 40226.6 40231.8 41627.0 41657.6 42786.1 50109.2 52193.2 52797.7 52929.0 54259.0 11690.8 11842.4 12716.2 13011.2 13021.5 14385.5 14423.1 14481.1 14820.9 14861.8 10536.4 12830.2 13155.7 13158.0 13480.3 13517.5 13660.9 13764.1 13909.2 14193.3 13188.7 13245.3 13316.5 13467.5 13808.0 11415.9 11495.2 11520.0 11765.3 11806.3 11234.9 11268.7 11444.4 11622.4 11627.9 17:18:25 INFO - PROCESS | 3375 | -------- Summary: end -------- 17:18:25 INFO - PROCESS | 3375 | 17:18:26 INFO - TEST-INFO | 3375: exit 0 17:18:26 INFO - TEST-OK | dromaeo_css | took 1115514ms 17:18:26 INFO - TEST-START | kraken 17:18:26 INFO - operating with platform_type : linux_ 17:18:26 INFO - Initialising browser for kraken test... 17:18:26 INFO - TEST-INFO | started process 3564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYTrOfQ/profile http://localhost:53324/getInfo.html) 17:18:30 INFO - PROCESS | 3564 | __metrics Screen width/height:1600/1200 17:18:30 INFO - PROCESS | 3564 | colorDepth:24 17:18:30 INFO - PROCESS | 3564 | Browser inner width/height: 1024/697 17:18:30 INFO - PROCESS | 3564 | __metrics 17:18:31 ERROR - PROCESS | 3564 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:18:32 INFO - TEST-INFO | 3564: exit 0 17:18:32 INFO - Browser initialized. 17:18:32 INFO - Running cycle 1/1 for kraken test... 17:18:32 INFO - TEST-INFO | started process 3652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYTrOfQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:44 INFO - PROCESS | 3652 | RSS: Main: 141479936 17:18:44 INFO - PROCESS | 3652 | 17:18:47 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53324/tests/kraken/driver.html?testName=audio-beat-detection) 17:18:47 INFO - PROCESS | 3652 | RSS: Main: 196550656 17:18:47 INFO - PROCESS | 3652 | 17:18:50 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53324/tests/kraken/driver.html?testName=audio-dft) 17:18:51 INFO - PROCESS | 3652 | RSS: Main: 182067200 17:18:51 INFO - PROCESS | 3652 | 17:18:53 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53324/tests/kraken/driver.html?testName=audio-fft) 17:18:54 INFO - PROCESS | 3652 | RSS: Main: 273346560 17:18:54 INFO - PROCESS | 3652 | 17:18:56 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53324/tests/kraken/driver.html?testName=audio-oscillator) 17:18:57 INFO - PROCESS | 3652 | RSS: Main: 178663424 17:18:57 INFO - PROCESS | 3652 | 17:18:59 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53324/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:00 INFO - PROCESS | 3652 | RSS: Main: 177577984 17:19:00 INFO - PROCESS | 3652 | 17:19:02 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53324/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:03 INFO - PROCESS | 3652 | RSS: Main: 212066304 17:19:03 INFO - PROCESS | 3652 | 17:19:06 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53324/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:07 INFO - PROCESS | 3652 | RSS: Main: 212893696 17:19:07 INFO - PROCESS | 3652 | 17:19:11 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53324/tests/kraken/driver.html?testName=json-parse-financial) 17:19:11 INFO - PROCESS | 3652 | RSS: Main: 212926464 17:19:11 INFO - PROCESS | 3652 | 17:19:12 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53324/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:19:12 INFO - PROCESS | 3652 | RSS: Main: 191127552 17:19:12 INFO - PROCESS | 3652 | 17:19:14 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53324/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:19:15 INFO - PROCESS | 3652 | RSS: Main: 193093632 17:19:15 INFO - PROCESS | 3652 | 17:19:20 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53324/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:19:20 INFO - PROCESS | 3652 | RSS: Main: 192335872 17:19:20 INFO - PROCESS | 3652 | 17:19:23 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:19:23 INFO - PROCESS | 3652 | RSS: Main: 211595264 17:19:23 INFO - PROCESS | 3652 | 17:19:26 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:19:26 INFO - PROCESS | 3652 | RSS: Main: 207908864 17:19:26 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | Cycle 1(1): loaded http://localhost:53324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53324/tests/kraken/driver.html?testName=ai-astar) 17:19:28 INFO - PROCESS | 3652 | RSS: Main: 270888960 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | __start_tp_report 17:19:28 INFO - PROCESS | 3652 | _x_x_mozilla_page_load 17:19:28 INFO - PROCESS | 3652 | _x_x_mozilla_page_load_details 17:19:28 INFO - PROCESS | 3652 | |i|pagename|runs| 17:19:28 INFO - PROCESS | 3652 | |0;ai-astar;110;112;112;110;110;112;105;109;110;109 17:19:28 INFO - PROCESS | 3652 | |1;audio-beat-detection;155;126;157;176;126;160;152;138;177;133 17:19:28 INFO - PROCESS | 3652 | |2;audio-dft;161;162;160;159;160;161;159;162;162;159 17:19:28 INFO - PROCESS | 3652 | |3;audio-fft;75;75;75;179;75;77;75;72;167;75 17:19:28 INFO - PROCESS | 3652 | |4;audio-oscillator;91;92;159;93;92;92;144;91;93;155 17:19:28 INFO - PROCESS | 3652 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;117;117 17:19:28 INFO - PROCESS | 3652 | |6;imaging-darkroom;145;145;145;145;146;146;145;144;146;145 17:19:28 INFO - PROCESS | 3652 | |7;imaging-desaturate;94;95;95;95;94;95;95;95;94;98 17:19:28 INFO - PROCESS | 3652 | |8;json-parse-financial;59;54;55;54;54;55;55;72;53;52 17:19:28 INFO - PROCESS | 3652 | |9;json-stringify-tinderbox;57;59;58;58;57;58;58;58;57;58 17:19:28 INFO - PROCESS | 3652 | |10;stanford-crypto-aes;72;72;81;76;76;75;82;80;72;72 17:19:28 INFO - PROCESS | 3652 | |11;stanford-crypto-ccm;114;118;114;115;114;114;126;122;116;110 17:19:28 INFO - PROCESS | 3652 | |12;stanford-crypto-pbkdf2;158;156;156;155;161;159;157;159;160;157 17:19:28 INFO - PROCESS | 3652 | |13;stanford-crypto-sha256-iterative;69;68;66;67;65;66;64;65;65;65 17:19:28 INFO - PROCESS | 3652 | __end_tp_report 17:19:28 INFO - PROCESS | 3652 | __start_cc_report 17:19:28 INFO - PROCESS | 3652 | _x_x_mozilla_cycle_collect,1626 17:19:28 INFO - PROCESS | 3652 | __end_cc_report 17:19:28 INFO - PROCESS | 3652 | __startTimestamp1462839568875__endTimestamp 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | ------- Summary: start ------- 17:19:28 INFO - PROCESS | 3652 | Number of tests: 14 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:2.08 (1.9%) stddev-sans-first:2.20 17:19:28 INFO - PROCESS | 3652 | Values: 110.0 112.0 112.0 110.0 110.0 112.0 105.0 109.0 110.0 109.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:156.00 stddev:18.76 (12.0%) stddev-sans-first:19.81 17:19:28 INFO - PROCESS | 3652 | Values: 155.0 126.0 157.0 176.0 126.0 160.0 152.0 138.0 177.0 133.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 17:19:28 INFO - PROCESS | 3652 | Values: 161.0 162.0 160.0 159.0 160.0 161.0 159.0 162.0 162.0 159.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:41.49 (55.3%) stddev-sans-first:43.40 17:19:28 INFO - PROCESS | 3652 | Values: 75.0 75.0 75.0 179.0 75.0 77.0 75.0 72.0 167.0 75.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.00 stddev:29.54 (32.1%) stddev-sans-first:30.50 17:19:28 INFO - PROCESS | 3652 | Values: 91.0 92.0 159.0 93.0 92.0 92.0 144.0 91.0 93.0 155.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 17:19:28 INFO - PROCESS | 3652 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:19:28 INFO - PROCESS | 3652 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 145.0 144.0 146.0 145.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.15 (1.2%) stddev-sans-first:1.17 17:19:28 INFO - PROCESS | 3652 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 98.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:5.81 (10.6%) stddev-sans-first:6.08 17:19:28 INFO - PROCESS | 3652 | Values: 59.0 54.0 55.0 54.0 54.0 55.0 55.0 72.0 53.0 52.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 17:19:28 INFO - PROCESS | 3652 | Values: 57.0 59.0 58.0 58.0 57.0 58.0 58.0 58.0 57.0 58.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:3.97 (5.2%) stddev-sans-first:3.96 17:19:28 INFO - PROCESS | 3652 | Values: 72.0 72.0 81.0 76.0 76.0 75.0 82.0 80.0 72.0 72.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:115.50 stddev:4.62 (4.0%) stddev-sans-first:4.82 17:19:28 INFO - PROCESS | 3652 | Values: 114.0 118.0 114.0 115.0 114.0 114.0 126.0 122.0 116.0 110.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:158.50 stddev:1.93 (1.2%) stddev-sans-first:2.05 17:19:28 INFO - PROCESS | 3652 | Values: 158.0 156.0 156.0 155.0 161.0 159.0 157.0 159.0 160.0 157.0 17:19:28 INFO - PROCESS | 3652 | 17:19:28 INFO - PROCESS | 3652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.56 (2.4%) stddev-sans-first:1.22 17:19:28 INFO - PROCESS | 3652 | Values: 69.0 68.0 66.0 67.0 65.0 66.0 64.0 65.0 65.0 65.0 17:19:28 INFO - PROCESS | 3652 | -------- Summary: end -------- 17:19:28 INFO - PROCESS | 3652 | 17:19:29 INFO - TEST-INFO | 3652: exit 0 17:19:29 INFO - TEST-OK | kraken | took 63608ms 17:19:29 INFO - SUITE-END | took 1179s 17:19:30 INFO - Completed test suite (00:19:39) 17:19:30 INFO - javascript benchmark 17:19:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.5397444357786, 3343.314620502797, 3373.4771110477886, 3373.949390759138, 3377.1894745261143, 5454.318210223722, 5462.180672899067, 5476.698781567012, 5482.314710661168, 5492.697901615409, 5453.0, 5489.149181876805, 5506.079338232721, 5511.3937466878615, 5552.694601796909, 4792.472827988919, 4925.384326959139, 4994.051130285252, 5072.568831649296, 5102.974485127569, 4752.833650822222, 4819.180739274332, 4910.484399138093, 4919.13915064864, 4922.753862306889, 4961.05739909416, 5007.37407824022, 5010.899782004358, 5012.0, 5045.217991211368, 4951.257311403282, 4980.750962451899, 4998.875028124289, 5002.224655178435, 5015.398152221756, 4775.641826863, 4880.707157570557, 4927.334809800667, 4945.431275403303, 4952.925706114411, 5251.6061295403, 5255.185446255837, 5260.00059988601, 5263.8420847374255, 5311.814086506954, 5489.64317319373, 5703.40114288002, 5704.515116215127, 5707.942920570783, 5725.541956643458, 5705.857353566194, 5742.196092547047, 5782.7397767100165, 5794.246747922743, 5806.04200306953, 5405.054115529767, 5407.188921661743, 5411.026015317241, 5417.079096553595, 5417.999999999961, 5697.572682048863, 5881.323647780475, 5885.676287804212, 5888.911666325009, 5894.852628684317, 5701.885962280731, 5704.600677952587, 5709.05800542914, 5709.457601527848, 5747.85630359236, 5734.541236701138, 5739.885202295931, 5742.799002034993, 5768.711564421762, 5771.249737534094, 5554.972225138848, 5706.229658996065, 5728.369879313273, 5761.164631128547, 5789.681567513827, 5682.659040457585, 5689.743961521742, 5706.144078388192, 5712.371639119693, 5733.025385684444, 4346.500152482442, 4352.477702675699, 4359.0, 4368.475782906072, 4369.3227549729845, 3893.260280546687, 3951.545572259227, 3952.051507638146, 4026.899327516777, 4033.798310084484, 5365.651232669864, 5381.54256888161, 5383.596230282745, 5405.0, 5424.050791111618, 5708.429157084258, 5711.857203569861, 5720.8283751487525, 5726.169705392695, 5731.140328950607, 5336.359636843604, 5445.319335083114, 5493.697846618475, 5521.061419558685, 5543.584231182677, 4841.515848415201, 4842.394700662418, 4846.127697014571, 4846.466888642247, 4875.536824001785, 5784.652920824764, 5953.255843019622, 5961.374055724174, 5963.5825492216, 5964.910526342108, 5648.5481161507805, 5744.195812586157, 5759.769609215752, 5766.481016708516, 5785.074388097884, 5951.58338916289, 5966.254218222723, 5966.612170208922, 5968.313643931004, 5978.4021597839865, 5529.364123125892, 5640.633358831663, 5647.20939068539, 5650.858728531655, 5660.773569057356, 5700.25896633435, 5703.8859222816145, 5704.80033198836, 5715.628484148683, 5741.655500669973, 5556.805511807229, 5597.160425936142, 5601.831945041656, 5603.327600687943, 5606.355269143937, 5493.066178749542, 5578.721063946868, 5598.076317407582, 5626.943730562642, 5709.115087161496, 5437.945620543744, 5441.183822426668, 5451.536619387238, 5460.34475862899, 5483.7806487740045, 5531.059719847716, 5544.889102218014, 5550.111982082847, 5552.833414997556, 5590.552755779447, 5419.918701219563, 5485.369182544058, 5521.309836270466, 5557.1664250361155, 5608.158776183605], "value": 5309.2842908186385, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.2844586496203, 648.3710800523494, 648.9383508566686, 655.9508036897234, 659.6240143118422, 40601.18797624049, 41229.0, 41241.79379103108, 41276.587234127684, 41292.17415651689, 47529.52470475294, 48197.51802481974, 48292.0, 48358.75820620901, 48374.75812620941, 9130.589123489442, 9313.860292095624, 9323.160915517603, 9325.347225694204, 9327.16055555, 9011.594478248462, 9126.406783559047, 9137.68018119366, 9140.771480713001, 9141.451512909247, 9128.132827381422, 9194.402363846328, 9197.678081267157, 9199.632014719436, 9202.76993075175, 9083.636654533811, 9130.589123489426, 9152.267818574564, 9154.221891139261, 9155.450672959643, 9046.638134474613, 9095.31785116119, 9124.361294709373, 9137.177654011104, 9159.0, 42577.36133957993, 42963.35554966678, 43031.7848410756, 43047.784761076306, 43105.35341969873, 3845.1156234066043, 3907.355286377744, 3961.1483531040676, 4020.4170395292517, 4216.093539888939, 31877.0, 32929.506057409155, 33183.502247466306, 33426.1643458913, 34526.48210276848, 4227.661787057028, 4233.111046680201, 4293.355996600504, 4299.656027517823, 4341.674374421899, 326097.0, 326147.9999999976, 326247.0, 326369.0, 326920.0, 60480.69759651174, 60577.09134362988, 60684.393156067876, 61027.0, 61083.694581526805, 64446.67776661087, 69163.3083669167, 70110.0, 70510.64744676347, 70731.0, 16419.343226270816, 16563.503094907173, 16577.83422165787, 16593.087380193963, 16598.25307861149, 12430.689232769073, 12494.125411221126, 12505.74988500225, 12506.18709783861, 12507.249565026128, 20369.2870749526, 20507.974601269878, 20671.793282067287, 20783.0, 21135.8943205283, 7592.52801992528, 7658.324004477882, 7697.805410754586, 7750.0, 7809.687612495437, 1121.9439028048564, 1191.559123124432, 1212.4543955220186, 1255.9497620095094, 1275.5216793702361, 34335.48861277469, 34988.47517287243, 35095.0, 35237.82381088078, 35435.468467973, 1210.152892974921, 1222.2422098299112, 1270.142653708743, 1285.9228446293253, 1354.4446776821455, 17712.55718607045, 17942.551436213937, 18036.368727094752, 18038.729419058724, 18041.548961276072, 569354.0, 582321.0, 585553.0, 586215.0, 586270.0, 53688.194677079875, 53973.73013134909, 54198.729006355505, 54233.1865022025, 54235.18647220295, 1377.4627895120911, 1481.7851411545266, 1482.7405204089457, 1527.6104593328407, 1528.1900592685672, 30751.384972300875, 31551.36897262088, 32246.83876580602, 32329.19177020499, 32657.34685306328, 46248.30627540657, 46398.53601464077, 46940.295895562274, 46981.530184697716, 47040.0, 240564.0, 244954.0, 246739.0, 247753.0, 518225.0, 29918.551221731257, 30065.398692026476, 30471.390572188877, 31009.224769380948, 31051.223719407197, 44731.552684472736, 44778.0, 44988.55011449844, 45600.31599526076, 46030.53969460396, 37555.436668449445, 38175.0, 38634.22731545297, 38927.0, 39412.0, 36828.631713682524, 37231.6276837239, 37331.81334093312, 39247.80376098101, 40164.39753403643, 41796.79101604473, 42366.36450453184, 42470.362944555236, 42796.14407711891, 43194.0, 34511.82744086264, 35738.0, 36114.45828312525, 36331.0, 36458.8177059113, 28260.71739282581, 28560.0, 28714.42571148607, 28717.28206794847, 29071.854640726662], "value": 20479.305621566196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.98328066877326, 432.1853306517214, 437.4990635722098, 441.50988425281406, 448.86534039788074, 18715.532111697197, 18912.432627021193, 19460.51348716281, 19945.0, 20285.797142028576, 19167.0, 19408.126634301454, 20053.398398048044, 20110.497237569067, 20153.0, 5635.943640563582, 5675.631083979539, 5897.11543268511, 5903.970480147594, 5911.793087241947, 4279.186954478655, 5791.449812267828, 5843.035899076647, 6166.321704612489, 6437.356264373549, 6388.105665206875, 6422.068800023993, 6426.871462570746, 6430.421262086411, 6434.6782660867, 6065.909011364833, 6331.588446750947, 6349.714262858182, 6350.523710721714, 6363.5863668861375, 3866.4780254665543, 4286.957130428687, 5602.943970560283, 5721.971390143064, 5740.225069615591, 12953.158044727063, 13030.478780848754, 13196.208227506284, 13213.075084744072, 13256.602301930958, 2359.97640023601, 2479.1446950801947, 2480.06997375984, 2541.1614167324738, 2666.4800363929044, 9912.752181195456, 9950.800983980353, 10000.149987251092, 10078.748031299203, 10140.89859101407, 2046.8055534724178, 2087.6346639338053, 2089.101686274901, 2099.5381016176416, 2122.342073957063, 74589.62705186494, 75545.99999999945, 76197.0, 77319.0, 80410.19589804085, 10998.505067271992, 11256.831147532794, 11265.605703800491, 11321.886781132249, 11358.148138889452, 15574.532764017098, 15671.451499197474, 15820.683586328209, 15862.127582982816, 15868.682626347409, 8005.159458256916, 8036.196380361917, 8042.83914321722, 8120.390970677223, 8140.185981401931, 7581.090269167735, 7626.0, 7638.69445222196, 7642.159362470124, 7717.2668596483245, 4769.594584460359, 4811.975940120277, 4812.663113582085, 4816.470188279286, 4897.632677549198, 1808.8299591760735, 1842.3367587668429, 1866.5800194956298, 2032.1566549881634, 2045.2943734411604, 1041.9010194031555, 1084.7505073833063, 1093.1254996003165, 1096.6490722968574, 1097.6981330134117, 17471.737923931152, 18867.339643112424, 18894.149763260688, 18952.905235473736, 19225.711614325795, 1043.9112675422523, 1086.147374311162, 1089.7493576477455, 1110.6334909479851, 1178.8585369755513, 10344.896551034544, 10809.94690919619, 10842.132629389629, 10901.672949811518, 11012.834807477895, 502161.0, 520336.0, 520753.0, 524015.0, 551238.0, 96373.0, 100572.49713751531, 101884.0, 102437.97562024284, 102633.0, 1127.3236058364917, 1148.1388958281289, 1182.775272698202, 1227.4231111377637, 1229.610540089693, 16963.321467141177, 17058.65882682364, 17123.22945467432, 17183.3985810496, 17278.136093195542, 38467.23065538618, 38940.41589376105, 39043.609563904, 39080.80459597798, 39396.0, 59082.0, 59741.10388344265, 59880.70059649674, 60069.39930600813, 60770.392296076476, 8636.697715579925, 8687.39188256816, 8776.429532080394, 8833.205011548991, 9046.321525885453, 8929.955350223207, 12264.405627268397, 13046.347682615642, 13522.459101635824, 13588.79616805729, 10198.592056317664, 11349.959582048456, 11410.201285909907, 11558.768824623628, 11944.76110477803, 5479.479449452455, 10090.899091009289, 10594.417307048187, 11616.593419230287, 11830.881691183322, 11973.221740586834, 12008.459619317326, 12011.339376334385, 12025.699357516132, 12114.515419383479, 7973.441859070042, 8615.181557752254, 8781.297496200417, 8921.018687944192, 9186.40288381253, 10269.229807764297, 11243.718907027063, 11263.943680281875, 11298.49156787963, 11703.180777345504], "value": 9208.81198055748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.7466056109897, 1568.7176308264516, 1579.7077540654984, 1743.08488043777, 1843.4930394141618, 7960.761177164687, 8185.263326300632, 8198.877016844745, 8215.26062654361, 8218.671253149867, 8115.797105072376, 8259.752207433772, 8266.132056134109, 8273.91726082739, 8287.005559332874, 2016.7781544030217, 2065.163608738463, 2230.631945728961, 2271.250487339174, 2291.140822191678, 2284.6573014047945, 2294.1167650454613, 2298.4598619324447, 2301.620232661609, 2301.9309420717323, 1804.5759246577045, 1822.0, 1841.6869132247482, 1848.4731851422348, 1849.8335149836512, 1971.3198946363552, 2186.606410846047, 2189.5292512109895, 2237.8881055947136, 2247.9438014049615, 2187.3984654220217, 2208.2491952736145, 2251.8648881067024, 2255.210676263311, 2258.8080013198896, 8272.545010024447, 8310.044344900292, 8357.080721120672, 8365.498070115751, 8380.413371064027, 4895.534924182232, 5016.874578135539, 5059.671121377099, 5061.468545802674, 5064.164412871909, 3238.4008958342783, 3278.5737854079057, 3289.0626171541235, 3309.93380132396, 3311.0, 1079.1852151625471, 1098.9230753847235, 1106.1869525898458, 1140.8345789860423, 1153.9826902596467, 11905.345206013666, 11951.880481195163, 11960.760784784343, 11972.940135299355, 11991.460384282727, 4250.4899412070135, 4259.914801704011, 4353.804078816461, 4361.9127617447475, 4364.8254069837485, 10058.647947321808, 10095.192384609214, 10116.089551940213, 10124.291299609104, 10182.643607473703, 4851.078295123915, 4879.853604391874, 4889.168841296988, 4893.168161412568, 4896.118698634209, 4040.6565441937764, 4441.0, 4464.374987501752, 4517.09658068381, 4521.502634710179, 3870.7871067091583, 3942.64516193544, 3991.8004099794894, 3997.7401468904427, 4051.8987025324604, 1195.635331223985, 1198.2451055834767, 1209.2744353387898, 1217.0628615965657, 1240.3054289597853, 871.3856731004627, 897.9281657467387, 956.1967946924617, 983.0562659846628, 986.807572523351, 5566.276384070045, 5585.692786896679, 5712.028955077647, 5805.88388232233, 5812.041013232769, 982.1700662939804, 994.5176589354157, 1033.1270076785104, 1110.3781882145863, 1126.3861195648392, 3802.2585595809105, 3810.3096062945096, 3843.442700808367, 3857.8263978121054, 3918.7844668542934, 10296.691099267035, 10606.840897386546, 10648.627298044532, 10719.571217151382, 10728.034476897117, 10455.68632941013, 10549.47252637365, 10551.314164579278, 10569.207309451822, 10586.947065264778, 7560.470767046364, 7958.08482024563, 7981.521108733495, 8012.278894899487, 8112.067112282045, 5836.387179346108, 5893.9115913260475, 5914.526837852875, 5943.257092863392, 5982.401759824157, 9414.717558473258, 9449.14957653787, 9570.56932438028, 9578.712638620853, 9694.709158724967, 9517.238620910171, 9824.115829575372, 9846.852297215404, 9849.064338887794, 10023.097921187129, 6705.497087718343, 7056.894146587908, 7250.456215783732, 7295.781126566211, 7448.217937116525, 7933.60331983387, 7940.245676660708, 7943.086545047394, 7967.681292748225, 7981.40139489529, 7072.3634872861685, 7167.462440316893, 7197.388222000979, 7321.59731214767, 7387.9261207387235, 7018.192907815666, 7078.327558882104, 7146.964265178641, 7147.142342918883, 7162.319579639926, 6118.082287656887, 6233.812985610439, 6244.843878903063, 6245.0320200369015, 6250.343713909974, 4994.0, 4995.750212489434, 5000.000000000087, 5025.447200807835, 5100.132977393778, 5052.8989420210655, 5053.216751403538, 5087.016063735072, 5098.923516147187, 5272.103742363884], "value": 4437.966117090725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.44130330618106, 338.55987216618405, 342.6231145739687, 346.2089126346299, 354.42936871636647, 5847.356790753014, 6199.814005579834, 6204.4416002559765, 6222.128901953724, 6301.968490157555, 6186.814395568129, 6198.752049917998, 6228.003519436891, 6237.189165408502, 6241.531885108612, 4610.170169369512, 4623.560761727647, 4632.559906808848, 4634.2353511670535, 4638.141943740402, 4628.884277893046, 4632.4672662643725, 4635.304704294349, 4640.211164102111, 4644.767761611923, 4576.748278844679, 4585.977070114644, 4587.059652771174, 4593.586577208051, 4595.080983803236, 4500.324951257305, 4583.54164583539, 4592.586667199951, 4593.081383723252, 4596.655250856183, 3959.544652364986, 3964.5044369453817, 3966.127451960564, 3968.0, 3969.3252147134767, 6007.068904319837, 6019.277686677583, 6022.277326720821, 6028.728707208186, 6048.576599638027, 5307.6019298552765, 5310.495502927216, 5345.3852806926925, 5345.438728933484, 5345.946540534623, 6536.803895883131, 6561.376669216417, 6590.308017658125, 6609.3390660934, 6616.437602803768, 4370.300751879716, 4376.606105450493, 4393.538678438782, 4394.714343567658, 4395.912081758379, 6534.901976470357, 6570.310117437696, 6682.599044057372, 6806.685726852894, 6822.692978815916, 4310.50429200646, 4324.070324880166, 4330.069035157457, 4337.175936572041, 4337.501187363494, 4379.1241751649795, 4382.123575284956, 4384.605385515319, 4385.956140438619, 4387.648988080946, 5118.872028199325, 5181.145111056633, 5284.894302114013, 5297.735113244323, 5304.867378315573, 6504.869902601921, 6519.250286217051, 6532.0, 6534.346565343428, 6544.541882068304, 1580.7707882356995, 1593.7689035089847, 1595.1465965708521, 1596.640755829929, 1600.3838522169049, 1008.1732978957185, 1019.7246743379394, 1028.4857571214393, 1034.6844212515105, 1054.3252318516156, 6335.651539165298, 6370.076338930921, 6375.489960803217, 6383.765682011352, 6393.296737358887, 6730.461563074942, 6735.797926062128, 6738.258791532928, 6750.257471678112, 6769.559978601375, 6342.873142537123, 6364.299927008025, 6364.554481186365, 6366.395192456802, 6377.617342959437, 3600.0459878132315, 3616.8734094306574, 3618.2401695644207, 3622.185008373095, 3627.6009638939695, 6922.376986071277, 6943.791686249319, 7102.112235970504, 7128.251533589002, 7136.429085673134, 6896.172459304916, 6922.342377474132, 6927.445804335641, 6932.549384290005, 6942.895856562156, 7103.822404439827, 7106.289371062852, 7114.786556403316, 7118.608476533736, 7122.074130363019, 6780.898286525608, 6791.573769508459, 6799.11611490503, 6813.829654258683, 6816.727330906709, 6467.159269294962, 6680.532362734756, 6681.532292739462, 6688.899666504909, 6698.961660942562, 7087.149542054986, 7100.005999160225, 7109.857802844018, 7112.893306600302, 7128.607926564089, 4362.323839804835, 4391.912161756683, 4393.143337049245, 4395.472543294825, 4396.758178300224, 6774.796756097325, 6778.813707601052, 6779.186497620317, 6780.830479238059, 6782.69477873487, 6485.805425837232, 6635.8009259722285, 6639.170103737033, 6639.435647969976, 6640.701168447335, 6584.50616203777, 6586.045023471665, 6599.109120268702, 6600.768973085919, 6601.966990165019, 6499.7400103995315, 6544.443722283469, 6550.050242714684, 6554.573952693059, 6559.573627714183, 6658.9667051666365, 6660.666966651551, 6663.866722665616, 6668.166479190101, 6670.466362691071, 6327.525435592441, 6485.416312531895, 6489.415952564292, 6491.805245842632, 6498.740050397932], "value": 4882.401597273744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.2527097401139, 857.4126723194612, 858.7895965488455, 864.2524216552682, 912.9589168487418, 13819.585412437618, 14719.484818031371, 14853.331600077996, 14869.92565037176, 14886.255687215624, 13467.191968481873, 13496.055276130675, 13499.999999999976, 13553.93223033886, 13554.457821687145, 733.9486235963485, 884.486997541426, 895.1943251074052, 909.6634245329237, 915.9954200229023, 912.406935491929, 914.7758799094231, 916.138829500271, 916.1662886773038, 917.4724533393293, 954.3176628710471, 955.350361754007, 956.3926906414407, 956.4978386347188, 957.5164541906328, 783.5377127494777, 932.69687351611, 944.5796620503878, 945.191860958884, 947.4788866123673, 686.6120641837346, 693.4106009891602, 693.4417793676089, 693.8716337477532, 693.8785712500343, 13843.723125537534, 13995.720085598332, 14018.92990535051, 14038.92980535101, 14066.296685165804, 14508.968744375796, 14953.40186392543, 14985.175815330153, 15036.0, 15060.698786024219, 11394.237007315987, 11693.181477296592, 11696.23974441667, 11800.291982481078, 12186.146969712123, 3983.3029219886403, 4001.899952501211, 4061.9187616247805, 4136.9793151034355, 4137.81379837908, 57196.428035719946, 57733.7113314435, 57882.0, 57955.710221449044, 58035.70982145105, 11511.942440287745, 11519.596814111634, 11839.28964262147, 11857.644270671894, 11913.702157446132, 20863.895680521804, 20905.268315608882, 20916.581668366547, 20954.685679714818, 20961.161553537993, 7664.11862635804, 7752.573608451589, 7768.844623107506, 7792.571408572583, 7794.688212471551, 4786.1624215762795, 4807.182778927521, 4841.419029716457, 4842.055799119208, 4934.037862616827, 3346.1634591352163, 3436.7250619950346, 3438.707709844641, 3439.0, 3439.6560343965402, 589.1163255117324, 616.8149555133442, 619.0683022051874, 633.6704913444983, 650.8047585724264, 673.8955461903413, 753.8228516298666, 754.3889449545885, 762.8359902620963, 763.8701420758484, 8638.568071596395, 8956.373053886166, 8959.148880856308, 9138.314626403046, 9155.725328240163, 662.5097427903413, 701.4633805139073, 763.4884627299723, 772.5557804262571, 774.8101715079841, 4259.23333799919, 4352.238358287287, 4464.843730469418, 4476.932846007313, 4511.278195488771, 67863.3213667857, 68481.0, 68886.9666954996, 68925.31074689189, 68982.0, 55901.0, 55990.440095598526, 57015.714921425955, 60150.0, 60643.39356606466, 51809.0, 53522.73238633704, 53707.0, 54143.18785218225, 54576.72711636416, 8585.09856465087, 8666.566671666518, 8734.673933096296, 9100.089991001112, 9134.22359099484, 40226.59773402345, 40231.798841005606, 41627.0, 41657.58342416537, 42786.14427711491, 50109.24836127534, 52193.21710174427, 52797.7360113197, 52929.0, 54259.0, 11690.76618467643, 11842.407879605813, 12716.173448725804, 13011.154274972096, 13021.460337674664, 14385.496507622183, 14423.134611923319, 14481.131132132106, 14820.851791482379, 14861.777073344125, 10536.367817930948, 12830.16603920742, 13155.736885262433, 13158.01314901367, 13480.258585777485, 13517.459301628218, 13660.863391366356, 13764.068735644878, 13909.165450073027, 14193.29033548339, 13188.670283242996, 13245.27151006704, 13316.533921312708, 13467.461301547828, 13808.0, 11415.942920285346, 11495.195336326376, 11520.0, 11765.294082355085, 11806.291622502677, 11234.887651123385, 11268.661940141808, 11444.370559619301, 11622.418879055844, 11627.941860290644], "value": 7108.908941494983, "unit": "score"}], "name": "dromaeo_css", "value": 7323.234036247717, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 110.0, 110.0, 112.0, 105.0, 109.0, 110.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 157.0, 176.0, 126.0, 160.0, 152.0, 138.0, 177.0, 133.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 159.0, 160.0, 161.0, 159.0, 162.0, 162.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 179.0, 75.0, 77.0, 75.0, 72.0, 167.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 159.0, 93.0, 92.0, 92.0, 144.0, 91.0, 93.0, 155.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 144.0, 146.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 98.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 55.0, 54.0, 54.0, 55.0, 55.0, 72.0, 53.0, 52.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 81.0, 76.0, 76.0, 75.0, 82.0, 80.0, 72.0, 72.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 114.0, 115.0, 114.0, 114.0, 126.0, 122.0, 116.0, 110.0], "value": 116.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 156.0, 155.0, 161.0, 159.0, 157.0, 159.0, 160.0, 157.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 67.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1512.0999999999997, "alertThreshold": 2.0}]} 17:19:30 INFO - Return code: 0 17:19:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:19:30 ERROR - # TBPL SUCCESS # 17:19:30 INFO - Running post-action listener: _resource_record_post_action 17:19:30 INFO - Running post-run listener: _resource_record_post_run 17:19:31 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8093696; Write bytes: 390004736; Read time: 2468; Write time: 745608 17:19:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20287488; Read time: 0; Write time: 7148 17:19:31 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 6356992; Write bytes: 369717248; Read time: 2432; Write time: 738460 17:19:31 INFO - Running post-run listener: _upload_blobber_files 17:19:31 INFO - Blob upload gear active. 17:19:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:19:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:19:31 INFO - (blobuploader) - INFO - Open directory for files ... 17:19:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:19:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:32 INFO - (blobuploader) - INFO - Done attempting. 17:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:19:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:33 INFO - (blobuploader) - INFO - Done attempting. 17:19:33 INFO - (blobuploader) - INFO - Iteration through files over. 17:19:33 INFO - Return code: 0 17:19:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:19:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:19:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab3e2ffefa2f0ce6cfceb3174caadbdf09884909f5b95416b3fc96ccba820690b0269c88b3469f410e57e0adafb33f62e17f4c935dc6f683afc9dae8de0e269d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49ddffed5786318576b27ca5f92ea9fa055706f46544f8b51f1a0d114ff75a629d2f615190de17da958b073641a2c0db4e02c38669e8353b8cc03bfb3b538f99"} 17:19:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:19:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:19:33 INFO - Contents: 17:19:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab3e2ffefa2f0ce6cfceb3174caadbdf09884909f5b95416b3fc96ccba820690b0269c88b3469f410e57e0adafb33f62e17f4c935dc6f683afc9dae8de0e269d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49ddffed5786318576b27ca5f92ea9fa055706f46544f8b51f1a0d114ff75a629d2f615190de17da958b073641a2c0db4e02c38669e8353b8cc03bfb3b538f99"} 17:19:33 INFO - Running post-run listener: copy_logs_to_upload_dir 17:19:33 INFO - Copying logs to upload dir... 17:19:33 INFO - mkdir: /builds/slave/test/build/upload/logs 17:19:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.095995 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-05-09 17:19:33.348024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 17:19:33.351843) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366 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/ab3e2ffefa2f0ce6cfceb3174caadbdf09884909f5b95416b3fc96ccba820690b0269c88b3469f410e57e0adafb33f62e17f4c935dc6f683afc9dae8de0e269d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49ddffed5786318576b27ca5f92ea9fa055706f46544f8b51f1a0d114ff75a629d2f615190de17da958b073641a2c0db4e02c38669e8353b8cc03bfb3b538f99"} build_url:https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/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/ab3e2ffefa2f0ce6cfceb3174caadbdf09884909f5b95416b3fc96ccba820690b0269c88b3469f410e57e0adafb33f62e17f4c935dc6f683afc9dae8de0e269d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49ddffed5786318576b27ca5f92ea9fa055706f46544f8b51f1a0d114ff75a629d2f615190de17da958b073641a2c0db4e02c38669e8353b8cc03bfb3b538f99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 17:19:33.375824) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:19:33.376130) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462837135.985398-1935389366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:19:33.458936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 17:19:33.459220) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 17:19:33.459486) ========= ========= Total master_lag: 0.17 =========