builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1462485701.61 results: success (0) buildid: 20160505123841 builduid: 1457772db7ef4c1982b4796b67a4914d revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:41.612214) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:41.626474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:41.626841) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:41.643296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:41.643642) ========= 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=6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 15:01:41-- 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% 43.0M=0s 2016-05-05 15:01:41 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109053 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:41.766661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:41.766954) ========= 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=6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017220 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:41.817475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:41.817914) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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=6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 15:01:42,020 truncating revision to first 12 chars 2016-05-05 15:01:42,020 Setting DEBUG logging. 2016-05-05 15:01:42,020 attempt 1/10 2016-05-05 15:01:42,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0123e9f41ced?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 15:01:42,283 unpacking tar archive at: mozilla-aurora-0123e9f41ced/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:42.389326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:42.389642) ========= script_repo_revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:42.390019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:42.390293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 15:01:42.399264) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-05 15:01:42.399575) ========= /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=6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:42 INFO - MultiFileLogger online at 20160505 15:01:42 in /builds/slave/test 15:01:42 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 15:01:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:42 INFO - {'append_to_log': False, 15:01:42 INFO - 'base_work_dir': '/builds/slave/test', 15:01:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:01:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:42 INFO - 'branch': 'Mozilla-Aurora', 15:01:42 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:42 INFO - 'config_files': ('talos/linux_config.py',), 15:01:42 INFO - 'default_actions': ('clobber', 15:01:42 INFO - 'read-buildbot-config', 15:01:42 INFO - 'download-and-extract', 15:01:42 INFO - 'populate-webroot', 15:01:42 INFO - 'create-virtualenv', 15:01:42 INFO - 'install', 15:01:42 INFO - 'run-tests'), 15:01:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:42 INFO - 'download_minidump_stackwalk': True, 15:01:42 INFO - 'download_symbols': 'ondemand', 15:01:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:42 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:42 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:42 INFO - 'installer_path': 'installer.exe', 15:01:42 INFO - 'log_level': 'info', 15:01:42 INFO - 'log_name': 'talos', 15:01:42 INFO - 'log_to_console': True, 15:01:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:42 INFO - 'opt_config_files': (), 15:01:42 INFO - 'pip_index': False, 15:01:42 INFO - 'sps_profile': False, 15:01:42 INFO - 'sps_profile_interval': 0, 15:01:42 INFO - 'suite': 'dromaeojs', 15:01:42 INFO - 'system_bits': '32', 15:01:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:42 INFO - 'title': 'talos-linux64-ix-050', 15:01:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:42 INFO - 'use_talos_json': True, 15:01:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:42 INFO - 'work_dir': 'build'} 15:01:42 INFO - ##### 15:01:42 INFO - ##### Running clobber step. 15:01:42 INFO - ##### 15:01:42 INFO - Running pre-action listener: _resource_record_pre_action 15:01:42 INFO - Running main action method: clobber 15:01:42 INFO - rmtree: /builds/slave/test/build 15:01:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:43 INFO - Running post-action listener: _resource_record_post_action 15:01:43 INFO - ##### 15:01:43 INFO - ##### Running read-buildbot-config step. 15:01:43 INFO - ##### 15:01:43 INFO - Running pre-action listener: _resource_record_pre_action 15:01:43 INFO - Running main action method: read_buildbot_config 15:01:43 INFO - Using buildbot properties: 15:01:43 INFO - { 15:01:43 INFO - "project": "", 15:01:43 INFO - "product": "firefox", 15:01:43 INFO - "script_repo_revision": "production", 15:01:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:01:43 INFO - "repository": "", 15:01:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:01:43 INFO - "buildid": "20160505123841", 15:01:43 INFO - "pgo_build": "True", 15:01:43 INFO - "basedir": "/builds/slave/test", 15:01:43 INFO - "buildnumber": 220, 15:01:43 INFO - "slavename": "talos-linux64-ix-050", 15:01:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:01:43 INFO - "platform": "ubuntu64_hw", 15:01:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:01:43 INFO - "branch": "mozilla-aurora", 15:01:43 INFO - "repo_path": "releases/mozilla-aurora", 15:01:43 INFO - "revision": "0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b", 15:01:43 INFO - "stage_platform": "linux64-pgo", 15:01:43 INFO - "builduid": "1457772db7ef4c1982b4796b67a4914d", 15:01:43 INFO - "slavebuilddir": "test" 15:01:43 INFO - } 15:01:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 15:01:43 INFO - Running post-action listener: _resource_record_post_action 15:01:43 INFO - ##### 15:01:43 INFO - ##### Running download-and-extract step. 15:01:43 INFO - ##### 15:01:43 INFO - Running pre-action listener: _resource_record_pre_action 15:01:43 INFO - Running main action method: download_and_extract 15:01:43 INFO - mkdir: /builds/slave/test/build/tests 15:01:43 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')]} 15:01:43 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:01:43 INFO - Downloaded 1361 bytes. 15:01:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 15:01:43 INFO - Using the following test package requirements: 15:01:43 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:01:43 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:01:43 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:01:43 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:43 INFO - u'jsshell-linux-x86_64.zip'], 15:01:43 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:01:43 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 15:01:43 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:01:43 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:01:43 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:01:43 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 15:01:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:01:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:01:43 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')]} 15:01:43 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:02:01 INFO - Downloaded 23824026 bytes. 15:02:01 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'] 15:02:01 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 15:02:02 INFO - Return code: 0 15:02:02 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 15:02: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')]} 15:02:02 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 15:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:02:04 INFO - Downloaded 23824026 bytes. 15:02:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:02:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:02:05 INFO - Return code: 0 15:02:05 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')]} 15:02:05 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:02:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:02:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 15:02:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:02:06 INFO - Downloaded 10840145 bytes. 15:02:06 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'] 15:02:06 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 15:02:07 INFO - Return code: 0 15:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:07 INFO - https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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 15:02:08 INFO - Downloaded 62687148 bytes. 15:02:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:02:08 INFO - mkdir: /builds/slave/test/properties 15:02:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:02:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:02:08 INFO - Contents: 15:02:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 15:02:11 INFO - Running post-action listener: _resource_record_post_action 15:02:11 INFO - Running post-action listener: set_extra_try_arguments 15:02:11 INFO - ##### 15:02:11 INFO - ##### Running populate-webroot step. 15:02:11 INFO - ##### 15:02:11 INFO - Running pre-action listener: _resource_record_pre_action 15:02:11 INFO - Running main action method: populate_webroot 15:02:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:02:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:02:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:02:11 INFO - '--tppagecycles', 15:02:11 INFO - '7'], 15:02:11 INFO - 'tests': ['tsvgm']}}, 15:02:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:02:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:02:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:02:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:02:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:11 INFO - 'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:11 INFO - 'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['damp', 'tps']}, 15:02:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:11 INFO - 'tests': ['damp', 'tps']}, 15:02:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['dromaeo_dom']}, 15:02:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:02:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['a11yr', 15:02:11 INFO - 'ts_paint', 15:02:11 INFO - 'tpaint', 15:02:11 INFO - 'sessionrestore', 15:02:11 INFO - 'sessionrestore_no_auto_restore', 15:02:11 INFO - 'tabpaint']}, 15:02:11 INFO - 'other-e10s': {'tests': ['a11yr', 15:02:11 INFO - 'ts_paint', 15:02:11 INFO - 'tpaint', 15:02:11 INFO - 'sessionrestore', 15:02:11 INFO - 'sessionrestore_no_auto_restore', 15:02:11 INFO - 'tabpaint']}, 15:02:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:02:11 INFO - 'ts_paint', 15:02:11 INFO - 'tpaint', 15:02:11 INFO - 'sessionrestore', 15:02:11 INFO - 'sessionrestore_no_auto_restore', 15:02:11 INFO - 'tabpaint']}, 15:02:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:02:11 INFO - 'ts_paint', 15:02:11 INFO - 'tpaint', 15:02:11 INFO - 'sessionrestore', 15:02:11 INFO - 'sessionrestore_no_auto_restore', 15:02:11 INFO - 'tabpaint']}, 15:02:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['a11yr', 15:02:11 INFO - 'ts_paint', 15:02:11 INFO - 'tpaint', 15:02:11 INFO - 'sessionrestore', 15:02:11 INFO - 'sessionrestore_no_auto_restore', 15:02:11 INFO - 'tabpaint']}, 15:02:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['a11yr', 15:02:11 INFO - 'ts_paint', 15:02:11 INFO - 'tpaint', 15:02:11 INFO - 'sessionrestore', 15:02:11 INFO - 'sessionrestore_no_auto_restore', 15:02:11 INFO - 'tabpaint']}, 15:02:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['tsvgx', 15:02:11 INFO - 'tsvgr_opacity', 15:02:11 INFO - 'tart', 15:02:11 INFO - 'tscrollx', 15:02:11 INFO - 'cart']}, 15:02:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:02:11 INFO - 'tsvgr_opacity', 15:02:11 INFO - 'tart', 15:02:11 INFO - 'tscrollx', 15:02:11 INFO - 'cart']}, 15:02:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:11 INFO - 'talos_options': ['--disable-e10s'], 15:02:11 INFO - 'tests': ['tp5o']}, 15:02:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:11 INFO - 'tests': ['tp5o']}, 15:02:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:11 INFO - 'talos_options': ['--disable-e10s', 15:02:11 INFO - '--xperf_path', 15:02:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:11 INFO - 'tests': ['tp5n']}, 15:02:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:11 INFO - 'talos_options': ['--xperf_path', 15:02:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:11 INFO - 'tests': ['tp5n']}}, 15:02:11 INFO - 'talos.zip': {'path': '', 15:02:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:02:11 INFO - Running post-action listener: _resource_record_post_action 15:02:11 INFO - ##### 15:02:11 INFO - ##### Running create-virtualenv step. 15:02:11 INFO - ##### 15:02:11 INFO - Running pre-action listener: _resource_record_pre_action 15:02:11 INFO - Running main action method: create_virtualenv 15:02:11 INFO - Creating virtualenv /builds/slave/test/build/venv 15:02:11 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 15:02:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:02:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:02:11 INFO - Using real prefix '/usr' 15:02:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:02:12 INFO - Installing distribute.............................................................................................................................................................................................done. 15:02:14 INFO - Installing pip.................done. 15:02:14 INFO - Return code: 0 15:02:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:02: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')]} 15:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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')]} 15:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25a0599f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', '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 15:02: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', 'pip>=1.5'] in /builds/slave/test/build 15:02: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 pip>=1.5 15:02:14 INFO - Using env: {'DISPLAY': ':0', 15:02:14 INFO - 'HOME': '/home/cltbld', 15:02:14 INFO - 'LANG': 'en_US.UTF-8', 15:02:14 INFO - 'LANGUAGE': 'en_US:en', 15:02:14 INFO - 'LOGNAME': 'cltbld', 15:02:14 INFO - 'MAIL': '/var/mail/cltbld', 15:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:14 INFO - 'MOZ_NO_REMOTE': '1', 15:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:14 INFO - 'NO_EM_RESTART': '1', 15:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:14 INFO - 'PWD': '/builds/slave/test', 15:02:14 INFO - 'SHELL': '/bin/bash', 15:02:14 INFO - 'SHLVL': '1', 15:02:14 INFO - 'TERM': 'linux', 15:02:14 INFO - 'TMOUT': '86400', 15:02:14 INFO - 'USER': 'cltbld', 15:02:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:14 INFO - '_': '/tools/buildbot/bin/python'} 15:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:14 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 15:02:14 INFO - Cleaning up... 15:02:14 INFO - Return code: 0 15:02:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:02: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')]} 15:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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')]} 15:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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', '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 0x7f25a0599f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', '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 15:02: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', 'psutil>=0.7.1'] in /builds/slave/test/build 15:02: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 psutil>=0.7.1 15:02:14 INFO - Using env: {'DISPLAY': ':0', 15:02:14 INFO - 'HOME': '/home/cltbld', 15:02:14 INFO - 'LANG': 'en_US.UTF-8', 15:02:14 INFO - 'LANGUAGE': 'en_US:en', 15:02:14 INFO - 'LOGNAME': 'cltbld', 15:02:14 INFO - 'MAIL': '/var/mail/cltbld', 15:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:14 INFO - 'MOZ_NO_REMOTE': '1', 15:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:14 INFO - 'NO_EM_RESTART': '1', 15:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:14 INFO - 'PWD': '/builds/slave/test', 15:02:14 INFO - 'SHELL': '/bin/bash', 15:02:14 INFO - 'SHLVL': '1', 15:02:14 INFO - 'TERM': 'linux', 15:02:14 INFO - 'TMOUT': '86400', 15:02:14 INFO - 'USER': 'cltbld', 15:02:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:14 INFO - '_': '/tools/buildbot/bin/python'} 15:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:14 INFO - Downloading/unpacking psutil>=0.7.1 15:02:14 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 15:02:14 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 15:02:14 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 15:02:14 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 15:02:14 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 15:02:14 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 15:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:02:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:16 INFO - Installing collected packages: psutil 15:02:16 INFO - Running setup.py install for psutil 15:02:16 INFO - building 'psutil._psutil_linux' extension 15:02:16 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 15:02:16 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 15:02:16 INFO - building 'psutil._psutil_posix' extension 15:02:16 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 15:02:17 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 15:02:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:17 INFO - Successfully installed psutil 15:02:17 INFO - Cleaning up... 15:02:17 INFO - Return code: 0 15:02:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:02: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')]} 15:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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')]} 15:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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', '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 0x7f25a0599f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', '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 15:02: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:02: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 mozsystemmonitor==0.0.0 15:02:17 INFO - Using env: {'DISPLAY': ':0', 15:02:17 INFO - 'HOME': '/home/cltbld', 15:02:17 INFO - 'LANG': 'en_US.UTF-8', 15:02:17 INFO - 'LANGUAGE': 'en_US:en', 15:02:17 INFO - 'LOGNAME': 'cltbld', 15:02:17 INFO - 'MAIL': '/var/mail/cltbld', 15:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:17 INFO - 'MOZ_NO_REMOTE': '1', 15:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:17 INFO - 'NO_EM_RESTART': '1', 15:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:17 INFO - 'PWD': '/builds/slave/test', 15:02:17 INFO - 'SHELL': '/bin/bash', 15:02:17 INFO - 'SHLVL': '1', 15:02:17 INFO - 'TERM': 'linux', 15:02:17 INFO - 'TMOUT': '86400', 15:02:17 INFO - 'USER': 'cltbld', 15:02:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:17 INFO - '_': '/tools/buildbot/bin/python'} 15:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:02:19 INFO - Installing collected packages: mozsystemmonitor 15:02:19 INFO - Running setup.py install for mozsystemmonitor 15:02:19 INFO - Successfully installed mozsystemmonitor 15:02:19 INFO - Cleaning up... 15:02:19 INFO - Return code: 0 15:02:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f25a0599f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', '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 15:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:02:19 INFO - Using env: {'DISPLAY': ':0', 15:02:19 INFO - 'HOME': '/home/cltbld', 15:02:19 INFO - 'LANG': 'en_US.UTF-8', 15:02:19 INFO - 'LANGUAGE': 'en_US:en', 15:02:19 INFO - 'LOGNAME': 'cltbld', 15:02:19 INFO - 'MAIL': '/var/mail/cltbld', 15:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:19 INFO - 'MOZ_NO_REMOTE': '1', 15:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:19 INFO - 'NO_EM_RESTART': '1', 15:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:19 INFO - 'PWD': '/builds/slave/test', 15:02:19 INFO - 'SHELL': '/bin/bash', 15:02:19 INFO - 'SHLVL': '1', 15:02:19 INFO - 'TERM': 'linux', 15:02:19 INFO - 'TMOUT': '86400', 15:02:19 INFO - 'USER': 'cltbld', 15:02:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:19 INFO - '_': '/tools/buildbot/bin/python'} 15:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:19 INFO - Downloading/unpacking blobuploader==1.2.4 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02:21 INFO - Downloading blobuploader-1.2.4.tar.gz 15:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:02:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:02:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:22 INFO - Downloading docopt-0.6.1.tar.gz 15:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:02:22 INFO - Installing collected packages: blobuploader, requests, docopt 15:02:22 INFO - Running setup.py install for blobuploader 15:02:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:02:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:02:22 INFO - Running setup.py install for requests 15:02:22 INFO - Running setup.py install for docopt 15:02:22 INFO - Successfully installed blobuploader requests docopt 15:02:22 INFO - Cleaning up... 15:02:22 INFO - Return code: 0 15:02:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:22 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 0x7f25a0599f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', '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 15:02:22 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 15:02:22 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 15:02:22 INFO - Using env: {'DISPLAY': ':0', 15:02:22 INFO - 'HOME': '/home/cltbld', 15:02:22 INFO - 'LANG': 'en_US.UTF-8', 15:02:22 INFO - 'LANGUAGE': 'en_US:en', 15:02:22 INFO - 'LOGNAME': 'cltbld', 15:02:22 INFO - 'MAIL': '/var/mail/cltbld', 15:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:22 INFO - 'MOZ_NO_REMOTE': '1', 15:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:22 INFO - 'NO_EM_RESTART': '1', 15:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:22 INFO - 'PWD': '/builds/slave/test', 15:02:22 INFO - 'SHELL': '/bin/bash', 15:02:22 INFO - 'SHLVL': '1', 15:02:22 INFO - 'TERM': 'linux', 15:02:22 INFO - 'TMOUT': '86400', 15:02:22 INFO - 'USER': 'cltbld', 15:02:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:22 INFO - '_': '/tools/buildbot/bin/python'} 15:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:23 INFO - Running setup.py (path:/tmp/pip-P3_DPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:23 INFO - Running setup.py (path:/tmp/pip-qSRaRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:23 INFO - Running setup.py (path:/tmp/pip-BNYMr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:23 INFO - Running setup.py (path:/tmp/pip-iagq5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:23 INFO - Running setup.py (path:/tmp/pip-gN3QTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:23 INFO - Running setup.py (path:/tmp/pip-rsSbLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:23 INFO - Running setup.py (path:/tmp/pip-kakNJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:23 INFO - Running setup.py (path:/tmp/pip-otjYbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:23 INFO - Running setup.py (path:/tmp/pip-_xRAGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:23 INFO - Running setup.py (path:/tmp/pip-71ZIJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:23 INFO - Running setup.py (path:/tmp/pip-jBMKYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:24 INFO - Running setup.py (path:/tmp/pip-NdIoSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:24 INFO - Running setup.py (path:/tmp/pip-Q49_gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:24 INFO - Running setup.py (path:/tmp/pip-MH1j6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:24 INFO - Running setup.py (path:/tmp/pip-v_njKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:24 INFO - Running setup.py (path:/tmp/pip-qBukZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:24 INFO - Running setup.py (path:/tmp/pip-akcoKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:02:24 INFO - Running setup.py install for manifestparser 15:02:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Running setup.py install for mozcrash 15:02:24 INFO - Running setup.py install for mozdebug 15:02:24 INFO - Running setup.py install for mozdevice 15:02:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Running setup.py install for mozfile 15:02:24 INFO - Running setup.py install for mozhttpd 15:02:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Running setup.py install for mozinfo 15:02:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Running setup.py install for mozInstall 15:02:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Running setup.py install for mozleak 15:02:25 INFO - Running setup.py install for mozlog 15:02:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Running setup.py install for moznetwork 15:02:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Running setup.py install for mozprocess 15:02:25 INFO - Running setup.py install for mozprofile 15:02:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Running setup.py install for mozrunner 15:02:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:02:25 INFO - Running setup.py install for mozscreenshot 15:02:26 INFO - Running setup.py install for moztest 15:02:26 INFO - Running setup.py install for mozversion 15:02:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:02:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:02:26 INFO - Cleaning up... 15:02:26 INFO - Return code: 0 15:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:26 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 0x7f25a0599f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', '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 15:02:26 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 15:02:26 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 15:02:26 INFO - Using env: {'DISPLAY': ':0', 15:02:26 INFO - 'HOME': '/home/cltbld', 15:02:26 INFO - 'LANG': 'en_US.UTF-8', 15:02:26 INFO - 'LANGUAGE': 'en_US:en', 15:02:26 INFO - 'LOGNAME': 'cltbld', 15:02:26 INFO - 'MAIL': '/var/mail/cltbld', 15:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:26 INFO - 'MOZ_NO_REMOTE': '1', 15:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:26 INFO - 'NO_EM_RESTART': '1', 15:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:26 INFO - 'PWD': '/builds/slave/test', 15:02:26 INFO - 'SHELL': '/bin/bash', 15:02:26 INFO - 'SHLVL': '1', 15:02:26 INFO - 'TERM': 'linux', 15:02:26 INFO - 'TMOUT': '86400', 15:02:26 INFO - 'USER': 'cltbld', 15:02:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:26 INFO - '_': '/tools/buildbot/bin/python'} 15:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:26 INFO - Running setup.py (path:/tmp/pip-IlApeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:26 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)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:26 INFO - Running setup.py (path:/tmp/pip-hY7OkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:26 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)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:26 INFO - Running setup.py (path:/tmp/pip-9lVxfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:26 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)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:26 INFO - Running setup.py (path:/tmp/pip-sR6obt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:26 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)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:26 INFO - Running setup.py (path:/tmp/pip-omGW3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:26 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)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:26 INFO - Running setup.py (path:/tmp/pip-w89Fog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:26 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)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:26 INFO - Running setup.py (path:/tmp/pip-VzkmsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:26 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)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:26 INFO - Running setup.py (path:/tmp/pip-mM2PiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:27 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)) 15:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:27 INFO - Running setup.py (path:/tmp/pip-kFZVQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:27 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)) 15:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:27 INFO - Running setup.py (path:/tmp/pip-JNyBHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:27 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)) 15:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:27 INFO - Running setup.py (path:/tmp/pip-mdya3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:27 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)) 15:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:27 INFO - Running setup.py (path:/tmp/pip-1G1j_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:27 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)) 15:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:27 INFO - Running setup.py (path:/tmp/pip-9JWIMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:27 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)) 15:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:27 INFO - Running setup.py (path:/tmp/pip-od2x5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:27 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)) 15:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:27 INFO - Running setup.py (path:/tmp/pip-6gr1sL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:27 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)) 15:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:27 INFO - Running setup.py (path:/tmp/pip-VWPVSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:27 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)) 15:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:27 INFO - Running setup.py (path:/tmp/pip-cmT41x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:27 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)) 15:02:27 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)) 15:02:27 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)) 15:02:27 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)) 15:02:27 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)) 15:02:27 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)) 15:02:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:29 INFO - Downloading blessings-1.6.tar.gz 15:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:02:29 INFO - Installing collected packages: blessings 15:02:29 INFO - Running setup.py install for blessings 15:02:29 INFO - Successfully installed blessings 15:02:29 INFO - Cleaning up... 15:02:29 INFO - Return code: 0 15:02:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:30 INFO - Reading from file tmpfile_stdout 15:02:30 INFO - Current package versions: 15:02:30 INFO - argparse == 1.2.1 15:02:30 INFO - blessings == 1.6 15:02:30 INFO - blobuploader == 1.2.4 15:02:30 INFO - docopt == 0.6.1 15:02:30 INFO - manifestparser == 1.1 15:02:30 INFO - mozInstall == 1.12 15:02:30 INFO - mozcrash == 0.17 15:02:30 INFO - mozdebug == 0.1 15:02:30 INFO - mozdevice == 0.48 15:02:30 INFO - mozfile == 1.2 15:02:30 INFO - mozhttpd == 0.7 15:02:30 INFO - mozinfo == 0.9 15:02:30 INFO - mozleak == 0.1 15:02:30 INFO - mozlog == 3.1 15:02:30 INFO - moznetwork == 0.27 15:02:30 INFO - mozprocess == 0.22 15:02:30 INFO - mozprofile == 0.28 15:02:30 INFO - mozrunner == 6.11 15:02:30 INFO - mozscreenshot == 0.1 15:02:30 INFO - mozsystemmonitor == 0.0 15:02:30 INFO - moztest == 0.7 15:02:30 INFO - mozversion == 1.4 15:02:30 INFO - psutil == 3.1.1 15:02:30 INFO - requests == 1.2.3 15:02:30 INFO - wsgiref == 0.1.2 15:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02: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')]} 15:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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')]} 15:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:30 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 0x7f25a0599f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', '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 15:02:30 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 15:02:30 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 15:02:30 INFO - Using env: {'DISPLAY': ':0', 15:02:30 INFO - 'HOME': '/home/cltbld', 15:02:30 INFO - 'LANG': 'en_US.UTF-8', 15:02:30 INFO - 'LANGUAGE': 'en_US:en', 15:02:30 INFO - 'LOGNAME': 'cltbld', 15:02:30 INFO - 'MAIL': '/var/mail/cltbld', 15:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:30 INFO - 'MOZ_NO_REMOTE': '1', 15:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:30 INFO - 'NO_EM_RESTART': '1', 15:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:30 INFO - 'PWD': '/builds/slave/test', 15:02:30 INFO - 'SHELL': '/bin/bash', 15:02:30 INFO - 'SHLVL': '1', 15:02:30 INFO - 'TERM': 'linux', 15:02:30 INFO - 'TMOUT': '86400', 15:02:30 INFO - 'USER': 'cltbld', 15:02:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:30 INFO - '_': '/tools/buildbot/bin/python'} 15:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:30 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)) 15:02:30 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)) 15:02:30 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)) 15:02:30 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)) 15:02:30 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)) 15:02:30 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)) 15:02:30 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)) 15:02:30 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)) 15:02:30 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)) 15:02:30 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)) 15:02:30 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)) 15:02:30 INFO - Cleaning up... 15:02:30 INFO - Return code: 0 15:02:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:02: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')]} 15:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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')]} 15:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25a0599f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', '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 15:02: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', 'jsonschema'] in /builds/slave/test/build 15:02: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 jsonschema 15:02:30 INFO - Using env: {'DISPLAY': ':0', 15:02:30 INFO - 'HOME': '/home/cltbld', 15:02:30 INFO - 'LANG': 'en_US.UTF-8', 15:02:30 INFO - 'LANGUAGE': 'en_US:en', 15:02:30 INFO - 'LOGNAME': 'cltbld', 15:02:30 INFO - 'MAIL': '/var/mail/cltbld', 15:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:30 INFO - 'MOZ_NO_REMOTE': '1', 15:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:30 INFO - 'NO_EM_RESTART': '1', 15:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:30 INFO - 'PWD': '/builds/slave/test', 15:02:30 INFO - 'SHELL': '/bin/bash', 15:02:30 INFO - 'SHLVL': '1', 15:02:30 INFO - 'TERM': 'linux', 15:02:30 INFO - 'TMOUT': '86400', 15:02:30 INFO - 'USER': 'cltbld', 15:02:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:30 INFO - '_': '/tools/buildbot/bin/python'} 15:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:30 INFO - Downloading/unpacking jsonschema 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:02:32 INFO - Downloading/unpacking functools32 (from jsonschema) 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02:32 INFO - Downloading functools32-3.2.3-2.tar.gz 15:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:02:32 INFO - warning: no files found matching '*.txt' 15:02:32 INFO - no previously-included directories found matching 'build' 15:02:32 INFO - no previously-included directories found matching 'dist' 15:02:32 INFO - no previously-included directories found matching '.git*' 15:02:32 INFO - Installing collected packages: jsonschema, functools32 15:02:32 INFO - Running setup.py install for functools32 15:02:32 INFO - warning: no files found matching '*.txt' 15:02:32 INFO - no previously-included directories found matching 'build' 15:02:32 INFO - no previously-included directories found matching 'dist' 15:02:32 INFO - no previously-included directories found matching '.git*' 15:02:32 INFO - Successfully installed jsonschema functools32 15:02:32 INFO - Cleaning up... 15:02:32 INFO - Return code: 0 15:02:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:32 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 0x7f25a0599f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', '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 15:02:32 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 15:02:32 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 15:02:32 INFO - Using env: {'DISPLAY': ':0', 15:02:32 INFO - 'HOME': '/home/cltbld', 15:02:32 INFO - 'LANG': 'en_US.UTF-8', 15:02:32 INFO - 'LANGUAGE': 'en_US:en', 15:02:32 INFO - 'LOGNAME': 'cltbld', 15:02:32 INFO - 'MAIL': '/var/mail/cltbld', 15:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:32 INFO - 'MOZ_NO_REMOTE': '1', 15:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:32 INFO - 'NO_EM_RESTART': '1', 15:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:32 INFO - 'PWD': '/builds/slave/test', 15:02:32 INFO - 'SHELL': '/bin/bash', 15:02:32 INFO - 'SHLVL': '1', 15:02:32 INFO - 'TERM': 'linux', 15:02:32 INFO - 'TMOUT': '86400', 15:02:32 INFO - 'USER': 'cltbld', 15:02:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:32 INFO - '_': '/tools/buildbot/bin/python'} 15:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:33 INFO - Downloading/unpacking flake8 15:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:02:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:02:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:02:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:35 INFO - no previously-included directories found matching 'docs/_build' 15:02:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:02:35 INFO - Running setup.py install for pep8 15:02:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:35 INFO - no previously-included directories found matching 'docs/_build' 15:02:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:02:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:02:36 INFO - Cleaning up... 15:02:36 INFO - Return code: 0 15:02:36 INFO - Running post-action listener: _resource_record_post_action 15:02:36 INFO - Running post-action listener: _start_resource_monitoring 15:02:36 INFO - Starting resource monitoring. 15:02:36 INFO - ##### 15:02:36 INFO - ##### Running install step. 15:02:36 INFO - ##### 15:02:36 INFO - Running pre-action listener: _resource_record_pre_action 15:02:36 INFO - Running main action method: install 15:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:36 INFO - Reading from file tmpfile_stdout 15:02:36 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:36 INFO - Reading from file tmpfile_stdout 15:02:36 INFO - Output received: 15:02:36 INFO - Usage: mozinstall [options] installer 15:02:36 INFO - Options: 15:02:36 INFO - -h, --help show this help message and exit 15:02:36 INFO - -d DEST, --destination=DEST 15:02:36 INFO - Directory to install application into. [default: 15:02:36 INFO - "/builds/slave/test"] 15:02:36 INFO - --app=APP Application being installed. [default: firefox] 15:02:36 INFO - mkdir: /builds/slave/test/build/application 15:02:36 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'] 15:02:36 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 15:02:52 INFO - Reading from file tmpfile_stdout 15:02:52 INFO - Output received: 15:02:52 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:52 INFO - Running post-action listener: _resource_record_post_action 15:02:52 INFO - ##### 15:02:52 INFO - ##### Running run-tests step. 15:02:52 INFO - ##### 15:02:52 INFO - Running pre-action listener: _resource_record_pre_action 15:02:52 INFO - Running main action method: run_tests 15:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:52 INFO - Python 2.7.3 15:02:52 INFO - Return code: 0 15:02:52 INFO - grabbing minidump binary from tooltool 15:02:52 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')]} 15:02:52 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 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:52 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 15:02:52 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 15:02:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:52 INFO - Return code: 0 15:02:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:02:53 INFO - Return code: 0 15:02:53 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/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 15:02:53 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/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 15:02:53 INFO - Using env: {'DISPLAY': ':0', 15:02:53 INFO - 'HOME': '/home/cltbld', 15:02:53 INFO - 'LANG': 'en_US.UTF-8', 15:02:53 INFO - 'LANGUAGE': 'en_US:en', 15:02:53 INFO - 'LOGNAME': 'cltbld', 15:02:53 INFO - 'MAIL': '/var/mail/cltbld', 15:02:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:53 INFO - 'MOZ_NO_REMOTE': '1', 15:02:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:53 INFO - 'NO_EM_RESTART': '1', 15:02:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:53 INFO - 'PWD': '/builds/slave/test', 15:02:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:53 INFO - 'SHELL': '/bin/bash', 15:02:53 INFO - 'SHLVL': '1', 15:02:53 INFO - 'TERM': 'linux', 15:02:53 INFO - 'TMOUT': '86400', 15:02:53 INFO - 'USER': 'cltbld', 15:02:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869', 15:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:53 INFO - '_': '/tools/buildbot/bin/python'} 15:02:53 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/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 15:02:53 INFO - mozversion application_buildid: 20160505123841 15:02:53 INFO - mozversion application_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 15:02:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:02:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:53 INFO - mozversion application_name: Firefox 15:02:53 INFO - mozversion application_remotingname: firefox-dev 15:02:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:02:53 INFO - mozversion application_vendor: Mozilla 15:02:53 INFO - mozversion application_version: 48.0a2 15:02:53 INFO - mozversion platform_buildid: 20160505123841 15:02:53 INFO - mozversion platform_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 15:02:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:02:53 INFO - mozversion platform_version: 48.0a2 15:02:53 INFO - using testdate: 1462485773 15:02:53 INFO - actual date: 1462485773 15:02:53 INFO - starting webserver on 'localhost:45783' 15:02:53 INFO - SUITE-START | Running 2 tests 15:02:53 INFO - TEST-START | dromaeo_css 15:02:53 INFO - operating with platform_type : linux_ 15:02:53 INFO - Initialising browser for dromaeo_css test... 15:02:53 INFO - TEST-INFO | started process 23341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGYR4_3/profile http://localhost:45783/getInfo.html) 15:02:57 INFO - PROCESS | 23341 | __metrics Screen width/height:1600/1200 15:02:57 INFO - PROCESS | 23341 | colorDepth:24 15:02:57 INFO - PROCESS | 23341 | Browser inner width/height: 1024/697 15:02:57 INFO - PROCESS | 23341 | __metrics 15:02:58 ERROR - PROCESS | 23341 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:02:58 INFO - TEST-INFO | 23341: exit 0 15:02:58 INFO - Browser initialized. 15:02:58 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:58 INFO - TEST-INFO | started process 23430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGYR4_3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:03:10 INFO - PROCESS | 23430 | RSS: Main: 142348288 15:03:10 INFO - PROCESS | 23430 | 15:04:02 INFO - PROCESS | 23430 | 1462485842294 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] 15:06:09 INFO - PROCESS | 23430 | Cycle 1(1): loaded http://localhost:45783/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45783/tests/dromaeo/cssquery-ext.html) 15:06:10 INFO - PROCESS | 23430 | RSS: Main: 245100544 15:06:10 INFO - PROCESS | 23430 | 15:09:12 INFO - PROCESS | 23430 | Cycle 1(1): loaded http://localhost:45783/tests/dromaeo/cssquery-ext.html (next: http://localhost:45783/tests/dromaeo/cssquery-jquery.html) 15:09:13 INFO - PROCESS | 23430 | RSS: Main: 226983936 15:09:13 INFO - PROCESS | 23430 | 15:12:14 INFO - PROCESS | 23430 | Cycle 1(1): loaded http://localhost:45783/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45783/tests/dromaeo/cssquery-mootools.html) 15:12:15 INFO - PROCESS | 23430 | RSS: Main: 221458432 15:12:15 INFO - PROCESS | 23430 | 15:15:17 INFO - PROCESS | 23430 | Cycle 1(1): loaded http://localhost:45783/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45783/tests/dromaeo/cssquery-prototype.html) 15:15:17 INFO - PROCESS | 23430 | RSS: Main: 224759808 15:15:17 INFO - PROCESS | 23430 | 15:18:20 INFO - PROCESS | 23430 | Cycle 1(1): loaded http://localhost:45783/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45783/tests/dromaeo/cssquery-yui.html) 15:18:20 INFO - PROCESS | 23430 | RSS: Main: 215715840 15:18:20 INFO - PROCESS | 23430 | 15:21:23 INFO - PROCESS | 23430 | Cycle 1(1): loaded http://localhost:45783/tests/dromaeo/cssquery-yui.html (next: http://localhost:45783/tests/dromaeo/cssquery-dojo.html) 15:21:23 INFO - PROCESS | 23430 | RSS: Main: 246906880 15:21:23 INFO - PROCESS | 23430 | 15:21:23 INFO - PROCESS | 23430 | __start_tp_report 15:21:23 INFO - PROCESS | 23430 | _x_x_mozilla_page_load 15:21:23 INFO - PROCESS | 23430 | _x_x_mozilla_page_load_details 15:21:23 INFO - PROCESS | 23430 | |i|pagename|runs| 15:21:23 INFO - PROCESS | 23430 | |0;dojo.html;3298.1259966108983;3348.045806945021;3381.847816848243;3392.5420068290773;3422.8117453540053;5523.558115350772;5539.002979463695;5556.194351818994;5556.388797232306;5558.416366281543;5532.170174473831;5559.833205003846;5560.7219639017985;5564.777408903639;5571.275734154565;4896.804127834882;5027.0699920514735;5045.495450454961;5047.167217409123;5126.282320475137;5036.82371117011;5045.621578381618;5078.898422031557;5080.79676812927;5112.130937740593;5046.369203849519;5072.72100034498;5084;5084.415292241384;5085.923711144335;5078.390593128811;5082.161443361878;5085.618578606619;5095.184770436731;5113.207452844834;4924.285978533093;4961.851144465636;4982.800687972477;5011.6241281904;5014.52362025607;5385.111456609694;5396.352437707461;5398.406175320712;5399.83800485986;5450.482204190595;5810.535157187415;5829.883402331972;5843.912341314884;5850.912236316459;5858.707064646751;5828.154917536934;5841.678707671076;5873.970630146822;5925.940740592582;5969.8806023879715;5617.325920889438;5625.887482250373;5626.606137570372;5627.240322556484;5632.239647647556;6094.11635312886;6098.969505152446;6099.2985806632805;6118.785842495491;6120.510359171256;5711.171880077365;5724.398938111522;5810.070388737866;5846.883062338729;5848.4151584841175;5870.794522191788;5890.911636325459;5893.351731309553;5899.115132730125;5902.793402230901;5829.242198514166;5861.296644402699;5868.823935281948;5874.618149820333;5876.941230587725;5768.077107662753;5925.881482370414;5975;5982.40175982407;5990.820275391745;4486.865394038184;4486.990427153864;4487.955120448819;4493.505714371417;4516.322551617283;3954.6696367477566;4039.7980100994832;4044;4051.716379853441;4071.7964101795383;5601.439856014447;5698.230738850285;5718.628289161191;5718.714064296769;5754.9424505754405;5888.175655408247;5888.322842873039;5891.027980383275;5896.380880007623;5902.763889444374;5467.644603100785;5573;5584;5588.552915766729;5594.720263986785;5109.335786347825;5109.335786347825;5112.616553758483;5113.821016264487;5146.562542183956;6117.051856962178;6122.816315510542;6124.173236613089;6125.418085281891;6125.693715314216;5758.222639943721;5879.353271140086;5933.792317268875;5942.64344139353;5955.434233747787;6060.787872424444;6096.390360963868;6096.695165241809;6101.7559297627595;6121.540884433596;5741.885162296814;5782.624129431573;5790.478856902899;5792.797252096157;5798.94201057984;5711.828645140652;5844.3571207168025;5844.386339434468;5903.7048147593305;5957.957357462514;5769.394213607511;5775.1914731938405;5778.913316300343;5781.682007489629;5786.392428794916;5694.601377903673;5754.5684073695475;5758.078707406795;5765.913511297418;5768.394318596655;5521.723913804374;5672.064109422065;5734.684592347294;5735;5753.108268218432;5773;5775.826725198251;5788.27646544182;5789.073748200268;5793.623414478046;5510.614257001971;5636.098224284095;5671.517920976763;5672.03575392176;5673.5461163107675 15:21:23 INFO - PROCESS | 23430 | |1;ext.html;621.2389822467478;659.4098282037577;678.0676569716641;683.4737252315714;688.352948228665;34362.14094647632;34940.95177144687;34997.999999999935;35007.824960875194;40402.797986010104;43205;43761.56238437615;43876.780616096956;43885.12229755403;44060;8613.138686131399;8864.556772161399;8868.733937981871;8871.600777965006;8878.822423551524;8883.289336853068;9061.773455663595;9074.319426043041;9074.546272686372;9082.091790820898;9050.411723237969;9191.678291259806;9202.217811486033;9204.769880752969;9215;9071.047540008303;9102;9162.770930726718;9172.541372931326;9178.219851312646;8935.32985026119;8991.685291014848;9019.774505637346;9042.502662353569;9051.366404351698;43781;44262;44330;44344.334834977504;44388.77805610983;3868.516435445569;3968.464257325253;3980.24375368679;4240.406343111967;4645.883852903705;32419.351612967843;32445.188870278194;32886.177845553815;32909.50635740466;33907.830460847785;4597.655175861823;4635.95364046362;4655;4666.859994200146;4701.106789709978;240824;242422;242685;243105;243168;36630.8168459156;67557.98663020058;68691;68762.3123768766;68797.31202688008;38251;38402.2319553613;38415.23169536594;38455.423168652494;38491;16733.74899376486;16977.575560611083;16990.490285291213;16995.74506382405;17032.57418564546;14166.291685415688;14190.929045354707;14221.28893555318;14239.644008899653;14239.64400889986;9395.436273823592;9444.480553569481;9457.148856602938;9462.384944978554;9505.144536991565;3569.9659384894903;3635.94546081809;3646.2889736501656;3672.1737609038287;3688.0779805048737;1170.0814860334597;1198.7422704118483;1207.4626791078063;1230.9384530773425;1257.830192923962;35500.46749298763;35606.46590301148;35755.463668045;35848.462273065925;35999.28001439956;1217.792975194219;1218.5734992752643;1245.9252444853337;1340.1423089222906;1368.7270838120644;18257.269709211483;18637.534061648297;18697;18741.34405295808;18762.906185468986;525491;531988;532453;532935;533111;64669;65475.672621636586;65657;65673.67163164154;65719;1467.5377256164275;1508.6605513759537;1509.9698006039819;1520.2018940056337;1595.6649103688123;30878.691213087583;32865.50701739523;33588.1602959928;33617.83191084127;35192.824035879654;48847.5115248843;49020;49180.26229606487;49425;49499;300624;301853;302286;302419;333959;28540;28904.421911562073;28928.42143157083;29109;29343.266418339714;44463;45073;45593.54406455893;46668.7666561665;46831.76584117058;41183.58816411797;41441.1711765769;42044.78977605092;42715.35926961036;43361.566384335754;42368;42394.364084539375;42849.571504284555;43558.78220608877;43617.56382436135;41358;42172.156556868074;42515;42748.358774619024;42950.140997180504;35602.8219858899;37128;37290.440643389826;37559.61272201302;37732.811335943145;28072.157835264974;28290.85854570714;28606;28629;28784.136475905758 15:21:23 INFO - PROCESS | 23430 | |2;jquery.html;425.8892687901145;426.95516970718086;434.6090735731075;441.6224128370244;442.7432089388153;18310.26758929643;18909.527261818443;19150.90424547879;19174.712379314322;19204.615907681837;18468.538286542844;18843.152058157382;20029.399118026482;21005.579888402262;21051.2632057878;5796.739146738396;5906.704664766766;5916.556258280646;5927.110933360009;5936.643801371932;4282.400463935051;4371.759553224571;5771.249737534135;5803.158542011406;6465.709043093048;6459.257185423666;6486.189226346707;6492.805215843532;6494.772682956098;6498.935010649904;6392.3288054754275;6423.164988551505;6444.0656104865;6460.127882735841;6461.57999730016;3957.960420395788;5568.136938774496;5688.715564221772;5864.5894787364905;5873.2658417697785;23044.308670739905;23762.88118559396;23894;24011.27966161018;24021.39946501334;2599.7920166386643;2622.3229832768757;2639.762421382085;2711.6339294195427;2770.3351195713085;14609.853901460956;14783.852161478355;14796.260186990607;14878.553643390716;14912.925435372863;1878.953026174343;1909.8185672361103;1916.425072478251;1919.481739930211;1971.1819594868114;54023.72988135074;56988.715056424866;82041;85484;86032;11395.601153959571;11497.770044599229;11691.123165762601;11746.29522228669;11855.644330670093;16662.83337166637;16678;16802.32790688383;16829.831701682826;16831.91584042072;8353.33173346143;8493.193146651058;8558.743237702878;8677.739667809976;8780.429272097294;8109.5134291941495;8154.836903261901;8185.427020108655;8200.712975045844;8307.916920830836;4931.852044438672;4943.90112197754;5007.9499205008215;5030;5077.492250774893;1849.842763365129;1962.3720409469117;2026.2806703620297;2092.309537852505;2097.108728790258;476.5187160967448;487.8365747474565;985.7190700650424;1057.5558265528496;1079.9892001080045;12180.57367992116;12359.814602780785;12453.688657783447;12510.49958001688;12549.623511294676;495.1038620097635;502.0511233768181;507.4219178355312;516.2385481414883;529.7669025628788;6558;6678.298778628271;6771.627560484122;6788.422984046411;6879.862402751917;527695;531495;534915;534991;536726;93884;94510.52744736233;99041;103130;103770;1156.2831044752306;1165.4347641393917;1196.2284326609288;1230.864604893461;1232.8952039076778;14620.926895365455;17763.200655970253;18169.818301816813;18527.258909643464;18763.249470021045;41029;43464.34803477887;43647.56352436435;44295;44301.55698442974;53132.20301695555;56155.71922140363;56642;57779;58021.70989145027;8823.117688231125;8874.866876996979;9055.18503334703;9184.54077296119;9387.624495020124;12994.090413670952;13039.348032598142;13744.312784360942;14061.226632535308;14135.717285654435;11500.597479088192;11946.820797687868;12429.689257768629;12529.749405012031;12597.055220858289;11972.820407694066;12025.398730063636;12316.630501084981;12739.235645861278;12793.872061279268;12830.87169128334;12878.806817897552;12914.612561623166;13127.671808204872;13179.67050823737;9108.453492790453;9237.676681316121;9350.25197984146;9504.85742713846;9545.140937315675;9693.27300452483;12524.998000159783;12783.488660453479;12856.935715321364;13254.602361929157 15:21:23 INFO - PROCESS | 23430 | |3;mootools.html;1404.9859501404983;1571.2222449887308;1614.0880402572545;1781.9643607127857;1941.3593514140334;8211.219934106257;8655.740327790169;8690.56547172642;8696.565171741404;8700.521471319074;8438.789030274245;8627.568621568927;8647.092055334193;8648.13518648135;8656.91343086569;2115.481706981792;2338.029717667166;2374.1215750172373;2378.5718570657273;2447.0945750072497;2357.2221167014845;2367.9644805327935;2369.230000249917;2369.5616310982523;2369.668246445499;2299.195281651417;2354.6703461515403;2366.6331718583647;2368.86971216583;2369.680093187415;2108.5888251790907;2297.827662925279;2371;2376.263358358914;2377.4175327044986;2269.988650056739;2275.9089636414524;2279.5213005268915;2281.0419623757894;2315.5368926214655;8557.187067228604;8564.657413703444;8575.656973721043;8579.313654907592;8585.35609829259;5297.867553311159;5467.589930755209;5472.097103977839;5472.835814925519;5591.0495215813;3231.5960504936884;3356.882509112194;3361.764676472648;3413.9317213655836;3437.673421024999;1048.7849990751954;1062.755566219766;1063.4257500949554;1064.4518073192312;1093.9343639381582;12075.215111017756;12163.878361216452;12167.634970950885;12183.878161218452;12188.085893558018;4619.884502887455;4681.625469962463;4746.311784791255;4777.020710754287;4782.593479554207;9660.37207581505;9671.70984870455;9684.789401324835;9696.95151524238;9701.805963880824;4801.51984801524;5469.343678758495;5470.8085217017215;5499.945000550023;5507.366652834975;4884.340614017134;4955.752212389366;4969.925451118236;4986.950130498649;4994.950050499521;3908.2769687607883;3946.329124048861;4005.0588111793704;4037.1320166164414;4063.8577649782706;1132.2583707671488;1239.5165885304739;1242.8943539799038;1248.36333469931;1259.3766085787595;943.9480828554358;999.3703966501204;1017.3692310767372;1024.4928760263567;1040.843873418993;5761.164631128463;5975.25309336333;5981.235535517033;6113.8471538211015;6146.446819786241;443.15799980038184;444.62651372846966;447.42729306487746;461.53846153846155;467.87367410798896;3935.6457918787446;4075.89810254746;4078.408630748525;4097.242010228118;4160.45914031174;10606.840897386546;11095.55617775296;11233.494492747683;11257.099432045417;11280.097592192606;10940.890591094147;10943.124550035978;11000.22998390105;11066.059384952208;11089.445527723581;7623.35201507867;7931.167227441036;8021;8026.675598526294;8037.678492860337;5681.914771278517;6032.969835150796;6063.242094738158;6077.908831367445;6161.383861613803;9547.904520954979;9702.563384647567;9922.503874806087;9924.503774811086;9939.353941993748;9707.029297070236;9910.504474776377;10056.748581285527;10197.796044079225;10640.201984851323;7227.7108915644885;7779.494332868346;7989.840203195788;8016.358691304798;8194.67221311141;8590.355723320901;8636;8640.395172338127;8673.392862499817;8688.956555217184;7536.1333446654335;7637.465377423527;7719.961400193188;7920.841583168189;8010.198980101944;7599.924000759922;7630.465867389452;7668.961655191688;7698.422618303762;7899;7011.368976792113;7177;7224.638768061681;7240.52936559122;7253.238409966877;5187.29971453864;5208.947910520847;5289.550388217045;5328.680279183106;5358.544523715528;5031.84904452867;5164.715940623302;5264.657797243321;5341.732913354394;5368.812091576776 15:21:23 INFO - PROCESS | 23430 | |4;prototype.html;348.7175387935772;354.1500399042298;356.01561681949397;357.95883473400534;363.41490200776747;5484.957858006986;5507.57666626684;5513.283273174487;5534.667919924807;5551.195076713874;5414.4044155143;5418.91871621926;5425.83722488325;5446.685158807511;5463.508284254416;4024.8591299304458;4094.529129150141;4120.484939382577;4264.530901600821;4273.316269396897;4257.467816522934;4268.765217913014;4287.228298906196;4308.43990281263;4311.504177019636;4047.150098479323;4259.957400426003;4268.271350103213;4271.081717430752;4292.549282325358;3939.72421930465;4160.43834082398;4263;4300.376445415429;4300.6989510734265;3794.4687743715904;3797.5442946846556;3811.790351530665;3826.349520581508;3831.3103641344546;5225.242339860737;5227.2159176123505;5232.450592687751;5243.134882744343;5251.474852514756;4558.475775285851;4833.806647734086;4837.419509658828;4854.320395144682;4854.83008094715;5622.437756224344;5626.549876009909;5656.8020119295625;5675.262215911946;5678.886422271573;4108.137291168858;4112.773797441139;4113.71204015719;4117.526484454266;4118.032262418329;5610.663360198401;5912.17229587858;5935.614185077956;5958.40415958405;5960.433758792951;4115.650169735606;4163.687723420695;4164.167166566699;4172.395002724588;4189.476315460567;4227.837344730224;4248.107897341592;4250.872473825791;4257.489101307863;4259.893502662396;4720.858374248709;4829.9034019319415;4858.878528036827;4868.342773725572;4896.975515122402;5692.544596432275;5707.3721890592005;5714.200011998323;5718.342390625048;5736.110902810071;1541.3988544467666;1549.1944189021647;1552.8136623605014;1554.1452201289246;1554.4015554011787;963.6386355116831;975.2734213011352;999.9251553027497;1041.9895801042044;1043.7077618266896;5779.248697669276;5866.735996880066;5885.411458854081;5900.527957763368;5904.350521442638;6170.228721409824;6211.3167551569295;6215.098810672427;6226.750929962841;6262.34245404226;5732.226149469769;5869.970650146807;5876.382979787061;5880.676562789087;5896.115582662635;3248.512723091555;3278;3283.6223834259367;3312.7349812015464;3319.535265062893;6268.905966410507;6357.459615932605;6364.363563643691;6411.429199845974;6429.196350456193;6241.656708880964;6255.74977000924;6264.874702505925;6264.968675156595;6295.842603934847;6270.999999999909;6372.235331760218;6385.648789316632;6415.230172379344;6422.518311126684;6130.272028947075;6143.232095988002;6153.154053783757;6187.535934804818;6194.628322300677;6081.5134789217645;6111.449969502766;6119.816405507842;6127.3566275540425;6149;6223.408776166257;6347.428731414195;6390.744370225325;6397.104405383157;6412.679366031586;4375.081232941118;4380.7152535085115;4385.758783266951;4388.802503887397;4394.428724265953;5670.376258611467;6206.596571222856;6226.719797609027;6236.472064344264;6240.251169859464;5745.540356771365;5780.046292361882;5789.034511359732;5791;5813.738381772746;5712.82887008154;5737.647564498536;5742.885142297047;5791.913121303268;5794.913076303775;5589.357223919302;5666.17840413146;5679.545636348999;5685.800996965087;5724.198612194213;5772.1341798728845;5783.096409923369;5791.233673729553;5816.127580862904;5823.854403639943;5494.752736126964;5684.886302274014;5689.374168841341;5698.230738850202;5700.743466543932 15:21:23 INFO - PROCESS | 23430 | |5;yui.html;896.1128482802027;918.9816203675927;924.1590152960807;927.8097989912073;943.9103285187905;14707.926460367697;14781.482648107318;14884.404623815035;15881.285342159601;16672.58318542037;15582.142982135978;15656.138912359816;15697.84302156978;15721.213939303047;15729.528114156565;767.4436033875452;890.7773056735816;923.685946778097;924.4268553496807;925.0980294213156;934.7476181431009;934.9579268932914;935.6771913689767;935.9953200233989;936.1901954809109;967.5065716484609;968.099667309402;968.4963818814213;968.8013957138805;969.3989726369625;807.6204184033495;934.1825902335456;964.3635200767495;970.7136394763562;973.0415540692412;713.3401603516726;713.4435140590348;713.8001359619315;714.0610097721532;714.417749534128;14963.251837408086;15024.17367044812;15064.548063558;15065.171415572138;15065.548033559011;14032.298385080807;14648.560543183721;14659.853401465956;14662;14719.55841324762;11158.776824463464;11660.53208544133;11864.762704745857;11873.228240164362;11986.486216340494;4642.117997580449;4735.414922040109;4799.880002999918;4808.903821923577;4813.590844778198;58130.41869581334;59062.99999999957;59575.70212148955;59579.702101489645;60448.69775651138;11827.172097953233;11939.582114625946;11943.104267179997;12090.57682981109;12135.635930922086;20407.081681324376;20472.69290960637;20474.590508189754;20549.794502055087;20593.279235226695;8748.69379571712;8953.731388058368;8996.640134394682;9135.40619859707;9246.306527010502;4955.108080545464;4982.77577509013;5002.57478114357;5039.949600503948;5082.2122571001555;3519.4192958161616;3629.346717590859;3634.273145370936;3635.909102272464;3640.581333146669;648.9610623362613;652.742166844094;657.6481582353514;658.0524045374646;679.4869873245767;653.1867824558456;757.5909009135115;761.6001599160485;764.3273918951287;782.6047845837816;9018.413803102909;9274.211692006254;9418.735722764897;9478.526073696288;9553.570089345996;647.1231481342807;743.5129989856653;785.8899754034439;789.5302295134501;794.7456813819638;4359.716618419792;4405.273129933589;4412.4705035395955;4433.202023635777;4436.423264975532;64688;65262;65835;65999.34000659932;66172.669136654;59258.703706482054;59862;59955;60161.699191503765;61319.08021379683;51666.741666291426;51998.74000630048;52042.739786300066;53803.46196538063;55466;8672.82654346897;8730.388872778845;8736.344774141837;8779.604917778588;8831.646734130563;36400.08999774921;36625.63374366222;36721.63278367182;36760;36911.96984165897;43771.56228437675;46435.53564464447;48270.75864620795;48849.267260990404;49870.75064624654;11803.527858885893;12222.388880556115;12344.62966111018;12405.813912791134;12485.500579976699;13177.472901084233;13297;13400.597982060553;13433.395497202844;13440.46238150463;12041.45813438415;12093.57672481459;12146.574869879512;12232.266064036186;12380.380980951097;12465.93767031159;12573.308468034345;12592.433340499883;12595.181313214978;13043.086983911035;12179.147459677737;12191;12241.632751017483;12399.938000309941;12536.686582835502;9154.633814647339;9206.723798286062;9286.489243091695;9340.486273255035;9545.188658964065;10314.845277320996;10682.73293167677;10703.357798532114;10833.51249193804;10896.237263391486 15:21:23 INFO - PROCESS | 23430 | __end_tp_report 15:21:23 INFO - PROCESS | 23430 | __start_cc_report 15:21:23 INFO - PROCESS | 23430 | _x_x_mozilla_cycle_collect,807 15:21:23 INFO - PROCESS | 23430 | __end_cc_report 15:21:23 INFO - PROCESS | 23430 | __startTimestamp1462486883372__endTimestamp 15:21:23 INFO - PROCESS | 23430 | 15:21:23 INFO - PROCESS | 23430 | ------- Summary: start ------- 15:21:23 INFO - PROCESS | 23430 | Number of tests: 6 15:21:23 INFO - PROCESS | 23430 | 15:21:23 INFO - PROCESS | 23430 | [#0] dojo.html Cycles:165 Average:5491.62 Median:5718.63 stddev:597.70 (10.5%) stddev-sans-first:574.23 15:21:23 INFO - PROCESS | 23430 | Values: 3298.1 3348.0 3381.8 3392.5 3422.8 5523.6 5539.0 5556.2 5556.4 5558.4 5532.2 5559.8 5560.7 5564.8 5571.3 4896.8 5027.1 5045.5 5047.2 5126.3 5036.8 5045.6 5078.9 5080.8 5112.1 5046.4 5072.7 5084.0 5084.4 5085.9 5078.4 5082.2 5085.6 5095.2 5113.2 4924.3 4961.9 4982.8 5011.6 5014.5 5385.1 5396.4 5398.4 5399.8 5450.5 5810.5 5829.9 5843.9 5850.9 5858.7 5828.2 5841.7 5874.0 5925.9 5969.9 5617.3 5625.9 5626.6 5627.2 5632.2 6094.1 6099.0 6099.3 6118.8 6120.5 5711.2 5724.4 5810.1 5846.9 5848.4 5870.8 5890.9 5893.4 5899.1 5902.8 5829.2 5861.3 5868.8 5874.6 5876.9 5768.1 5925.9 5975.0 5982.4 5990.8 4486.9 4487.0 4488.0 4493.5 4516.3 3954.7 4039.8 4044.0 4051.7 4071.8 5601.4 5698.2 5718.6 5718.7 5754.9 5888.2 5888.3 5891.0 5896.4 5902.8 5467.6 5573.0 5584.0 5588.6 5594.7 5109.3 5109.3 5112.6 5113.8 5146.6 6117.1 6122.8 6124.2 6125.4 6125.7 5758.2 5879.4 5933.8 5942.6 5955.4 6060.8 6096.4 6096.7 6101.8 6121.5 5741.9 5782.6 5790.5 5792.8 5798.9 5711.8 5844.4 5844.4 5903.7 5958.0 5769.4 5775.2 5778.9 5781.7 5786.4 5694.6 5754.6 5758.1 5765.9 5768.4 5521.7 5672.1 5734.7 5735.0 5753.1 5773.0 5775.8 5788.3 5789.1 5793.6 5510.6 5636.1 5671.5 5672.0 5673.5 15:21:23 INFO - PROCESS | 23430 | 15:21:23 INFO - PROCESS | 23430 | [#1] ext.html Cycles:180 Average:53110.97 Median:41399.59 stddev:101294.81 (244.7%) stddev-sans-first:101502.31 15:21:23 INFO - PROCESS | 23430 | Values: 621.2 659.4 678.1 683.5 688.4 34362.1 34941.0 34998.0 35007.8 40402.8 43205.0 43761.6 43876.8 43885.1 44060.0 8613.1 8864.6 8868.7 8871.6 8878.8 8883.3 9061.8 9074.3 9074.5 9082.1 9050.4 9191.7 9202.2 9204.8 9215.0 9071.0 9102.0 9162.8 9172.5 9178.2 8935.3 8991.7 9019.8 9042.5 9051.4 43781.0 44262.0 44330.0 44344.3 44388.8 3868.5 3968.5 3980.2 4240.4 4645.9 32419.4 32445.2 32886.2 32909.5 33907.8 4597.7 4636.0 4655.0 4666.9 4701.1 240824.0 242422.0 242685.0 243105.0 243168.0 36630.8 67558.0 68691.0 68762.3 68797.3 38251.0 38402.2 38415.2 38455.4 38491.0 16733.7 16977.6 16990.5 16995.7 17032.6 14166.3 14190.9 14221.3 14239.6 14239.6 9395.4 9444.5 9457.1 9462.4 9505.1 3570.0 3635.9 3646.3 3672.2 3688.1 1170.1 1198.7 1207.5 1230.9 1257.8 35500.5 35606.5 35755.5 35848.5 35999.3 1217.8 1218.6 1245.9 1340.1 1368.7 18257.3 18637.5 18697.0 18741.3 18762.9 525491.0 531988.0 532453.0 532935.0 533111.0 64669.0 65475.7 65657.0 65673.7 65719.0 1467.5 1508.7 1510.0 1520.2 1595.7 30878.7 32865.5 33588.2 33617.8 35192.8 48847.5 49020.0 49180.3 49425.0 49499.0 300624.0 301853.0 302286.0 302419.0 333959.0 28540.0 28904.4 28928.4 29109.0 29343.3 44463.0 45073.0 45593.5 46668.8 46831.8 41183.6 41441.2 42044.8 42715.4 43361.6 42368.0 42394.4 42849.6 43558.8 43617.6 41358.0 42172.2 42515.0 42748.4 42950.1 35602.8 37128.0 37290.4 37559.6 37732.8 28072.2 28290.9 28606.0 28629.0 28784.1 15:21:23 INFO - PROCESS | 23430 | 15:21:23 INFO - PROCESS | 23430 | [#2] jquery.html Cycles:180 Average:30271.58 Median:426.42 stddev:87717.64 (20570.6%) stddev-sans-first:87935.09 15:21:23 INFO - PROCESS | 23430 | Values: 425.9 427.0 434.6 441.6 442.7 18310.3 18909.5 19150.9 19174.7 19204.6 18468.5 18843.2 20029.4 21005.6 21051.3 5796.7 5906.7 5916.6 5927.1 5936.6 4282.4 4371.8 5771.2 5803.2 6465.7 6459.3 6486.2 6492.8 6494.8 6498.9 6392.3 6423.2 6444.1 6460.1 6461.6 3958.0 5568.1 5688.7 5864.6 5873.3 23044.3 23762.9 23894.0 24011.3 24021.4 2599.8 2622.3 2639.8 2711.6 2770.3 14609.9 14783.9 14796.3 14878.6 14912.9 1879.0 1909.8 1916.4 1919.5 1971.2 54023.7 56988.7 82041.0 85484.0 86032.0 11395.6 11497.8 11691.1 11746.3 11855.6 16662.8 16678.0 16802.3 16829.8 16831.9 8353.3 8493.2 8558.7 8677.7 8780.4 8109.5 8154.8 8185.4 8200.7 8307.9 4931.9 4943.9 5007.9 5030.0 5077.5 1849.8 1962.4 2026.3 2092.3 2097.1 476.5 487.8 985.7 1057.6 1080.0 12180.6 12359.8 12453.7 12510.5 12549.6 495.1 502.1 507.4 516.2 529.8 6558.0 6678.3 6771.6 6788.4 6879.9 527695.0 531495.0 534915.0 534991.0 536726.0 93884.0 94510.5 99041.0 103130.0 103770.0 1156.3 1165.4 1196.2 1230.9 1232.9 14620.9 17763.2 18169.8 18527.3 18763.2 41029.0 43464.3 43647.6 44295.0 44301.6 53132.2 56155.7 56642.0 57779.0 58021.7 8823.1 8874.9 9055.2 9184.5 9387.6 12994.1 13039.3 13744.3 14061.2 14135.7 11500.6 11946.8 12429.7 12529.7 12597.1 11972.8 12025.4 12316.6 12739.2 12793.9 12830.9 12878.8 12914.6 13127.7 13179.7 9108.5 9237.7 9350.3 9504.9 9545.1 9693.3 12525.0 12783.5 12856.9 13254.6 15:21:23 INFO - PROCESS | 23430 | 15:21:23 INFO - PROCESS | 23430 | [#3] mootools.html Cycles:180 Average:5781.98 Median:4990.95 stddev:3269.75 (65.5%) stddev-sans-first:3262.38 15:21:23 INFO - PROCESS | 23430 | Values: 1405.0 1571.2 1614.1 1782.0 1941.4 8211.2 8655.7 8690.6 8696.6 8700.5 8438.8 8627.6 8647.1 8648.1 8656.9 2115.5 2338.0 2374.1 2378.6 2447.1 2357.2 2368.0 2369.2 2369.6 2369.7 2299.2 2354.7 2366.6 2368.9 2369.7 2108.6 2297.8 2371.0 2376.3 2377.4 2270.0 2275.9 2279.5 2281.0 2315.5 8557.2 8564.7 8575.7 8579.3 8585.4 5297.9 5467.6 5472.1 5472.8 5591.0 3231.6 3356.9 3361.8 3413.9 3437.7 1048.8 1062.8 1063.4 1064.5 1093.9 12075.2 12163.9 12167.6 12183.9 12188.1 4619.9 4681.6 4746.3 4777.0 4782.6 9660.4 9671.7 9684.8 9697.0 9701.8 4801.5 5469.3 5470.8 5499.9 5507.4 4884.3 4955.8 4969.9 4987.0 4995.0 3908.3 3946.3 4005.1 4037.1 4063.9 1132.3 1239.5 1242.9 1248.4 1259.4 943.9 999.4 1017.4 1024.5 1040.8 5761.2 5975.3 5981.2 6113.8 6146.4 443.2 444.6 447.4 461.5 467.9 3935.6 4075.9 4078.4 4097.2 4160.5 10606.8 11095.6 11233.5 11257.1 11280.1 10940.9 10943.1 11000.2 11066.1 11089.4 7623.4 7931.2 8021.0 8026.7 8037.7 5681.9 6033.0 6063.2 6077.9 6161.4 9547.9 9702.6 9922.5 9924.5 9939.4 9707.0 9910.5 10056.7 10197.8 10640.2 7227.7 7779.5 7989.8 8016.4 8194.7 8590.4 8636.0 8640.4 8673.4 8689.0 7536.1 7637.5 7720.0 7920.8 8010.2 7599.9 7630.5 7669.0 7698.4 7899.0 7011.4 7177.0 7224.6 7240.5 7253.2 5187.3 5208.9 5289.6 5328.7 5358.5 5031.8 5164.7 5264.7 5341.7 5368.8 15:21:23 INFO - PROCESS | 23430 | 15:21:23 INFO - PROCESS | 23430 | [#4] prototype.html Cycles:180 Average:4921.82 Median:5624.49 stddev:1472.03 (26.2%) stddev-sans-first:1435.58 15:21:23 INFO - PROCESS | 23430 | Values: 348.7 354.2 356.0 358.0 363.4 5485.0 5507.6 5513.3 5534.7 5551.2 5414.4 5418.9 5425.8 5446.7 5463.5 4024.9 4094.5 4120.5 4264.5 4273.3 4257.5 4268.8 4287.2 4308.4 4311.5 4047.2 4260.0 4268.3 4271.1 4292.5 3939.7 4160.4 4263.0 4300.4 4300.7 3794.5 3797.5 3811.8 3826.3 3831.3 5225.2 5227.2 5232.5 5243.1 5251.5 4558.5 4833.8 4837.4 4854.3 4854.8 5622.4 5626.5 5656.8 5675.3 5678.9 4108.1 4112.8 4113.7 4117.5 4118.0 5610.7 5912.2 5935.6 5958.4 5960.4 4115.7 4163.7 4164.2 4172.4 4189.5 4227.8 4248.1 4250.9 4257.5 4259.9 4720.9 4829.9 4858.9 4868.3 4897.0 5692.5 5707.4 5714.2 5718.3 5736.1 1541.4 1549.2 1552.8 1554.1 1554.4 963.6 975.3 999.9 1042.0 1043.7 5779.2 5866.7 5885.4 5900.5 5904.4 6170.2 6211.3 6215.1 6226.8 6262.3 5732.2 5870.0 5876.4 5880.7 5896.1 3248.5 3278.0 3283.6 3312.7 3319.5 6268.9 6357.5 6364.4 6411.4 6429.2 6241.7 6255.7 6264.9 6265.0 6295.8 6271.0 6372.2 6385.6 6415.2 6422.5 6130.3 6143.2 6153.2 6187.5 6194.6 6081.5 6111.4 6119.8 6127.4 6149.0 6223.4 6347.4 6390.7 6397.1 6412.7 4375.1 4380.7 4385.8 4388.8 4394.4 5670.4 6206.6 6226.7 6236.5 6240.3 5745.5 5780.0 5789.0 5791.0 5813.7 5712.8 5737.6 5742.9 5791.9 5794.9 5589.4 5666.2 5679.5 5685.8 5724.2 5772.1 5783.1 5791.2 5816.1 5823.9 5494.8 5684.9 5689.4 5698.2 5700.7 15:21:23 INFO - PROCESS | 23430 | 15:21:23 INFO - PROCESS | 23430 | [#5] yui.html Cycles:180 Average:15616.07 Median:27426.76 stddev:18320.67 (66.8%) stddev-sans-first:18338.72 15:21:23 INFO - PROCESS | 23430 | Values: 896.1 919.0 924.2 927.8 943.9 14707.9 14781.5 14884.4 15881.3 16672.6 15582.1 15656.1 15697.8 15721.2 15729.5 767.4 890.8 923.7 924.4 925.1 934.7 935.0 935.7 936.0 936.2 967.5 968.1 968.5 968.8 969.4 807.6 934.2 964.4 970.7 973.0 713.3 713.4 713.8 714.1 714.4 14963.3 15024.2 15064.5 15065.2 15065.5 14032.3 14648.6 14659.9 14662.0 14719.6 11158.8 11660.5 11864.8 11873.2 11986.5 4642.1 4735.4 4799.9 4808.9 4813.6 58130.4 59063.0 59575.7 59579.7 60448.7 11827.2 11939.6 11943.1 12090.6 12135.6 20407.1 20472.7 20474.6 20549.8 20593.3 8748.7 8953.7 8996.6 9135.4 9246.3 4955.1 4982.8 5002.6 5039.9 5082.2 3519.4 3629.3 3634.3 3635.9 3640.6 649.0 652.7 657.6 658.1 679.5 653.2 757.6 761.6 764.3 782.6 9018.4 9274.2 9418.7 9478.5 9553.6 647.1 743.5 785.9 789.5 794.7 4359.7 4405.3 4412.5 4433.2 4436.4 64688.0 65262.0 65835.0 65999.3 66172.7 59258.7 59862.0 59955.0 60161.7 61319.1 51666.7 51998.7 52042.7 53803.5 55466.0 8672.8 8730.4 8736.3 8779.6 8831.6 36400.1 36625.6 36721.6 36760.0 36912.0 43771.6 46435.5 48270.8 48849.3 49870.8 11803.5 12222.4 12344.6 12405.8 12485.5 13177.5 13297.0 13400.6 13433.4 13440.5 12041.5 12093.6 12146.6 12232.3 12380.4 12465.9 12573.3 12592.4 12595.2 13043.1 12179.1 12191.0 12241.6 12399.9 12536.7 9154.6 9206.7 9286.5 9340.5 9545.2 10314.8 10682.7 10703.4 10833.5 10896.2 15:21:23 INFO - PROCESS | 23430 | -------- Summary: end -------- 15:21:23 INFO - PROCESS | 23430 | 15:21:23 INFO - TEST-INFO | 23430: exit 0 15:21:23 INFO - TEST-OK | dromaeo_css | took 1110481ms 15:21:23 INFO - TEST-START | kraken 15:21:23 INFO - operating with platform_type : linux_ 15:21:23 INFO - Initialising browser for kraken test... 15:21:23 INFO - TEST-INFO | started process 23623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFE7MRI/profile http://localhost:45783/getInfo.html) 15:21:27 INFO - PROCESS | 23623 | __metrics Screen width/height:1600/1200 15:21:27 INFO - PROCESS | 23623 | colorDepth:24 15:21:27 INFO - PROCESS | 23623 | Browser inner width/height: 1024/697 15:21:27 INFO - PROCESS | 23623 | __metrics 15:21:28 ERROR - PROCESS | 23623 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:21:29 INFO - TEST-INFO | 23623: exit 0 15:21:29 INFO - Browser initialized. 15:21:29 INFO - Running cycle 1/1 for kraken test... 15:21:29 INFO - TEST-INFO | started process 23718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFE7MRI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:41 INFO - PROCESS | 23718 | RSS: Main: 141910016 15:21:41 INFO - PROCESS | 23718 | 15:21:43 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45783/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:44 INFO - PROCESS | 23718 | RSS: Main: 190861312 15:21:44 INFO - PROCESS | 23718 | 15:21:47 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45783/tests/kraken/driver.html?testName=audio-dft) 15:21:47 INFO - PROCESS | 23718 | RSS: Main: 184672256 15:21:47 INFO - PROCESS | 23718 | 15:21:50 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45783/tests/kraken/driver.html?testName=audio-fft) 15:21:51 INFO - PROCESS | 23718 | RSS: Main: 273674240 15:21:51 INFO - PROCESS | 23718 | 15:21:53 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45783/tests/kraken/driver.html?testName=audio-oscillator) 15:21:53 INFO - PROCESS | 23718 | RSS: Main: 182607872 15:21:53 INFO - PROCESS | 23718 | 15:21:56 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45783/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:56 INFO - PROCESS | 23718 | RSS: Main: 181403648 15:21:56 INFO - PROCESS | 23718 | 15:21:59 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45783/tests/kraken/driver.html?testName=imaging-darkroom) 15:22:00 INFO - PROCESS | 23718 | RSS: Main: 216227840 15:22:00 INFO - PROCESS | 23718 | 15:22:03 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45783/tests/kraken/driver.html?testName=imaging-desaturate) 15:22:04 INFO - PROCESS | 23718 | RSS: Main: 215465984 15:22:04 INFO - PROCESS | 23718 | 15:22:06 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45783/tests/kraken/driver.html?testName=json-parse-financial) 15:22:07 INFO - PROCESS | 23718 | RSS: Main: 215220224 15:22:07 INFO - PROCESS | 23718 | 15:22:09 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45783/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:22:09 INFO - PROCESS | 23718 | RSS: Main: 199151616 15:22:09 INFO - PROCESS | 23718 | 15:22:11 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45783/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:22:12 INFO - PROCESS | 23718 | RSS: Main: 198545408 15:22:12 INFO - PROCESS | 23718 | 15:22:14 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45783/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:22:14 INFO - PROCESS | 23718 | RSS: Main: 207908864 15:22:14 INFO - PROCESS | 23718 | 15:22:17 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:22:17 INFO - PROCESS | 23718 | RSS: Main: 216559616 15:22:17 INFO - PROCESS | 23718 | 15:22:20 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:22:20 INFO - PROCESS | 23718 | RSS: Main: 214114304 15:22:20 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | Cycle 1(1): loaded http://localhost:45783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45783/tests/kraken/driver.html?testName=ai-astar) 15:22:22 INFO - PROCESS | 23718 | RSS: Main: 277811200 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | __start_tp_report 15:22:22 INFO - PROCESS | 23718 | _x_x_mozilla_page_load 15:22:22 INFO - PROCESS | 23718 | _x_x_mozilla_page_load_details 15:22:22 INFO - PROCESS | 23718 | |i|pagename|runs| 15:22:22 INFO - PROCESS | 23718 | |0;ai-astar;107;110;104;108;110;110;99;110;109;111 15:22:22 INFO - PROCESS | 23718 | |1;audio-beat-detection;152;126;156;178;136;157;149;133;186;126 15:22:22 INFO - PROCESS | 23718 | |2;audio-dft;159;160;160;159;159;159;161;162;161;159 15:22:22 INFO - PROCESS | 23718 | |3;audio-fft;72;75;78;173;77;76;76;76;167;76 15:22:22 INFO - PROCESS | 23718 | |4;audio-oscillator;91;92;154;92;93;93;148;92;92;148 15:22:22 INFO - PROCESS | 23718 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;116 15:22:22 INFO - PROCESS | 23718 | |6;imaging-darkroom;145;146;144;145;146;147;144;145;146;145 15:22:22 INFO - PROCESS | 23718 | |7;imaging-desaturate;94;94;95;95;94;94;95;95;95;94 15:22:22 INFO - PROCESS | 23718 | |8;json-parse-financial;55;59;58;59;57;57;56;84;57;55 15:22:22 INFO - PROCESS | 23718 | |9;json-stringify-tinderbox;58;58;58;58;59;58;58;58;59;58 15:22:22 INFO - PROCESS | 23718 | |10;stanford-crypto-aes;74;72;75;73;74;74;81;74;75;74 15:22:22 INFO - PROCESS | 23718 | |11;stanford-crypto-ccm;118;120;120;122;114;117;116;120;152;121 15:22:22 INFO - PROCESS | 23718 | |12;stanford-crypto-pbkdf2;159;158;155;156;155;157;160;157;157;159 15:22:22 INFO - PROCESS | 23718 | |13;stanford-crypto-sha256-iterative;67;68;67;66;64;68;77;66;65;65 15:22:22 INFO - PROCESS | 23718 | __end_tp_report 15:22:22 INFO - PROCESS | 23718 | __start_cc_report 15:22:22 INFO - PROCESS | 23718 | _x_x_mozilla_cycle_collect,1651 15:22:22 INFO - PROCESS | 23718 | __end_cc_report 15:22:22 INFO - PROCESS | 23718 | __startTimestamp1462486942898__endTimestamp 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | ------- Summary: start ------- 15:22:22 INFO - PROCESS | 23718 | Number of tests: 14 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:3.71 (3.4%) stddev-sans-first:3.92 15:22:22 INFO - PROCESS | 23718 | Values: 107.0 110.0 104.0 108.0 110.0 110.0 99.0 110.0 109.0 111.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:154.00 stddev:20.57 (13.4%) stddev-sans-first:21.80 15:22:22 INFO - PROCESS | 23718 | Values: 152.0 126.0 156.0 178.0 136.0 157.0 149.0 133.0 186.0 126.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 15:22:22 INFO - PROCESS | 23718 | Values: 159.0 160.0 160.0 159.0 159.0 159.0 161.0 162.0 161.0 159.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:39.79 (52.4%) stddev-sans-first:41.36 15:22:22 INFO - PROCESS | 23718 | Values: 72.0 75.0 78.0 173.0 77.0 76.0 76.0 76.0 167.0 76.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:28.00 (30.4%) stddev-sans-first:28.89 15:22:22 INFO - PROCESS | 23718 | Values: 91.0 92.0 154.0 92.0 93.0 93.0 148.0 92.0 92.0 148.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:22:22 INFO - PROCESS | 23718 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.95 (0.7%) stddev-sans-first:1.00 15:22:22 INFO - PROCESS | 23718 | Values: 145.0 146.0 144.0 145.0 146.0 147.0 144.0 145.0 146.0 145.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 15:22:22 INFO - PROCESS | 23718 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:57.50 stddev:8.65 (15.1%) stddev-sans-first:9.01 15:22:22 INFO - PROCESS | 23718 | Values: 55.0 59.0 58.0 59.0 57.0 57.0 56.0 84.0 57.0 55.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 15:22:22 INFO - PROCESS | 23718 | Values: 58.0 58.0 58.0 58.0 59.0 58.0 58.0 58.0 59.0 58.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:2.41 (3.3%) stddev-sans-first:2.55 15:22:22 INFO - PROCESS | 23718 | Values: 74.0 72.0 75.0 73.0 74.0 74.0 81.0 74.0 75.0 74.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:120.00 stddev:10.82 (9.0%) stddev-sans-first:11.38 15:22:22 INFO - PROCESS | 23718 | Values: 118.0 120.0 120.0 122.0 114.0 117.0 116.0 120.0 152.0 121.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:157.50 stddev:1.70 (1.1%) stddev-sans-first:1.69 15:22:22 INFO - PROCESS | 23718 | Values: 159.0 158.0 155.0 156.0 155.0 157.0 160.0 157.0 157.0 159.0 15:22:22 INFO - PROCESS | 23718 | 15:22:22 INFO - PROCESS | 23718 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:3.65 (5.5%) stddev-sans-first:3.87 15:22:22 INFO - PROCESS | 23718 | Values: 67.0 68.0 67.0 66.0 64.0 68.0 77.0 66.0 65.0 65.0 15:22:22 INFO - PROCESS | 23718 | -------- Summary: end -------- 15:22:22 INFO - PROCESS | 23718 | 15:22:23 INFO - TEST-INFO | 23718: exit 0 15:22:23 INFO - TEST-OK | kraken | took 60020ms 15:22:23 INFO - SUITE-END | took 1170s 15:22:24 INFO - Completed test suite (00:19:30) 15:22:24 INFO - javascript benchmark 15:22:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3298.1259966108983, 3348.045806945021, 3381.847816848243, 3392.5420068290773, 3422.8117453540053, 5523.558115350772, 5539.002979463695, 5556.194351818994, 5556.388797232306, 5558.416366281543, 5532.170174473831, 5559.833205003846, 5560.7219639017985, 5564.777408903639, 5571.275734154565, 4896.804127834882, 5027.0699920514735, 5045.495450454961, 5047.167217409123, 5126.282320475137, 5036.82371117011, 5045.621578381618, 5078.898422031557, 5080.79676812927, 5112.130937740593, 5046.369203849519, 5072.72100034498, 5084.0, 5084.415292241384, 5085.923711144335, 5078.390593128811, 5082.161443361878, 5085.618578606619, 5095.184770436731, 5113.207452844834, 4924.285978533093, 4961.851144465636, 4982.800687972477, 5011.6241281904, 5014.52362025607, 5385.111456609694, 5396.352437707461, 5398.406175320712, 5399.83800485986, 5450.482204190595, 5810.535157187415, 5829.883402331972, 5843.912341314884, 5850.912236316459, 5858.707064646751, 5828.154917536934, 5841.678707671076, 5873.970630146822, 5925.940740592582, 5969.8806023879715, 5617.325920889438, 5625.887482250373, 5626.606137570372, 5627.240322556484, 5632.239647647556, 6094.11635312886, 6098.969505152446, 6099.2985806632805, 6118.785842495491, 6120.510359171256, 5711.171880077365, 5724.398938111522, 5810.070388737866, 5846.883062338729, 5848.4151584841175, 5870.794522191788, 5890.911636325459, 5893.351731309553, 5899.115132730125, 5902.793402230901, 5829.242198514166, 5861.296644402699, 5868.823935281948, 5874.618149820333, 5876.941230587725, 5768.077107662753, 5925.881482370414, 5975.0, 5982.40175982407, 5990.820275391745, 4486.865394038184, 4486.990427153864, 4487.955120448819, 4493.505714371417, 4516.322551617283, 3954.6696367477566, 4039.7980100994832, 4044.0, 4051.716379853441, 4071.7964101795383, 5601.439856014447, 5698.230738850285, 5718.628289161191, 5718.714064296769, 5754.9424505754405, 5888.175655408247, 5888.322842873039, 5891.027980383275, 5896.380880007623, 5902.763889444374, 5467.644603100785, 5573.0, 5584.0, 5588.552915766729, 5594.720263986785, 5109.335786347825, 5109.335786347825, 5112.616553758483, 5113.821016264487, 5146.562542183956, 6117.051856962178, 6122.816315510542, 6124.173236613089, 6125.418085281891, 6125.693715314216, 5758.222639943721, 5879.353271140086, 5933.792317268875, 5942.64344139353, 5955.434233747787, 6060.787872424444, 6096.390360963868, 6096.695165241809, 6101.7559297627595, 6121.540884433596, 5741.885162296814, 5782.624129431573, 5790.478856902899, 5792.797252096157, 5798.94201057984, 5711.828645140652, 5844.3571207168025, 5844.386339434468, 5903.7048147593305, 5957.957357462514, 5769.394213607511, 5775.1914731938405, 5778.913316300343, 5781.682007489629, 5786.392428794916, 5694.601377903673, 5754.5684073695475, 5758.078707406795, 5765.913511297418, 5768.394318596655, 5521.723913804374, 5672.064109422065, 5734.684592347294, 5735.0, 5753.108268218432, 5773.0, 5775.826725198251, 5788.27646544182, 5789.073748200268, 5793.623414478046, 5510.614257001971, 5636.098224284095, 5671.517920976763, 5672.03575392176, 5673.5461163107675], "value": 5453.574663811809, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.2389822467478, 659.4098282037577, 678.0676569716641, 683.4737252315714, 688.352948228665, 34362.14094647632, 34940.95177144687, 34997.999999999935, 35007.824960875194, 40402.797986010104, 43205.0, 43761.56238437615, 43876.780616096956, 43885.12229755403, 44060.0, 8613.138686131399, 8864.556772161399, 8868.733937981871, 8871.600777965006, 8878.822423551524, 8883.289336853068, 9061.773455663595, 9074.319426043041, 9074.546272686372, 9082.091790820898, 9050.411723237969, 9191.678291259806, 9202.217811486033, 9204.769880752969, 9215.0, 9071.047540008303, 9102.0, 9162.770930726718, 9172.541372931326, 9178.219851312646, 8935.32985026119, 8991.685291014848, 9019.774505637346, 9042.502662353569, 9051.366404351698, 43781.0, 44262.0, 44330.0, 44344.334834977504, 44388.77805610983, 3868.516435445569, 3968.464257325253, 3980.24375368679, 4240.406343111967, 4645.883852903705, 32419.351612967843, 32445.188870278194, 32886.177845553815, 32909.50635740466, 33907.830460847785, 4597.655175861823, 4635.95364046362, 4655.0, 4666.859994200146, 4701.106789709978, 240824.0, 242422.0, 242685.0, 243105.0, 243168.0, 36630.8168459156, 67557.98663020058, 68691.0, 68762.3123768766, 68797.31202688008, 38251.0, 38402.2319553613, 38415.23169536594, 38455.423168652494, 38491.0, 16733.74899376486, 16977.575560611083, 16990.490285291213, 16995.74506382405, 17032.57418564546, 14166.291685415688, 14190.929045354707, 14221.28893555318, 14239.644008899653, 14239.64400889986, 9395.436273823592, 9444.480553569481, 9457.148856602938, 9462.384944978554, 9505.144536991565, 3569.9659384894903, 3635.94546081809, 3646.2889736501656, 3672.1737609038287, 3688.0779805048737, 1170.0814860334597, 1198.7422704118483, 1207.4626791078063, 1230.9384530773425, 1257.830192923962, 35500.46749298763, 35606.46590301148, 35755.463668045, 35848.462273065925, 35999.28001439956, 1217.792975194219, 1218.5734992752643, 1245.9252444853337, 1340.1423089222906, 1368.7270838120644, 18257.269709211483, 18637.534061648297, 18697.0, 18741.34405295808, 18762.906185468986, 525491.0, 531988.0, 532453.0, 532935.0, 533111.0, 64669.0, 65475.672621636586, 65657.0, 65673.67163164154, 65719.0, 1467.5377256164275, 1508.6605513759537, 1509.9698006039819, 1520.2018940056337, 1595.6649103688123, 30878.691213087583, 32865.50701739523, 33588.1602959928, 33617.83191084127, 35192.824035879654, 48847.5115248843, 49020.0, 49180.26229606487, 49425.0, 49499.0, 300624.0, 301853.0, 302286.0, 302419.0, 333959.0, 28540.0, 28904.421911562073, 28928.42143157083, 29109.0, 29343.266418339714, 44463.0, 45073.0, 45593.54406455893, 46668.7666561665, 46831.76584117058, 41183.58816411797, 41441.1711765769, 42044.78977605092, 42715.35926961036, 43361.566384335754, 42368.0, 42394.364084539375, 42849.571504284555, 43558.78220608877, 43617.56382436135, 41358.0, 42172.156556868074, 42515.0, 42748.358774619024, 42950.140997180504, 35602.8219858899, 37128.0, 37290.440643389826, 37559.61272201302, 37732.811335943145, 28072.157835264974, 28290.85854570714, 28606.0, 28629.0, 28784.136475905758], "value": 19446.939446418364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.8892687901145, 426.95516970718086, 434.6090735731075, 441.6224128370244, 442.7432089388153, 18310.26758929643, 18909.527261818443, 19150.90424547879, 19174.712379314322, 19204.615907681837, 18468.538286542844, 18843.152058157382, 20029.399118026482, 21005.579888402262, 21051.2632057878, 5796.739146738396, 5906.704664766766, 5916.556258280646, 5927.110933360009, 5936.643801371932, 4282.400463935051, 4371.759553224571, 5771.249737534135, 5803.158542011406, 6465.709043093048, 6459.257185423666, 6486.189226346707, 6492.805215843532, 6494.772682956098, 6498.935010649904, 6392.3288054754275, 6423.164988551505, 6444.0656104865, 6460.127882735841, 6461.57999730016, 3957.960420395788, 5568.136938774496, 5688.715564221772, 5864.5894787364905, 5873.2658417697785, 23044.308670739905, 23762.88118559396, 23894.0, 24011.27966161018, 24021.39946501334, 2599.7920166386643, 2622.3229832768757, 2639.762421382085, 2711.6339294195427, 2770.3351195713085, 14609.853901460956, 14783.852161478355, 14796.260186990607, 14878.553643390716, 14912.925435372863, 1878.953026174343, 1909.8185672361103, 1916.425072478251, 1919.481739930211, 1971.1819594868114, 54023.72988135074, 56988.715056424866, 82041.0, 85484.0, 86032.0, 11395.601153959571, 11497.770044599229, 11691.123165762601, 11746.29522228669, 11855.644330670093, 16662.83337166637, 16678.0, 16802.32790688383, 16829.831701682826, 16831.91584042072, 8353.33173346143, 8493.193146651058, 8558.743237702878, 8677.739667809976, 8780.429272097294, 8109.5134291941495, 8154.836903261901, 8185.427020108655, 8200.712975045844, 8307.916920830836, 4931.852044438672, 4943.90112197754, 5007.9499205008215, 5030.0, 5077.492250774893, 1849.842763365129, 1962.3720409469117, 2026.2806703620297, 2092.309537852505, 2097.108728790258, 476.5187160967448, 487.8365747474565, 985.7190700650424, 1057.5558265528496, 1079.9892001080045, 12180.57367992116, 12359.814602780785, 12453.688657783447, 12510.49958001688, 12549.623511294676, 495.1038620097635, 502.0511233768181, 507.4219178355312, 516.2385481414883, 529.7669025628788, 6558.0, 6678.298778628271, 6771.627560484122, 6788.422984046411, 6879.862402751917, 527695.0, 531495.0, 534915.0, 534991.0, 536726.0, 93884.0, 94510.52744736233, 99041.0, 103130.0, 103770.0, 1156.2831044752306, 1165.4347641393917, 1196.2284326609288, 1230.864604893461, 1232.8952039076778, 14620.926895365455, 17763.200655970253, 18169.818301816813, 18527.258909643464, 18763.249470021045, 41029.0, 43464.34803477887, 43647.56352436435, 44295.0, 44301.55698442974, 53132.20301695555, 56155.71922140363, 56642.0, 57779.0, 58021.70989145027, 8823.117688231125, 8874.866876996979, 9055.18503334703, 9184.54077296119, 9387.624495020124, 12994.090413670952, 13039.348032598142, 13744.312784360942, 14061.226632535308, 14135.717285654435, 11500.597479088192, 11946.820797687868, 12429.689257768629, 12529.749405012031, 12597.055220858289, 11972.820407694066, 12025.398730063636, 12316.630501084981, 12739.235645861278, 12793.872061279268, 12830.87169128334, 12878.806817897552, 12914.612561623166, 13127.671808204872, 13179.67050823737, 9108.453492790453, 9237.676681316121, 9350.25197984146, 9504.85742713846, 9545.140937315675, 9693.27300452483, 12524.998000159783, 12783.488660453479, 12856.935715321364, 13254.602361929157], "value": 9224.6909233559, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.9859501404983, 1571.2222449887308, 1614.0880402572545, 1781.9643607127857, 1941.3593514140334, 8211.219934106257, 8655.740327790169, 8690.56547172642, 8696.565171741404, 8700.521471319074, 8438.789030274245, 8627.568621568927, 8647.092055334193, 8648.13518648135, 8656.91343086569, 2115.481706981792, 2338.029717667166, 2374.1215750172373, 2378.5718570657273, 2447.0945750072497, 2357.2221167014845, 2367.9644805327935, 2369.230000249917, 2369.5616310982523, 2369.668246445499, 2299.195281651417, 2354.6703461515403, 2366.6331718583647, 2368.86971216583, 2369.680093187415, 2108.5888251790907, 2297.827662925279, 2371.0, 2376.263358358914, 2377.4175327044986, 2269.988650056739, 2275.9089636414524, 2279.5213005268915, 2281.0419623757894, 2315.5368926214655, 8557.187067228604, 8564.657413703444, 8575.656973721043, 8579.313654907592, 8585.35609829259, 5297.867553311159, 5467.589930755209, 5472.097103977839, 5472.835814925519, 5591.0495215813, 3231.5960504936884, 3356.882509112194, 3361.764676472648, 3413.9317213655836, 3437.673421024999, 1048.7849990751954, 1062.755566219766, 1063.4257500949554, 1064.4518073192312, 1093.9343639381582, 12075.215111017756, 12163.878361216452, 12167.634970950885, 12183.878161218452, 12188.085893558018, 4619.884502887455, 4681.625469962463, 4746.311784791255, 4777.020710754287, 4782.593479554207, 9660.37207581505, 9671.70984870455, 9684.789401324835, 9696.95151524238, 9701.805963880824, 4801.51984801524, 5469.343678758495, 5470.8085217017215, 5499.945000550023, 5507.366652834975, 4884.340614017134, 4955.752212389366, 4969.925451118236, 4986.950130498649, 4994.950050499521, 3908.2769687607883, 3946.329124048861, 4005.0588111793704, 4037.1320166164414, 4063.8577649782706, 1132.2583707671488, 1239.5165885304739, 1242.8943539799038, 1248.36333469931, 1259.3766085787595, 943.9480828554358, 999.3703966501204, 1017.3692310767372, 1024.4928760263567, 1040.843873418993, 5761.164631128463, 5975.25309336333, 5981.235535517033, 6113.8471538211015, 6146.446819786241, 443.15799980038184, 444.62651372846966, 447.42729306487746, 461.53846153846155, 467.87367410798896, 3935.6457918787446, 4075.89810254746, 4078.408630748525, 4097.242010228118, 4160.45914031174, 10606.840897386546, 11095.55617775296, 11233.494492747683, 11257.099432045417, 11280.097592192606, 10940.890591094147, 10943.124550035978, 11000.22998390105, 11066.059384952208, 11089.445527723581, 7623.35201507867, 7931.167227441036, 8021.0, 8026.675598526294, 8037.678492860337, 5681.914771278517, 6032.969835150796, 6063.242094738158, 6077.908831367445, 6161.383861613803, 9547.904520954979, 9702.563384647567, 9922.503874806087, 9924.503774811086, 9939.353941993748, 9707.029297070236, 9910.504474776377, 10056.748581285527, 10197.796044079225, 10640.201984851323, 7227.7108915644885, 7779.494332868346, 7989.840203195788, 8016.358691304798, 8194.67221311141, 8590.355723320901, 8636.0, 8640.395172338127, 8673.392862499817, 8688.956555217184, 7536.1333446654335, 7637.465377423527, 7719.961400193188, 7920.841583168189, 8010.198980101944, 7599.924000759922, 7630.465867389452, 7668.961655191688, 7698.422618303762, 7899.0, 7011.368976792113, 7177.0, 7224.638768061681, 7240.52936559122, 7253.238409966877, 5187.29971453864, 5208.947910520847, 5289.550388217045, 5328.680279183106, 5358.544523715528, 5031.84904452867, 5164.715940623302, 5264.657797243321, 5341.732913354394, 5368.812091576776], "value": 4559.033518110597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.7175387935772, 354.1500399042298, 356.01561681949397, 357.95883473400534, 363.41490200776747, 5484.957858006986, 5507.57666626684, 5513.283273174487, 5534.667919924807, 5551.195076713874, 5414.4044155143, 5418.91871621926, 5425.83722488325, 5446.685158807511, 5463.508284254416, 4024.8591299304458, 4094.529129150141, 4120.484939382577, 4264.530901600821, 4273.316269396897, 4257.467816522934, 4268.765217913014, 4287.228298906196, 4308.43990281263, 4311.504177019636, 4047.150098479323, 4259.957400426003, 4268.271350103213, 4271.081717430752, 4292.549282325358, 3939.72421930465, 4160.43834082398, 4263.0, 4300.376445415429, 4300.6989510734265, 3794.4687743715904, 3797.5442946846556, 3811.790351530665, 3826.349520581508, 3831.3103641344546, 5225.242339860737, 5227.2159176123505, 5232.450592687751, 5243.134882744343, 5251.474852514756, 4558.475775285851, 4833.806647734086, 4837.419509658828, 4854.320395144682, 4854.83008094715, 5622.437756224344, 5626.549876009909, 5656.8020119295625, 5675.262215911946, 5678.886422271573, 4108.137291168858, 4112.773797441139, 4113.71204015719, 4117.526484454266, 4118.032262418329, 5610.663360198401, 5912.17229587858, 5935.614185077956, 5958.40415958405, 5960.433758792951, 4115.650169735606, 4163.687723420695, 4164.167166566699, 4172.395002724588, 4189.476315460567, 4227.837344730224, 4248.107897341592, 4250.872473825791, 4257.489101307863, 4259.893502662396, 4720.858374248709, 4829.9034019319415, 4858.878528036827, 4868.342773725572, 4896.975515122402, 5692.544596432275, 5707.3721890592005, 5714.200011998323, 5718.342390625048, 5736.110902810071, 1541.3988544467666, 1549.1944189021647, 1552.8136623605014, 1554.1452201289246, 1554.4015554011787, 963.6386355116831, 975.2734213011352, 999.9251553027497, 1041.9895801042044, 1043.7077618266896, 5779.248697669276, 5866.735996880066, 5885.411458854081, 5900.527957763368, 5904.350521442638, 6170.228721409824, 6211.3167551569295, 6215.098810672427, 6226.750929962841, 6262.34245404226, 5732.226149469769, 5869.970650146807, 5876.382979787061, 5880.676562789087, 5896.115582662635, 3248.512723091555, 3278.0, 3283.6223834259367, 3312.7349812015464, 3319.535265062893, 6268.905966410507, 6357.459615932605, 6364.363563643691, 6411.429199845974, 6429.196350456193, 6241.656708880964, 6255.74977000924, 6264.874702505925, 6264.968675156595, 6295.842603934847, 6270.999999999909, 6372.235331760218, 6385.648789316632, 6415.230172379344, 6422.518311126684, 6130.272028947075, 6143.232095988002, 6153.154053783757, 6187.535934804818, 6194.628322300677, 6081.5134789217645, 6111.449969502766, 6119.816405507842, 6127.3566275540425, 6149.0, 6223.408776166257, 6347.428731414195, 6390.744370225325, 6397.104405383157, 6412.679366031586, 4375.081232941118, 4380.7152535085115, 4385.758783266951, 4388.802503887397, 4394.428724265953, 5670.376258611467, 6206.596571222856, 6226.719797609027, 6236.472064344264, 6240.251169859464, 5745.540356771365, 5780.046292361882, 5789.034511359732, 5791.0, 5813.738381772746, 5712.82887008154, 5737.647564498536, 5742.885142297047, 5791.913121303268, 5794.913076303775, 5589.357223919302, 5666.17840413146, 5679.545636348999, 5685.800996965087, 5724.198612194213, 5772.1341798728845, 5783.096409923369, 5791.233673729553, 5816.127580862904, 5823.854403639943, 5494.752736126964, 5684.886302274014, 5689.374168841341, 5698.230738850202, 5700.743466543932], "value": 4460.217851521826, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.1128482802027, 918.9816203675927, 924.1590152960807, 927.8097989912073, 943.9103285187905, 14707.926460367697, 14781.482648107318, 14884.404623815035, 15881.285342159601, 16672.58318542037, 15582.142982135978, 15656.138912359816, 15697.84302156978, 15721.213939303047, 15729.528114156565, 767.4436033875452, 890.7773056735816, 923.685946778097, 924.4268553496807, 925.0980294213156, 934.7476181431009, 934.9579268932914, 935.6771913689767, 935.9953200233989, 936.1901954809109, 967.5065716484609, 968.099667309402, 968.4963818814213, 968.8013957138805, 969.3989726369625, 807.6204184033495, 934.1825902335456, 964.3635200767495, 970.7136394763562, 973.0415540692412, 713.3401603516726, 713.4435140590348, 713.8001359619315, 714.0610097721532, 714.417749534128, 14963.251837408086, 15024.17367044812, 15064.548063558, 15065.171415572138, 15065.548033559011, 14032.298385080807, 14648.560543183721, 14659.853401465956, 14662.0, 14719.55841324762, 11158.776824463464, 11660.53208544133, 11864.762704745857, 11873.228240164362, 11986.486216340494, 4642.117997580449, 4735.414922040109, 4799.880002999918, 4808.903821923577, 4813.590844778198, 58130.41869581334, 59062.99999999957, 59575.70212148955, 59579.702101489645, 60448.69775651138, 11827.172097953233, 11939.582114625946, 11943.104267179997, 12090.57682981109, 12135.635930922086, 20407.081681324376, 20472.69290960637, 20474.590508189754, 20549.794502055087, 20593.279235226695, 8748.69379571712, 8953.731388058368, 8996.640134394682, 9135.40619859707, 9246.306527010502, 4955.108080545464, 4982.77577509013, 5002.57478114357, 5039.949600503948, 5082.2122571001555, 3519.4192958161616, 3629.346717590859, 3634.273145370936, 3635.909102272464, 3640.581333146669, 648.9610623362613, 652.742166844094, 657.6481582353514, 658.0524045374646, 679.4869873245767, 653.1867824558456, 757.5909009135115, 761.6001599160485, 764.3273918951287, 782.6047845837816, 9018.413803102909, 9274.211692006254, 9418.735722764897, 9478.526073696288, 9553.570089345996, 647.1231481342807, 743.5129989856653, 785.8899754034439, 789.5302295134501, 794.7456813819638, 4359.716618419792, 4405.273129933589, 4412.4705035395955, 4433.202023635777, 4436.423264975532, 64688.0, 65262.0, 65835.0, 65999.34000659932, 66172.669136654, 59258.703706482054, 59862.0, 59955.0, 60161.699191503765, 61319.08021379683, 51666.741666291426, 51998.74000630048, 52042.739786300066, 53803.46196538063, 55466.0, 8672.82654346897, 8730.388872778845, 8736.344774141837, 8779.604917778588, 8831.646734130563, 36400.08999774921, 36625.63374366222, 36721.63278367182, 36760.0, 36911.96984165897, 43771.56228437675, 46435.53564464447, 48270.75864620795, 48849.267260990404, 49870.75064624654, 11803.527858885893, 12222.388880556115, 12344.62966111018, 12405.813912791134, 12485.500579976699, 13177.472901084233, 13297.0, 13400.597982060553, 13433.395497202844, 13440.46238150463, 12041.45813438415, 12093.57672481459, 12146.574869879512, 12232.266064036186, 12380.380980951097, 12465.93767031159, 12573.308468034345, 12592.433340499883, 12595.181313214978, 13043.086983911035, 12179.147459677737, 12191.0, 12241.632751017483, 12399.938000309941, 12536.686582835502, 9154.633814647339, 9206.723798286062, 9286.489243091695, 9340.486273255035, 9545.188658964065, 10314.845277320996, 10682.73293167677, 10703.357798532114, 10833.51249193804, 10896.237263391486], "value": 7131.481701201162, "unit": "score"}], "name": "dromaeo_css", "value": 7221.971805719266, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 104.0, 108.0, 110.0, 110.0, 99.0, 110.0, 109.0, 111.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 156.0, 178.0, 136.0, 157.0, 149.0, 133.0, 186.0, 126.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 159.0, 159.0, 159.0, 161.0, 162.0, 161.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 78.0, 173.0, 77.0, 76.0, 76.0, 76.0, 167.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 154.0, 92.0, 93.0, 93.0, 148.0, 92.0, 92.0, 148.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 144.0, 145.0, 146.0, 147.0, 144.0, 145.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 58.0, 59.0, 57.0, 57.0, 56.0, 84.0, 57.0, 55.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 75.0, 73.0, 74.0, 74.0, 81.0, 74.0, 75.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 120.0, 122.0, 114.0, 117.0, 116.0, 120.0, 152.0, 121.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 155.0, 156.0, 155.0, 157.0, 160.0, 157.0, 157.0, 159.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 64.0, 68.0, 77.0, 66.0, 65.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1517.3999999999999, "alertThreshold": 2.0}]} 15:22:24 INFO - Return code: 0 15:22:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:22:24 ERROR - # TBPL SUCCESS # 15:22:24 INFO - Running post-action listener: _resource_record_post_action 15:22:24 INFO - Running post-run listener: _resource_record_post_run 15:22:25 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 376520704; Read time: 80; Write time: 253252 15:22:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 128180224; Read time: 0; Write time: 102512 15:22:25 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246239232; Read time: 80; Write time: 150704 15:22:25 INFO - Running post-run listener: _upload_blobber_files 15:22:25 INFO - Blob upload gear active. 15:22:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:25 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 15:22:25 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'] 15:22:25 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 15:22:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:22:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:22:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:26 INFO - (blobuploader) - INFO - Done attempting. 15:22:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:22:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:22:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:27 INFO - (blobuploader) - INFO - Done attempting. 15:22:27 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:27 INFO - Return code: 0 15:22:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ec6c57dd73b0fa3777858b224da15e233d5ace21f96335fe8f0737a136679cd853abcd5c510c55fb97483894f175d4ddc3fa7b3fd10fe18bd4ba940a81a0418", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61a1b47627e3c7e04f0b58f1d7cc8146e0f6276de3fec91cbf4c9ed89ec2b6747ce39b952335e41966b9bdd2aee51ad1a54bee1440cc8b571fc65d6e69fa7f83"} 15:22:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:27 INFO - Contents: 15:22:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ec6c57dd73b0fa3777858b224da15e233d5ace21f96335fe8f0737a136679cd853abcd5c510c55fb97483894f175d4ddc3fa7b3fd10fe18bd4ba940a81a0418", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61a1b47627e3c7e04f0b58f1d7cc8146e0f6276de3fec91cbf4c9ed89ec2b6747ce39b952335e41966b9bdd2aee51ad1a54bee1440cc8b571fc65d6e69fa7f83"} 15:22:27 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:27 INFO - Copying logs to upload dir... 15:22:27 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.792109 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-05 15:22:27.201267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 15:22:27.205089) ========= 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=6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869 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/3ec6c57dd73b0fa3777858b224da15e233d5ace21f96335fe8f0737a136679cd853abcd5c510c55fb97483894f175d4ddc3fa7b3fd10fe18bd4ba940a81a0418", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61a1b47627e3c7e04f0b58f1d7cc8146e0f6276de3fec91cbf4c9ed89ec2b6747ce39b952335e41966b9bdd2aee51ad1a54bee1440cc8b571fc65d6e69fa7f83"} build_url:https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/Vymv414BQ3OHq8QOv4zgvQ/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/3ec6c57dd73b0fa3777858b224da15e233d5ace21f96335fe8f0737a136679cd853abcd5c510c55fb97483894f175d4ddc3fa7b3fd10fe18bd4ba940a81a0418", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61a1b47627e3c7e04f0b58f1d7cc8146e0f6276de3fec91cbf4c9ed89ec2b6747ce39b952335e41966b9bdd2aee51ad1a54bee1440cc8b571fc65d6e69fa7f83"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 15:22:27.230775) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:22:27.231181) ========= 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=6dbc10da6d83fee962c624be000001a8-1462485701.16938-1642495869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 15:22:27.314929) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 15:22:27.315312) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 15:22:27.315675) ========= ========= Total master_lag: 0.16 =========