builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1466254465.72 results: success (0) buildid: 20160618031522 builduid: 162c044dae014cdb9ee9341d299a9c63 revision: cec857b11eaf51d6c04368f65fef17e017a0f96c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:25.722293) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:25.722924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:25.723258) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:25.738437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:25.738789) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 05:54:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-18 05:54:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120440 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:25.876147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:25.876868) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019210 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:25.930041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:25.930705) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cec857b11eaf51d6c04368f65fef17e017a0f96c --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-beta --rev cec857b11eaf51d6c04368f65fef17e017a0f96c --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=9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 05:54:26,049 truncating revision to first 12 chars 2016-06-18 05:54:26,049 Setting DEBUG logging. 2016-06-18 05:54:26,049 attempt 1/10 2016-06-18 05:54:26,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cec857b11eaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 05:54:26,367 unpacking tar archive at: mozilla-beta-cec857b11eaf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636119 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:26.687860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:26.688627) ========= script_repo_revision: cec857b11eaf51d6c04368f65fef17e017a0f96c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:26.689541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:26.690231) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 05:54:26.706611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-18 05:54:26.706919) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:26 INFO - MultiFileLogger online at 20160618 05:54:26 in /builds/slave/test 05:54:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:54:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:26 INFO - {'append_to_log': False, 05:54:26 INFO - 'base_work_dir': '/builds/slave/test', 05:54:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:54:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:26 INFO - 'branch': 'Mozilla-Beta', 05:54:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:26 INFO - 'config_files': ('talos/linux_config.py',), 05:54:26 INFO - 'default_actions': ('clobber', 05:54:26 INFO - 'read-buildbot-config', 05:54:26 INFO - 'download-and-extract', 05:54:26 INFO - 'populate-webroot', 05:54:26 INFO - 'create-virtualenv', 05:54:26 INFO - 'install', 05:54:26 INFO - 'run-tests'), 05:54:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:26 INFO - 'download_minidump_stackwalk': True, 05:54:26 INFO - 'download_symbols': 'ondemand', 05:54:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:26 INFO - 'installer_path': 'installer.exe', 05:54:26 INFO - 'log_level': 'info', 05:54:26 INFO - 'log_name': 'talos', 05:54:26 INFO - 'log_to_console': True, 05:54:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:26 INFO - 'opt_config_files': (), 05:54:26 INFO - 'pip_index': False, 05:54:26 INFO - 'sps_profile': False, 05:54:26 INFO - 'sps_profile_interval': 0, 05:54:26 INFO - 'suite': 'dromaeojs', 05:54:26 INFO - 'system_bits': '32', 05:54:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:26 INFO - 'title': 'talos-linux64-ix-013', 05:54:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:26 INFO - 'use_talos_json': True, 05:54:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:26 INFO - 'work_dir': 'build'} 05:54:26 INFO - ##### 05:54:26 INFO - ##### Running clobber step. 05:54:26 INFO - ##### 05:54:26 INFO - Running pre-action listener: _resource_record_pre_action 05:54:26 INFO - Running main action method: clobber 05:54:26 INFO - rmtree: /builds/slave/test/build 05:54:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:27 INFO - Running post-action listener: _resource_record_post_action 05:54:27 INFO - ##### 05:54:27 INFO - ##### Running read-buildbot-config step. 05:54:27 INFO - ##### 05:54:27 INFO - Running pre-action listener: _resource_record_pre_action 05:54:27 INFO - Running main action method: read_buildbot_config 05:54:27 INFO - Using buildbot properties: 05:54:27 INFO - { 05:54:27 INFO - "project": "", 05:54:27 INFO - "product": "firefox", 05:54:27 INFO - "script_repo_revision": "production", 05:54:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:54:27 INFO - "repository": "", 05:54:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:54:27 INFO - "buildid": "20160618031522", 05:54:27 INFO - "pgo_build": "True", 05:54:27 INFO - "basedir": "/builds/slave/test", 05:54:27 INFO - "buildnumber": 45, 05:54:27 INFO - "slavename": "talos-linux64-ix-013", 05:54:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:54:27 INFO - "platform": "ubuntu64_hw", 05:54:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:54:27 INFO - "branch": "mozilla-beta", 05:54:27 INFO - "repo_path": "releases/mozilla-beta", 05:54:27 INFO - "revision": "cec857b11eaf51d6c04368f65fef17e017a0f96c", 05:54:27 INFO - "stage_platform": "linux64-pgo", 05:54:27 INFO - "builduid": "162c044dae014cdb9ee9341d299a9c63", 05:54:27 INFO - "slavebuilddir": "test" 05:54:27 INFO - } 05:54:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 05:54:27 INFO - Running post-action listener: _resource_record_post_action 05:54:27 INFO - ##### 05:54:27 INFO - ##### Running download-and-extract step. 05:54:27 INFO - ##### 05:54:27 INFO - Running pre-action listener: _resource_record_pre_action 05:54:27 INFO - Running main action method: download_and_extract 05:54:27 INFO - mkdir: /builds/slave/test/build/tests 05:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:27 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:54:28 INFO - Downloaded 1327 bytes. 05:54:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:54:28 INFO - Using the following test package requirements: 05:54:28 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:54:28 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:28 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:28 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:28 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 05:54:28 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:28 INFO - u'jsshell-linux-x86_64.zip'], 05:54:28 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:28 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:28 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:54:28 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:28 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 05:54:28 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:28 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 05:54:28 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:28 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:28 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:54:28 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:28 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:28 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:29 INFO - Downloaded 24185047 bytes. 05:54:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:54:30 INFO - Return code: 0 05:54:30 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:54: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')]} 05:54:30 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:54:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:54:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:32 INFO - Downloaded 24185047 bytes. 05:54:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:54:33 INFO - Return code: 0 05:54:33 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')]} 05:54:33 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:35 INFO - Downloaded 10840145 bytes. 05:54:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:54:35 INFO - Return code: 0 05:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:35 INFO - https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:54:38 INFO - Downloaded 55996741 bytes. 05:54:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:54:38 INFO - mkdir: /builds/slave/test/properties 05:54:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:38 INFO - Contents: 05:54:38 INFO - build_url:https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:54:38 INFO - Running post-action listener: _resource_record_post_action 05:54:38 INFO - Running post-action listener: set_extra_try_arguments 05:54:38 INFO - ##### 05:54:38 INFO - ##### Running populate-webroot step. 05:54:38 INFO - ##### 05:54:38 INFO - Running pre-action listener: _resource_record_pre_action 05:54:38 INFO - Running main action method: populate_webroot 05:54:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:38 INFO - '--tppagecycles', 05:54:38 INFO - '7'], 05:54:38 INFO - 'tests': ['tsvgm']}}, 05:54:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:38 INFO - 'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:38 INFO - 'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['damp', 'tps']}, 05:54:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:38 INFO - 'tests': ['damp', 'tps']}, 05:54:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['dromaeo_dom']}, 05:54:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['a11yr', 05:54:38 INFO - 'ts_paint', 05:54:38 INFO - 'tpaint', 05:54:38 INFO - 'sessionrestore', 05:54:38 INFO - 'sessionrestore_no_auto_restore', 05:54:38 INFO - 'tabpaint']}, 05:54:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:38 INFO - 'ts_paint', 05:54:38 INFO - 'tpaint', 05:54:38 INFO - 'sessionrestore', 05:54:38 INFO - 'sessionrestore_no_auto_restore', 05:54:38 INFO - 'tabpaint']}, 05:54:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:38 INFO - 'ts_paint', 05:54:38 INFO - 'tpaint', 05:54:38 INFO - 'sessionrestore', 05:54:38 INFO - 'sessionrestore_no_auto_restore', 05:54:38 INFO - 'tabpaint']}, 05:54:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:38 INFO - 'ts_paint', 05:54:38 INFO - 'tpaint', 05:54:38 INFO - 'sessionrestore', 05:54:38 INFO - 'sessionrestore_no_auto_restore', 05:54:38 INFO - 'tabpaint']}, 05:54:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['a11yr', 05:54:38 INFO - 'ts_paint', 05:54:38 INFO - 'tpaint', 05:54:38 INFO - 'sessionrestore', 05:54:38 INFO - 'sessionrestore_no_auto_restore', 05:54:38 INFO - 'tabpaint']}, 05:54:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['a11yr', 05:54:38 INFO - 'ts_paint', 05:54:38 INFO - 'tpaint', 05:54:38 INFO - 'sessionrestore', 05:54:38 INFO - 'sessionrestore_no_auto_restore', 05:54:38 INFO - 'tabpaint']}, 05:54:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['tsvgx', 05:54:38 INFO - 'tsvgr_opacity', 05:54:38 INFO - 'tart', 05:54:38 INFO - 'tscrollx', 05:54:38 INFO - 'cart']}, 05:54:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:38 INFO - 'tsvgr_opacity', 05:54:38 INFO - 'tart', 05:54:38 INFO - 'tscrollx', 05:54:38 INFO - 'cart']}, 05:54:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:38 INFO - 'talos_options': ['--disable-e10s'], 05:54:38 INFO - 'tests': ['tp5o']}, 05:54:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:38 INFO - 'tests': ['tp5o']}, 05:54:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:38 INFO - 'talos_options': ['--disable-e10s', 05:54:38 INFO - '--xperf_path', 05:54:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:38 INFO - 'tests': ['tp5n']}, 05:54:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:38 INFO - 'talos_options': ['--xperf_path', 05:54:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:38 INFO - 'tests': ['tp5n']}}, 05:54:38 INFO - 'talos.zip': {'path': '', 05:54:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:38 INFO - Running post-action listener: _resource_record_post_action 05:54:38 INFO - ##### 05:54:38 INFO - ##### Running create-virtualenv step. 05:54:38 INFO - ##### 05:54:38 INFO - Running pre-action listener: _resource_record_pre_action 05:54:38 INFO - Running main action method: create_virtualenv 05:54:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:38 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 05:54:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:38 INFO - Using real prefix '/usr' 05:54:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:41 INFO - Installing pip.................done. 05:54:41 INFO - Return code: 0 05:54:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:41 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')]} 05:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:41 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')]} 05:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:41 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 0x7f4b090e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', '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 05:54:41 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 05:54:41 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 05:54:41 INFO - Using env: {'DISPLAY': ':0', 05:54:41 INFO - 'HOME': '/home/cltbld', 05:54:41 INFO - 'LANG': 'en_US.UTF-8', 05:54:41 INFO - 'LANGUAGE': 'en_US:en', 05:54:41 INFO - 'LOGNAME': 'cltbld', 05:54:41 INFO - 'MAIL': '/var/mail/cltbld', 05:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:41 INFO - 'MOZ_NO_REMOTE': '1', 05:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:41 INFO - 'NO_EM_RESTART': '1', 05:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:41 INFO - 'PWD': '/builds/slave/test', 05:54:41 INFO - 'SHELL': '/bin/bash', 05:54:41 INFO - 'SHLVL': '1', 05:54:41 INFO - 'TERM': 'linux', 05:54:41 INFO - 'TMOUT': '86400', 05:54:41 INFO - 'USER': 'cltbld', 05:54:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:41 INFO - '_': '/tools/buildbot/bin/python'} 05:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:41 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 05:54:41 INFO - Cleaning up... 05:54:41 INFO - Return code: 0 05:54:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:54:41 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')]} 05:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:41 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')]} 05:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:41 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 0x7f4b090e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', '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 05:54:41 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 05:54:41 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 05:54:41 INFO - Using env: {'DISPLAY': ':0', 05:54:41 INFO - 'HOME': '/home/cltbld', 05:54:41 INFO - 'LANG': 'en_US.UTF-8', 05:54:41 INFO - 'LANGUAGE': 'en_US:en', 05:54:41 INFO - 'LOGNAME': 'cltbld', 05:54:41 INFO - 'MAIL': '/var/mail/cltbld', 05:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:41 INFO - 'MOZ_NO_REMOTE': '1', 05:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:41 INFO - 'NO_EM_RESTART': '1', 05:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:41 INFO - 'PWD': '/builds/slave/test', 05:54:41 INFO - 'SHELL': '/bin/bash', 05:54:41 INFO - 'SHLVL': '1', 05:54:41 INFO - 'TERM': 'linux', 05:54:41 INFO - 'TMOUT': '86400', 05:54:41 INFO - 'USER': 'cltbld', 05:54:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:41 INFO - '_': '/tools/buildbot/bin/python'} 05:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:41 INFO - Downloading/unpacking psutil>=0.7.1 05:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:43 INFO - Installing collected packages: psutil 05:54:43 INFO - Running setup.py install for psutil 05:54:43 INFO - building 'psutil._psutil_linux' extension 05:54:43 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 05:54:44 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 05:54:44 INFO - building 'psutil._psutil_posix' extension 05:54:44 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 05:54:44 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 05:54:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:44 INFO - Successfully installed psutil 05:54:44 INFO - Cleaning up... 05:54:44 INFO - Return code: 0 05:54:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:54:44 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')]} 05:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:44 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')]} 05:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:44 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 0x7f4b090e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', '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 05:54:44 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 05:54:44 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 05:54:44 INFO - Using env: {'DISPLAY': ':0', 05:54:44 INFO - 'HOME': '/home/cltbld', 05:54:44 INFO - 'LANG': 'en_US.UTF-8', 05:54:44 INFO - 'LANGUAGE': 'en_US:en', 05:54:44 INFO - 'LOGNAME': 'cltbld', 05:54:44 INFO - 'MAIL': '/var/mail/cltbld', 05:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:44 INFO - 'MOZ_NO_REMOTE': '1', 05:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:44 INFO - 'NO_EM_RESTART': '1', 05:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:44 INFO - 'PWD': '/builds/slave/test', 05:54:44 INFO - 'SHELL': '/bin/bash', 05:54:44 INFO - 'SHLVL': '1', 05:54:44 INFO - 'TERM': 'linux', 05:54:44 INFO - 'TMOUT': '86400', 05:54:44 INFO - 'USER': 'cltbld', 05:54:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:44 INFO - '_': '/tools/buildbot/bin/python'} 05:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:54:46 INFO - Installing collected packages: mozsystemmonitor 05:54:46 INFO - Running setup.py install for mozsystemmonitor 05:54:46 INFO - Successfully installed mozsystemmonitor 05:54:46 INFO - Cleaning up... 05:54:46 INFO - Return code: 0 05:54:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:46 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')]} 05:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:46 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')]} 05:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:46 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 0x7f4b090e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', '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 05:54:46 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 05:54:46 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 05:54:46 INFO - Using env: {'DISPLAY': ':0', 05:54:46 INFO - 'HOME': '/home/cltbld', 05:54:46 INFO - 'LANG': 'en_US.UTF-8', 05:54:46 INFO - 'LANGUAGE': 'en_US:en', 05:54:46 INFO - 'LOGNAME': 'cltbld', 05:54:46 INFO - 'MAIL': '/var/mail/cltbld', 05:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:46 INFO - 'MOZ_NO_REMOTE': '1', 05:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:46 INFO - 'NO_EM_RESTART': '1', 05:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:46 INFO - 'PWD': '/builds/slave/test', 05:54:46 INFO - 'SHELL': '/bin/bash', 05:54:46 INFO - 'SHLVL': '1', 05:54:46 INFO - 'TERM': 'linux', 05:54:46 INFO - 'TMOUT': '86400', 05:54:46 INFO - 'USER': 'cltbld', 05:54:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:46 INFO - '_': '/tools/buildbot/bin/python'} 05:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 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 05:54:48 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:48 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 05:54:48 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 05:54:48 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 05:54:48 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 05:54:48 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 05:54:48 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 05:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 INFO - Downloading docopt-0.6.1.tar.gz 05:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:49 INFO - Running setup.py install for blobuploader 05:54:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:49 INFO - Running setup.py install for requests 05:54:50 INFO - Running setup.py install for docopt 05:54:50 INFO - Successfully installed blobuploader requests docopt 05:54:50 INFO - Cleaning up... 05:54:50 INFO - Return code: 0 05:54:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:50 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')]} 05:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:50 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')]} 05:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:50 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 0x7f4b090e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', '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 05:54:50 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 05:54:50 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 05:54:50 INFO - Using env: {'DISPLAY': ':0', 05:54:50 INFO - 'HOME': '/home/cltbld', 05:54:50 INFO - 'LANG': 'en_US.UTF-8', 05:54:50 INFO - 'LANGUAGE': 'en_US:en', 05:54:50 INFO - 'LOGNAME': 'cltbld', 05:54:50 INFO - 'MAIL': '/var/mail/cltbld', 05:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:50 INFO - 'MOZ_NO_REMOTE': '1', 05:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:50 INFO - 'NO_EM_RESTART': '1', 05:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:50 INFO - 'PWD': '/builds/slave/test', 05:54:50 INFO - 'SHELL': '/bin/bash', 05:54:50 INFO - 'SHLVL': '1', 05:54:50 INFO - 'TERM': 'linux', 05:54:50 INFO - 'TMOUT': '86400', 05:54:50 INFO - 'USER': 'cltbld', 05:54:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:50 INFO - '_': '/tools/buildbot/bin/python'} 05:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:50 INFO - Running setup.py (path:/tmp/pip-f09Xat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:50 INFO - Running setup.py (path:/tmp/pip-bkZu19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:50 INFO - Running setup.py (path:/tmp/pip-hPvcab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:50 INFO - Running setup.py (path:/tmp/pip-eGqvAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:50 INFO - Running setup.py (path:/tmp/pip-NEIg34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:50 INFO - Running setup.py (path:/tmp/pip-rHECGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:50 INFO - Running setup.py (path:/tmp/pip-LaNvsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:50 INFO - Running setup.py (path:/tmp/pip-rR0qVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:50 INFO - Running setup.py (path:/tmp/pip-G1ghQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:51 INFO - Running setup.py (path:/tmp/pip-U6sPsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:51 INFO - Running setup.py (path:/tmp/pip-KP88xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:51 INFO - Running setup.py (path:/tmp/pip-wEcbe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:51 INFO - Running setup.py (path:/tmp/pip-mWugAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:51 INFO - Running setup.py (path:/tmp/pip-vV_IRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:51 INFO - Running setup.py (path:/tmp/pip-1_PRN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:51 INFO - Running setup.py (path:/tmp/pip-hHviwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:51 INFO - Running setup.py (path:/tmp/pip-VC2jPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:51 INFO - Running setup.py install for manifestparser 05:54:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:51 INFO - Running setup.py install for mozcrash 05:54:51 INFO - Running setup.py install for mozdebug 05:54:51 INFO - Running setup.py install for mozdevice 05:54:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Running setup.py install for mozfile 05:54:52 INFO - Running setup.py install for mozhttpd 05:54:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Running setup.py install for mozinfo 05:54:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Running setup.py install for mozInstall 05:54:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Running setup.py install for mozleak 05:54:52 INFO - Running setup.py install for mozlog 05:54:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Running setup.py install for moznetwork 05:54:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Running setup.py install for mozprocess 05:54:52 INFO - Running setup.py install for mozprofile 05:54:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:52 INFO - Running setup.py install for mozrunner 05:54:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:53 INFO - Running setup.py install for mozscreenshot 05:54:53 INFO - Running setup.py install for moztest 05:54:53 INFO - Running setup.py install for mozversion 05:54:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:53 INFO - Cleaning up... 05:54:53 INFO - Return code: 0 05:54:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:53 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')]} 05:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:53 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')]} 05:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:53 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 0x7f4b090e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', '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 05:54:53 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 05:54:53 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 05:54:53 INFO - Using env: {'DISPLAY': ':0', 05:54:53 INFO - 'HOME': '/home/cltbld', 05:54:53 INFO - 'LANG': 'en_US.UTF-8', 05:54:53 INFO - 'LANGUAGE': 'en_US:en', 05:54:53 INFO - 'LOGNAME': 'cltbld', 05:54:53 INFO - 'MAIL': '/var/mail/cltbld', 05:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:53 INFO - 'MOZ_NO_REMOTE': '1', 05:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:53 INFO - 'NO_EM_RESTART': '1', 05:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:53 INFO - 'PWD': '/builds/slave/test', 05:54:53 INFO - 'SHELL': '/bin/bash', 05:54:53 INFO - 'SHLVL': '1', 05:54:53 INFO - 'TERM': 'linux', 05:54:53 INFO - 'TMOUT': '86400', 05:54:53 INFO - 'USER': 'cltbld', 05:54:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:53 INFO - '_': '/tools/buildbot/bin/python'} 05:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:53 INFO - Running setup.py (path:/tmp/pip-Zp4b6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:53 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)) 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:53 INFO - Running setup.py (path:/tmp/pip-BbM6lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:53 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)) 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:53 INFO - Running setup.py (path:/tmp/pip-SD3qPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:53 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)) 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:53 INFO - Running setup.py (path:/tmp/pip-7rq02q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:53 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)) 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:53 INFO - Running setup.py (path:/tmp/pip-WTixwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:53 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)) 05:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:53 INFO - Running setup.py (path:/tmp/pip-4VN35E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:54 INFO - Running setup.py (path:/tmp/pip-ehkJ4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:54 INFO - Running setup.py (path:/tmp/pip-fqT7hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:54 INFO - Running setup.py (path:/tmp/pip-UlHZjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:54 INFO - Running setup.py (path:/tmp/pip-Ap5zyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:54 INFO - Running setup.py (path:/tmp/pip-r0Ya8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:54 INFO - Running setup.py (path:/tmp/pip-QJHiUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:54 INFO - Running setup.py (path:/tmp/pip-bqOOsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:54 INFO - Running setup.py (path:/tmp/pip-rRDkCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:54 INFO - Running setup.py (path:/tmp/pip-drVSbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:54 INFO - Running setup.py (path:/tmp/pip-Lp_YVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:54 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)) 05:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:54 INFO - Running setup.py (path:/tmp/pip-ZOpIyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 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)) 05:54:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:56 INFO - Downloading blessings-1.6.tar.gz 05:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:56 INFO - Installing collected packages: blessings 05:54:56 INFO - Running setup.py install for blessings 05:54:56 INFO - Successfully installed blessings 05:54:56 INFO - Cleaning up... 05:54:56 INFO - Return code: 0 05:54:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:57 INFO - Reading from file tmpfile_stdout 05:54:57 INFO - Current package versions: 05:54:57 INFO - argparse == 1.2.1 05:54:57 INFO - blessings == 1.6 05:54:57 INFO - blobuploader == 1.2.4 05:54:57 INFO - docopt == 0.6.1 05:54:57 INFO - manifestparser == 1.1 05:54:57 INFO - mozInstall == 1.12 05:54:57 INFO - mozcrash == 0.17 05:54:57 INFO - mozdebug == 0.1 05:54:57 INFO - mozdevice == 0.48 05:54:57 INFO - mozfile == 1.2 05:54:57 INFO - mozhttpd == 0.7 05:54:57 INFO - mozinfo == 0.9 05:54:57 INFO - mozleak == 0.1 05:54:57 INFO - mozlog == 3.1 05:54:57 INFO - moznetwork == 0.27 05:54:57 INFO - mozprocess == 0.22 05:54:57 INFO - mozprofile == 0.28 05:54:57 INFO - mozrunner == 6.11 05:54:57 INFO - mozscreenshot == 0.1 05:54:57 INFO - mozsystemmonitor == 0.0 05:54:57 INFO - moztest == 0.7 05:54:57 INFO - mozversion == 1.4 05:54:57 INFO - psutil == 3.1.1 05:54:57 INFO - requests == 1.2.3 05:54:57 INFO - wsgiref == 0.1.2 05:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:57 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')]} 05:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:57 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')]} 05:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:57 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 0x7f4b090e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', '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 05:54:57 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 05:54:57 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 05:54:57 INFO - Using env: {'DISPLAY': ':0', 05:54:57 INFO - 'HOME': '/home/cltbld', 05:54:57 INFO - 'LANG': 'en_US.UTF-8', 05:54:57 INFO - 'LANGUAGE': 'en_US:en', 05:54:57 INFO - 'LOGNAME': 'cltbld', 05:54:57 INFO - 'MAIL': '/var/mail/cltbld', 05:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:57 INFO - 'MOZ_NO_REMOTE': '1', 05:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:57 INFO - 'NO_EM_RESTART': '1', 05:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:57 INFO - 'PWD': '/builds/slave/test', 05:54:57 INFO - 'SHELL': '/bin/bash', 05:54:57 INFO - 'SHLVL': '1', 05:54:57 INFO - 'TERM': 'linux', 05:54:57 INFO - 'TMOUT': '86400', 05:54:57 INFO - 'USER': 'cltbld', 05:54:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:57 INFO - '_': '/tools/buildbot/bin/python'} 05:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:57 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)) 05:54:57 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)) 05:54:57 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)) 05:54:57 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)) 05:54:57 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)) 05:54:57 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)) 05:54:57 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)) 05:54:57 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)) 05:54:57 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)) 05:54:57 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)) 05:54:57 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)) 05:54:57 INFO - Cleaning up... 05:54:57 INFO - Return code: 0 05:54:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:57 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')]} 05:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:57 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')]} 05:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:57 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 0x7f4b090e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', '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 05:54:57 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 05:54:57 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 05:54:57 INFO - Using env: {'DISPLAY': ':0', 05:54:57 INFO - 'HOME': '/home/cltbld', 05:54:57 INFO - 'LANG': 'en_US.UTF-8', 05:54:57 INFO - 'LANGUAGE': 'en_US:en', 05:54:57 INFO - 'LOGNAME': 'cltbld', 05:54:57 INFO - 'MAIL': '/var/mail/cltbld', 05:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:57 INFO - 'MOZ_NO_REMOTE': '1', 05:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:57 INFO - 'NO_EM_RESTART': '1', 05:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:57 INFO - 'PWD': '/builds/slave/test', 05:54:57 INFO - 'SHELL': '/bin/bash', 05:54:57 INFO - 'SHLVL': '1', 05:54:57 INFO - 'TERM': 'linux', 05:54:57 INFO - 'TMOUT': '86400', 05:54:57 INFO - 'USER': 'cltbld', 05:54:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:57 INFO - '_': '/tools/buildbot/bin/python'} 05:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:57 INFO - Downloading/unpacking jsonschema 05:54:57 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 05:54:57 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 05:54:57 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 05:54:57 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 05:54:57 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 05:54:57 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 05:54:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:59 INFO - Downloading/unpacking functools32 (from jsonschema) 05:54:59 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 05:54:59 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 05:54:59 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 05:54:59 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 05:54:59 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 05:54:59 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 05:54:59 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:59 INFO - warning: no files found matching '*.txt' 05:54:59 INFO - no previously-included directories found matching 'build' 05:54:59 INFO - no previously-included directories found matching 'dist' 05:54:59 INFO - no previously-included directories found matching '.git*' 05:54:59 INFO - Installing collected packages: jsonschema, functools32 05:54:59 INFO - Running setup.py install for functools32 05:54:59 INFO - warning: no files found matching '*.txt' 05:54:59 INFO - no previously-included directories found matching 'build' 05:54:59 INFO - no previously-included directories found matching 'dist' 05:54:59 INFO - no previously-included directories found matching '.git*' 05:54:59 INFO - Successfully installed jsonschema functools32 05:54:59 INFO - Cleaning up... 05:54:59 INFO - Return code: 0 05:54:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:54:59 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')]} 05:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:59 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')]} 05:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:59 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 0x7f4b090e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b295a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', '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 05:54:59 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 05:54:59 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 05:54:59 INFO - Using env: {'DISPLAY': ':0', 05:54:59 INFO - 'HOME': '/home/cltbld', 05:54:59 INFO - 'LANG': 'en_US.UTF-8', 05:54:59 INFO - 'LANGUAGE': 'en_US:en', 05:54:59 INFO - 'LOGNAME': 'cltbld', 05:54:59 INFO - 'MAIL': '/var/mail/cltbld', 05:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:59 INFO - 'MOZ_NO_REMOTE': '1', 05:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:59 INFO - 'NO_EM_RESTART': '1', 05:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:59 INFO - 'PWD': '/builds/slave/test', 05:54:59 INFO - 'SHELL': '/bin/bash', 05:54:59 INFO - 'SHLVL': '1', 05:54:59 INFO - 'TERM': 'linux', 05:54:59 INFO - 'TMOUT': '86400', 05:54:59 INFO - 'USER': 'cltbld', 05:54:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:59 INFO - '_': '/tools/buildbot/bin/python'} 05:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:00 INFO - Downloading/unpacking flake8 05:55:00 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 05:55:00 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 05:55:00 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 05:55:00 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 05:55:00 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 05:55:00 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 05:55:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:55:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:55:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 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 05:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:55:02 INFO - no previously-included directories found matching 'docs/_build' 05:55:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:55:03 INFO - Running setup.py install for pep8 05:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:55:03 INFO - no previously-included directories found matching 'docs/_build' 05:55:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:55:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:55:03 INFO - Cleaning up... 05:55:03 INFO - Return code: 0 05:55:03 INFO - Running post-action listener: _resource_record_post_action 05:55:03 INFO - Running post-action listener: _start_resource_monitoring 05:55:03 INFO - Starting resource monitoring. 05:55:03 INFO - ##### 05:55:03 INFO - ##### Running install step. 05:55:03 INFO - ##### 05:55:03 INFO - Running pre-action listener: _resource_record_pre_action 05:55:03 INFO - Running main action method: install 05:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:03 INFO - Reading from file tmpfile_stdout 05:55:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:03 INFO - Reading from file tmpfile_stdout 05:55:03 INFO - Output received: 05:55:03 INFO - Usage: mozinstall [options] installer 05:55:03 INFO - Options: 05:55:03 INFO - -h, --help show this help message and exit 05:55:03 INFO - -d DEST, --destination=DEST 05:55:03 INFO - Directory to install application into. [default: 05:55:03 INFO - "/builds/slave/test"] 05:55:03 INFO - --app=APP Application being installed. [default: firefox] 05:55:03 INFO - mkdir: /builds/slave/test/build/application 05:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:55:16 INFO - Reading from file tmpfile_stdout 05:55:16 INFO - Output received: 05:55:16 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:16 INFO - Running post-action listener: _resource_record_post_action 05:55:16 INFO - ##### 05:55:16 INFO - ##### Running run-tests step. 05:55:16 INFO - ##### 05:55:16 INFO - Running pre-action listener: _resource_record_pre_action 05:55:16 INFO - Running main action method: run_tests 05:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:16 INFO - Python 2.7.3 05:55:16 INFO - Return code: 0 05:55:16 INFO - grabbing minidump binary from tooltool 05:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:16 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 0x1bb8410>, '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 0x1bb9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:16 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 05:55:16 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 05:55:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:16 INFO - Return code: 0 05:55:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:55:17 INFO - Return code: 0 05:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 05:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 05:55:17 INFO - Using env: {'DISPLAY': ':0', 05:55:17 INFO - 'HOME': '/home/cltbld', 05:55:17 INFO - 'LANG': 'en_US.UTF-8', 05:55:17 INFO - 'LANGUAGE': 'en_US:en', 05:55:17 INFO - 'LOGNAME': 'cltbld', 05:55:17 INFO - 'MAIL': '/var/mail/cltbld', 05:55:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:17 INFO - 'MOZ_NO_REMOTE': '1', 05:55:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:17 INFO - 'NO_EM_RESTART': '1', 05:55:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:17 INFO - 'PWD': '/builds/slave/test', 05:55:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:17 INFO - 'SHELL': '/bin/bash', 05:55:17 INFO - 'SHLVL': '1', 05:55:17 INFO - 'TERM': 'linux', 05:55:17 INFO - 'TMOUT': '86400', 05:55:17 INFO - 'USER': 'cltbld', 05:55:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511', 05:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:17 INFO - '_': '/tools/buildbot/bin/python'} 05:55:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 05:55:17 INFO - mozversion application_buildid: 20160618031522 05:55:17 INFO - mozversion application_changeset: cec857b11eaf51d6c04368f65fef17e017a0f96c 05:55:17 INFO - mozversion application_display_name: Firefox 05:55:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:17 INFO - mozversion application_name: Firefox 05:55:17 INFO - mozversion application_remotingname: firefox 05:55:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:55:17 INFO - mozversion application_vendor: Mozilla 05:55:17 INFO - mozversion application_version: 48.0 05:55:17 INFO - mozversion platform_buildid: 20160618031522 05:55:17 INFO - mozversion platform_changeset: cec857b11eaf51d6c04368f65fef17e017a0f96c 05:55:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:55:17 INFO - mozversion platform_version: 48.0 05:55:17 INFO - using testdate: 1466254517 05:55:17 INFO - actual date: 1466254517 05:55:17 INFO - starting webserver on 'localhost:35347' 05:55:17 INFO - SUITE-START | Running 2 tests 05:55:17 INFO - TEST-START | dromaeo_css 05:55:17 INFO - operating with platform_type : linux_ 05:55:17 INFO - Initialising browser for dromaeo_css test... 05:55:17 INFO - TEST-INFO | started process 16477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIHtLLv/profile http://localhost:35347/getInfo.html) 05:55:21 INFO - PROCESS | 16477 | __metrics Screen width/height:1600/1200 05:55:21 INFO - PROCESS | 16477 | colorDepth:24 05:55:21 INFO - PROCESS | 16477 | Browser inner width/height: 1024/697 05:55:21 INFO - PROCESS | 16477 | __metrics 05:55:23 ERROR - PROCESS | 16477 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:55:24 INFO - TEST-INFO | 16477: exit 0 05:55:24 INFO - Browser initialized. 05:55:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:24 INFO - TEST-INFO | started process 16568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIHtLLv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:36 INFO - PROCESS | 16568 | RSS: Main: 140550144 05:55:36 INFO - PROCESS | 16568 | 05:56:27 INFO - PROCESS | 16568 | 1466254587093 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] 05:58:34 INFO - PROCESS | 16568 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35347/tests/dromaeo/cssquery-ext.html) 05:58:35 INFO - PROCESS | 16568 | RSS: Main: 249610240 05:58:35 INFO - PROCESS | 16568 | 06:01:37 INFO - PROCESS | 16568 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-ext.html (next: http://localhost:35347/tests/dromaeo/cssquery-jquery.html) 06:01:38 INFO - PROCESS | 16568 | RSS: Main: 226496512 06:01:38 INFO - PROCESS | 16568 | 06:04:40 INFO - PROCESS | 16568 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35347/tests/dromaeo/cssquery-mootools.html) 06:04:40 INFO - PROCESS | 16568 | RSS: Main: 218984448 06:04:40 INFO - PROCESS | 16568 | 06:07:42 INFO - PROCESS | 16568 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35347/tests/dromaeo/cssquery-prototype.html) 06:07:43 INFO - PROCESS | 16568 | RSS: Main: 216522752 06:07:43 INFO - PROCESS | 16568 | 06:10:45 INFO - PROCESS | 16568 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35347/tests/dromaeo/cssquery-yui.html) 06:10:46 INFO - PROCESS | 16568 | RSS: Main: 183664640 06:10:46 INFO - PROCESS | 16568 | 06:13:48 INFO - PROCESS | 16568 | Cycle 1(1): loaded http://localhost:35347/tests/dromaeo/cssquery-yui.html (next: http://localhost:35347/tests/dromaeo/cssquery-dojo.html) 06:13:48 INFO - PROCESS | 16568 | RSS: Main: 241344512 06:13:48 INFO - PROCESS | 16568 | 06:13:48 INFO - PROCESS | 16568 | __start_tp_report 06:13:48 INFO - PROCESS | 16568 | _x_x_mozilla_page_load 06:13:48 INFO - PROCESS | 16568 | _x_x_mozilla_page_load_details 06:13:48 INFO - PROCESS | 16568 | |i|pagename|runs| 06:13:48 INFO - PROCESS | 16568 | |0;dojo.html;3307.1897385140646;3362.9663703362976;3368.124287685201;3395.3039626876493;3414.7097496712777;5610.663360198386;5646.915296270554;5647.43525647435;5680.431956804317;5686.658800471974;5549.889002219953;5635.774569017234;5639.210510528529;5640.717964101799;5660.9433905660935;4994.775235114428;5004.199328107504;5086.5676417504465;5150.0472412603785;5208.791648334081;5073.4926507349155;5093.134167191586;5093.847184584469;5097.9490205097845;5103.668261562986;5007.974960125194;5128.333316668828;5146.3824341078935;5160.277561141444;5179.482051794828;5171.534561889429;5189.7405129743365;5208.765605547722;5212;5246.842594722146;4965.577925876305;5015.749212539395;5075.187969924795;5100.311457953166;5107.106256405114;5454.945450545483;5502.449755024506;5521.779128834842;5524.419935906712;5536.723163841792;6006.309274433453;6019.789307374221;6020.879582408371;6028.909566356509;6035.939640603582;5999.790007349766;6047.274327080734;6072.262809999529;6081.273088945718;6117.418845209698;5611.663300202001;5662.858428539278;5675.148727690879;5680.772769089232;5682.857928551819;6049.243844519435;6133.233345831771;6141.6007959482495;6144.4469997699525;6156.846078848064;5823.82528524145;5909.025010873158;5926.851828704231;5939.376365481562;5956.195913551702;5968.1942937703725;5974.641521508724;5974.970125149346;5983.820485385445;5985.191999080069;5820.767169313265;5859.970700146558;5942.7920022799;5946.256717910262;5950.494207992369;5941.257342832146;5944.64332140073;5947.37552556984;5950.67271300074;5977.282726072899;4515.096980603892;4532.637389008872;4534.002519445717;4536.274196128604;4560.749158796298;4008.518977722692;4024.879253622396;4079.653229475528;4088.0801819590947;4117;5661.235733175969;5675.914861277084;5681.204631351614;5705.144228365695;5714.7428365723645;5967.16459695643;5985.820425387245;5993.31076926159;5995.5803093783015;6004.819855404345;5563.554915606742;5589.832305030855;5662.009148399014;5672.092465205547;5679.545636349082;5157.974210128926;5163.044836705221;5170.741462926914;5171.198464238049;5171.870703232449;6180.134781130645;6216.968915155395;6223.782167624111;6230.158928544679;6231.813045608639;5853.765849365977;5961.970190149022;5998.880022399615;6056.06131049688;6072.119542666377;6134.375358695336;6142.635597264296;6162.722677479434;6168.537359697951;6172.938270617236;5853.882922341614;5868.09044598088;5868.149118377897;5869.148973398748;5901.822945311647;5855.590108692521;5982.970085149546;6026.879462410815;6061.212042434456;6068.120122582112;5842.1820945068575;5862.970685146547;5863.20846685692;5868.061110222344;5871.882562348815;5669.858253543694;5808.6224395414165;5836.620619659709;5865.94134058654;5869.559783016205;5711.828645140652;5779.104238842986;5802.94197058024;5803.767849285981;5813.505852002627;5820.5925585210325;5843.503302219359;5856.560757943086;5862.882742345215;5867.237259156283;5640.887182256414;5736.5410767139365;5764.596478246483;5766.855828604151;5834.416558344132 06:13:48 INFO - PROCESS | 16568 | |1;ext.html;661.2593894837779;671.7279501801769;672.5661948043515;725.836686745482;745.1282000059928;33311.167220819494;34172.658273417255;34173.31653366937;34194.65805341949;34197.48703769442;36601.63398366022;42024;42434.36348454776;42455.78772106135;42585;8779.868301975459;8967.192952634261;8970.596323165473;8977.236934860544;8982.281417486585;8354.289885359753;8956.19394254517;9091.454512729224;10815.134789216843;11096.33421994683;10705.83941240882;10739.194560407961;10788.190885683565;10792.460376981158;10815.67552973412;10478.266521343508;10505.9474702626;10546.736331591734;10548.47257637115;10552.736181595445;10814.405207713573;10879.673609791718;10938.507767150497;10979.505922233438;11016.779664406668;43005.35491967592;43241.13517729628;43540.3468947966;43555.78222108901;43591.782041089595;3897.7466464679705;3915.902102447433;3988.641022308006;4190.392393102983;4706.505816889212;33644;34008.14979625504;34020.829895850366;34376.140596485035;35341.29317413637;4334.934975975363;4406.515283318832;4425.645948324126;4461.821527138911;4543.1140927519145;323212;324228;324341;324888;325230;40791.18417631631;63380;63624.36375636277;64036.67981660062;64168.67915660392;38850.417243741365;38988.41517377242;39013.219735605126;39016.219675606895;39025.21949560993;16187.919060404858;16475.423360182576;16478.67042659164;16482.917585412237;16490.58773530671;12696.6825829355;12929.418176182095;13570.525031623845;13607.863921360859;13700.93149534246;9547.379420337656;9809.656662016796;9840.163586095263;9852.507374631383;9857.901420985841;3635.5092062571744;3734.231115936465;3762.285165818486;3777.6033516480375;3813.7139714521522;1147.4434899073942;1186.507599346279;1204.1330242225583;1208.5045131496045;1291.9031072669588;34424.48363274553;34436.48345274823;34566.65433345685;34802.651973480446;35403.82298088493;1209.3529961470572;1251.8184863194967;1265.6139877337316;1302.3683513495946;1331.966700832487;15690.921545392428;16333.83666163347;16545.751813722803;16784.496465106065;16871.57821054459;522961;529153;529813;530284;530497;60466;61276.69361653163;61319.6934015336;61538.69230653818;61794.69102654548;1400.5098215624653;1449.9347529360994;1459.664277216225;1473.911565306085;1556.564162034632;32589;33583.66416335805;34552;36836.447453287685;37008;53349.19976200438;53905.46094539161;54236;54267.72866135644;56808.43191568197;467010;467496;467612;468951;470100;27653.723462765116;30586;30920.381592368478;31030.0690979271;31402.52896206513;47530;48393.27410088922;48549.27176092291;49270.50729492659;49733.50266497434;40073.59926400699;40716;40786.59213407947;40933.1813363737;41907.580924191585;40409.797951010056;41053.178936421704;41327.58672413237;41685.37471937984;41932.79033604812;40955.59044409518;41501.96245093897;41999.7900010498;42702.57297426986;42824.143517130105;35316;36121.47362428215;36794;36806.63193368032;36828;28354;28426.28934276577;28595.714042859305;28645.713542864305;28699.42601148007 06:13:48 INFO - PROCESS | 16568 | |2;jquery.html;436.51546783070785;439.8856297362687;440.6496835016162;442.70950180224645;451.8395969430854;19341.323053693122;19587.706184407227;19929.10319035645;21177.364679059614;21187;20986;21082.789172108274;21088.261910833124;21274.680879786814;21359.57280854386;5791.768329266834;6012.18835457212;6048.727807248684;6057.909131363033;6060.727267272983;4610.492845786977;5963.940360596382;6057.757689692407;6459.41865232129;6787.830304242409;6744.359285867835;6764.255931847493;6770.593764374129;6771;6779.35596118368;6443.194600674916;6623.205215374186;6624;6624.039514270428;6631.701573429207;4155.8753237402925;4324.632406245441;5665.943340566583;5903.203067585864;5911.172435858984;22792.08831646749;23133.30600082;23141.305760827203;23202.65196022061;23362.64956025661;2411.2043025801618;2473.319837044809;2478.5910324796387;2570.4216551276;2874.8850045998133;14476.638084047878;15042.172680502568;15231.390744370212;15279.465218717403;15365.385384584602;2075.6990236415786;2084.176750183669;2085.780992995744;2086.1968142265187;2147.95704085919;79683;81653;82610.17389826085;82978.58510707408;83015.5849220756;11121.721956951142;11202.21584489078;11316.830247546293;11420;11684.415779211005;15920.920395398181;16111.677766444605;16112.436064737678;16114.67770644604;16149.677006459806;8663.91336086631;8820.911790882137;8845.690400836069;8935.687250946316;8999.730008099768;8475.321974242046;8510.574471276412;8526.74419767408;8653.091425400367;8661.523616201044;6981.5461994970165;7046.541974771623;7113.253108423644;7117.89323160153;7132.536385135053;1800.5066064215694;1928.758905136858;2023.1199428248758;2069.9482512937298;2071.8964051797348;1079.5735684404617;1136.9880806082592;1171.4084387384316;1180.073642190876;1252.5866464066837;19828.306009289605;19959.20163193456;20119.698204526943;20138.69791953122;20814.167433302802;1114.9275297105823;1136.2046567402851;1141.668916014363;1178.4780569581103;1205.5659962413524;11631.185816992729;11761.588344407905;11789.115816313812;11860.347680877461;11895.345755983504;393069;399527;401172;508670;520362;80346.59826700829;83783.5810820942;89551;89915;97047.51476242574;1045.7960697663882;1077.4128100185417;1143.9199256052163;1147.0422197465043;1153.2273376837538;17867.28530858751;17947.371841985467;18076.367327143485;18145.27418903229;18354.632907342046;26580.202593922215;27059.323516912234;39171.80414097911;42191.36712949247;43233.70298891038;59579.40420595912;60161;60211.09683354841;60435;61266;9236.214921731727;9291.442513449214;9314.48770317639;9525.333226674065;9571.994940531144;11678.766424671288;13299.468021279428;13653.931730341683;13748.381322840296;13794.793078104038;11623.709407264549;12320.383980801103;12400.13199076056;12419.130660853654;12422.875771242172;11530.57857849861;11784;11834.704132396759;12188.817167742314;12446.564370246997;12061.698457538632;12237.265764054186;12539.561115361283;12548.560800371943;12609.810852837032;9024.639014439348;9153.450792952444;9170.908290917272;9273.397229180082;9340.019297973886;12231.266124032587;12358.44387002569;12378.566750163702;12410.193337433038;12422.689432764253 06:13:48 INFO - PROCESS | 16568 | |3;mootools.html;1388.9930550347246;1617.6198593330569;1620.4976457298235;1885.145749694536;1975.5357490989616;8525.019622743386;8744.43161194522;8745.431546949443;8746.431481953668;8751.737447876565;8570.314374850013;8742.650293988232;8752.387332886701;8772.69295574655;8776.122387761221;2424.0425032112307;2440.2679196241147;2457.987710061447;2458.6312053191987;2458.754124587545;2421.58167623512;2510.083819405922;2528.3931856354525;2533.733957934418;2534.721180670125;2473.7155227148837;2494.713107992577;2513.3088400689776;2532.7720505154534;2536.365908522869;2458.60662294033;2477.3930387055198;2484.813638977084;2490.8505489670497;2505.0981646607206;2465.0386349323776;2481.5161043596504;2501.6622755927897;2507.2102287779476;2512.6105453654714;8538.530380829052;8778.078301778285;8821.60302786376;8890.377673562853;8905.109489051109;5526.806561770319;5645.661260324394;5647.632903861236;5653.689047102408;5659.688717120557;3626.2747450510005;3638.163222458823;3663.6519530644546;3740.756850804689;3757.079515518688;1158.2124155574206;1162.639581729658;1169.6783384569226;1197.67662731063;1230.0774419185611;12262.570810021607;12762.936185319108;12778.041646876429;12781.744365112645;12787.5524356648;4541.772911354419;4665.090307390026;4782.115308667908;4789.209780386267;4809.350737650442;10025.849612255823;10044.748881278027;10049.24630652704;10071.446070466194;10072.992700729868;5518.19986102021;5543.722813859291;5551.2228288039705;5551.805686800943;5553.0004599172535;4375.16871794358;4983.875403114951;5091.796328146833;5133.178691409356;5133.307003554472;3984.30274701926;4004.2191772604065;4064.4106604542176;4090.652294554996;4121.773302468333;1208.4803534480081;1258.4337048328289;1261.2873726344585;1261.7224210673821;1277.3996221775935;920.6547544670749;1062.8193207154802;1076.2896488317829;1093.868735751715;1100.6422912553453;6128.1114238435175;6278.465352708557;6348.460380867678;6422.903656445157;6488.221413430419;479.74813223058175;484.94665586785425;487.0867124142233;491.7713263332496;492.0626207075527;4149.979250103791;4154.189932963043;4154.729942553724;4156.355764856452;4170.979145104255;10770.138388928866;11217.943910280397;11219.32684038944;11226.66320010401;11227.550897964153;10174.440405777754;11081.667549973514;11081.667549973514;11103.555857765761;11115.610953616584;8385.664573416994;8417.873731894026;8445.155484451629;8514.361422893184;8519.57402129891;6035.336113027652;6098.298695650057;6105.389461053859;6123.632582045091;6229;9467.289953253672;9474.38416502925;9610.327277090537;9782.608695652094;9788.119069283799;9943.950280248553;10113.544890480092;10228.130608898327;10240.283180177315;10425.218108642033;7929.088154862034;7934.365250780039;7979.72070977513;7983.560904150095;8035.598220089089;8624.223819855992;8663.26362259215;8704.78238044054;8706.782330441789;8719.258862996716;7703.730369437043;7715.729949451742;7753.224677532202;7825.569593672402;8094.797630059295;7621.31408173267;7653.923460765321;7676.923230767621;7732.806679833049;7919.920800791919;6997.090378250795;7012;7032.613206273704;7041.5422997505;7045.260247674126;5077.31456253401;5138.820141295187;5207.609429292743;5273.6572122811895;5285.365756109291;5276.81531146408;5303.602229832701;5315.3090098286975;5316.069687804541;5334.3865455473115 06:13:48 INFO - PROCESS | 16568 | |4;prototype.html;358.8959201831469;360.98917032489015;368.1459015085004;371.2315506900717;374.998125009375;6245.375462453752;6291.496680265579;6302.527310451717;6306.6846657667165;6324.968375158123;6087.878242435148;6198.256209254884;6257.155284036654;6268.686565671721;6277.5291853110975;4817.6627636065405;4884.780184891689;4893.804247830082;4913.189323761575;4916.139675556781;4917.434495033063;4931.975340123312;4950.455449900508;4956.2070068789;4964.801407943678;4675.766211689419;4745.976270118645;4913.533214344631;4926.45808961014;4937.950620493785;4842.685225460352;4867.561919427251;4881.243407271843;4898.755062246873;4911.361523001987;4329.220740266751;4334.913301733947;4336.436263285784;4338;4345.608895199447;6134.171886795315;6146.231721034871;6159.23009623797;6161.815145545641;6166.599171053867;5739.741711622987;5740.885182296331;5747.827565173052;5750.65496070233;5754.510866576346;6557.540972131953;6755.695993680247;6768.69540870662;6774.153230846145;6793.830154246134;4665.573901571198;4703.741294228816;4713.363695901044;4713.6936099153445;4715.104130215248;6950.235474097845;6992.5105242633035;7028;7028.086348774677;7036.824079398005;4806.567408933143;4812.590929771009;4812.639052071108;4815.807367705323;4817.795551112222;4883.291922671193;4887.828925987574;4888.364512613409;4890.657653964259;4895.804167833318;5536.086545719912;5641.40765219646;5658.63218890779;5662.235598194274;5669.603127781016;6804.353586409283;6804.65976701163;6827.6244806536115;6840.521163518605;6848.760293389708;1670.4654510556504;1694.7034269002875;1702.1999660159704;1709.376077731619;1709.555515565937;1046.7487802927242;1099.4612639806437;1100.7138144082437;1102.1898904305328;1112.4382186995515;6341.936580634227;6380.808575742735;6383.872322553523;6390.648514331663;6474.255460622088;6925.480588955848;6973.198082220508;6998.755043573552;7003.684834182474;7013.298670133048;6463.15978922737;6465.612063276124;6465.77369792055;6467;6473.126127972758;3669.5963444021136;3712.276106159273;3748.793816340073;3751.8499260029294;3753.849846006129;7187.856242875113;7189.532680375759;7191.137063552407;7195.856082878313;7211.747588834365;7029.051078104492;7042.436605071582;7055.9294407056295;7069.328413800681;7071.328223818729;7181.281871812881;7186.6047367395295;7200.8919866201;7202.20775714671;7206.747763828241;6728.428083612947;6877.037214789833;6884.827879303058;6887.104676392037;6893.862122757617;6812.807758642317;6828.385445309946;6844;6846.110005699227;6848.14398200225;7158.319959603829;7191.7842464726145;7201.963990180016;7202.53183543068;7216.9278307216255;4788.449328327287;4791.448983366818;4798.088363211118;4801.231802911518;4805.063012712488;6858.279880612464;6865.897011544731;6882.69027893756;6893.276205998499;6898.8620227594165;6509.967450162909;6660.367265109807;6666.600003999775;6676.532642715158;6677.666116694243;6632.933670663231;6633.635150066792;6638.269790323157;6664.566803157779;6677.532572719863;6535.705893234911;6553.082568440327;6561.737530498726;6563.573367731082;6566.277709451861;6617.569857959217;6702.229243637044;6710.396064354231;6727.159105111861;6734.225564060196;6490.643014634241;6579.144711187707;6579.374959378852;6586.5389422739945;6587.736490540517 06:13:48 INFO - PROCESS | 16568 | |5;yui.html;906.5195446413401;912.3659056955416;914.7713071732067;917.5366439947825;920.6271460058674;14240.57278281652;14491.42034318626;14551.345189466472;14569.781453278196;14571.125732456047;14253.928730356334;15652.686946261096;15991.84008159918;16002.519924402286;16022.118783466905;779.3180966654178;912.3704643795793;913.4975763330175;917.8210249001447;930.8650245714367;933.3886304470583;938.0900526489329;939.8167357365317;939.8778158839341;941.8822647169104;969.8157350103493;972.8686627305294;974.9756256093583;976.599594166392;979.2949076664826;812.6749300279906;962.1629182611138;971.839646458337;974.2644303550844;978.041519311072;719.467593980456;724.2033762860812;724.4819953733106;724.5906063074347;725.5102805606194;15201.847981520154;15338.846611533854;15368.462103826312;15389.923050384788;15391.846081539154;14552.490662826856;14802.481913133097;14836.480723174636;14848.777268340984;14873.776893346609;12279.877201228051;12385.690357741129;12438.81341779874;12556.309402982832;12681;3972.304846651853;3976.8011599419915;4012.137390461065;4031.1534577738416;4068.0643452005907;57374;57537.42462575363;57565.42434575642;57566.42433575653;57959.71020144915;11094.889051109385;11500.079993600491;11515.481803318704;11728.120390970711;11747.823782643267;20687.793122068888;20785.89607051955;21360.252391166236;21419.143234270767;21452;8475.110113438;8511.787205319917;8525.616347264264;8748.737537873874;8791.428557143765;5032.421271553818;5084.059449001947;5093.643444958891;5096.566791822736;5123.923141152885;3748.756330838487;3778.0554861284677;3787.0910981364273;3787.886363409102;3807.5621303550447;656.3600489522677;662.7514681994252;677.5325025732229;679.8334408070054;680.7072958627739;759.4038679636459;759.946803723734;777.2577188784697;807.1807115777373;807.8101646113158;9598.712038638852;9703.466309353053;9800.55897484615;10319.535620896928;10500.107490863209;650.9707063182168;782.8825676148509;801.1747899663357;831.8419500295046;849.0575461238021;4611.492735799059;4644.117617652702;4679.27471241958;4737.265723812815;4815.686980346266;63429;64479.35520644827;64760.67619661872;64821.67589162024;65100.674496627216;57828;58813.705931470926;59705.40294596998;59868.40131598628;59870;50856;51061.744691276304;51571;51982;52356;9323.953380233326;9387.718368448957;9405.20055795265;9406.247500200105;9504.572294246915;39131.217375652894;39684.2063158741;40044;40753.796231018656;40807.59192408038;49202.50797491979;49387.50612493829;49842.25236621526;49944.50055499544;51371.2294315593;11439.714007149554;11583.305001699924;11661.591844285409;11663.825042624198;11873.465694043616;12773;13090.410931507915;13145.802812957621;13172.60482185536;13236.801447978096;12253.69365765863;12260.32568208757;12399.75200496003;12418.875811241773;12484.937575312066;12704.428300726675;12755.80866287025;12786.552470663853;12786.808197877226;12834.55079072228;12027.398630068637;12112.091593130373;12126.211796233569;12138.817917731065;12165.513379464723;10204.59181632756;10231.48842557884;10419.583216671248;10423.791524169626;10449.373037617766;10073.798524029331;10562.947185264025;10715.732106697395;10749.62376316825;10764.784704306026 06:13:48 INFO - PROCESS | 16568 | __end_tp_report 06:13:48 INFO - PROCESS | 16568 | __start_cc_report 06:13:48 INFO - PROCESS | 16568 | _x_x_mozilla_cycle_collect,837 06:13:48 INFO - PROCESS | 16568 | __end_cc_report 06:13:48 INFO - PROCESS | 16568 | __startTimestamp1466255628698__endTimestamp 06:13:48 INFO - PROCESS | 16568 | 06:13:48 INFO - PROCESS | 16568 | ------- Summary: start ------- 06:13:48 INFO - PROCESS | 16568 | Number of tests: 6 06:13:48 INFO - PROCESS | 16568 | 06:13:48 INFO - PROCESS | 16568 | [#0] dojo.html Cycles:165 Average:5566.74 Median:5802.94 stddev:616.84 (10.6%) stddev-sans-first:592.72 06:13:48 INFO - PROCESS | 16568 | Values: 3307.2 3363.0 3368.1 3395.3 3414.7 5610.7 5646.9 5647.4 5680.4 5686.7 5549.9 5635.8 5639.2 5640.7 5660.9 4994.8 5004.2 5086.6 5150.0 5208.8 5073.5 5093.1 5093.8 5097.9 5103.7 5008.0 5128.3 5146.4 5160.3 5179.5 5171.5 5189.7 5208.8 5212.0 5246.8 4965.6 5015.7 5075.2 5100.3 5107.1 5454.9 5502.4 5521.8 5524.4 5536.7 6006.3 6019.8 6020.9 6028.9 6035.9 5999.8 6047.3 6072.3 6081.3 6117.4 5611.7 5662.9 5675.1 5680.8 5682.9 6049.2 6133.2 6141.6 6144.4 6156.8 5823.8 5909.0 5926.9 5939.4 5956.2 5968.2 5974.6 5975.0 5983.8 5985.2 5820.8 5860.0 5942.8 5946.3 5950.5 5941.3 5944.6 5947.4 5950.7 5977.3 4515.1 4532.6 4534.0 4536.3 4560.7 4008.5 4024.9 4079.7 4088.1 4117.0 5661.2 5675.9 5681.2 5705.1 5714.7 5967.2 5985.8 5993.3 5995.6 6004.8 5563.6 5589.8 5662.0 5672.1 5679.5 5158.0 5163.0 5170.7 5171.2 5171.9 6180.1 6217.0 6223.8 6230.2 6231.8 5853.8 5962.0 5998.9 6056.1 6072.1 6134.4 6142.6 6162.7 6168.5 6172.9 5853.9 5868.1 5868.1 5869.1 5901.8 5855.6 5983.0 6026.9 6061.2 6068.1 5842.2 5863.0 5863.2 5868.1 5871.9 5669.9 5808.6 5836.6 5865.9 5869.6 5711.8 5779.1 5802.9 5803.8 5813.5 5820.6 5843.5 5856.6 5862.9 5867.2 5640.9 5736.5 5764.6 5766.9 5834.4 06:13:48 INFO - PROCESS | 16568 | 06:13:48 INFO - PROCESS | 16568 | [#1] ext.html Cycles:180 Average:59707.98 Median:3769.94 stddev:119078.85 (3158.6%) stddev-sans-first:119330.38 06:13:48 INFO - PROCESS | 16568 | Values: 661.3 671.7 672.6 725.8 745.1 33311.2 34172.7 34173.3 34194.7 34197.5 36601.6 42024.0 42434.4 42455.8 42585.0 8779.9 8967.2 8970.6 8977.2 8982.3 8354.3 8956.2 9091.5 10815.1 11096.3 10705.8 10739.2 10788.2 10792.5 10815.7 10478.3 10505.9 10546.7 10548.5 10552.7 10814.4 10879.7 10938.5 10979.5 11016.8 43005.4 43241.1 43540.3 43555.8 43591.8 3897.7 3915.9 3988.6 4190.4 4706.5 33644.0 34008.1 34020.8 34376.1 35341.3 4334.9 4406.5 4425.6 4461.8 4543.1 323212.0 324228.0 324341.0 324888.0 325230.0 40791.2 63380.0 63624.4 64036.7 64168.7 38850.4 38988.4 39013.2 39016.2 39025.2 16187.9 16475.4 16478.7 16482.9 16490.6 12696.7 12929.4 13570.5 13607.9 13700.9 9547.4 9809.7 9840.2 9852.5 9857.9 3635.5 3734.2 3762.3 3777.6 3813.7 1147.4 1186.5 1204.1 1208.5 1291.9 34424.5 34436.5 34566.7 34802.7 35403.8 1209.4 1251.8 1265.6 1302.4 1332.0 15690.9 16333.8 16545.8 16784.5 16871.6 522961.0 529153.0 529813.0 530284.0 530497.0 60466.0 61276.7 61319.7 61538.7 61794.7 1400.5 1449.9 1459.7 1473.9 1556.6 32589.0 33583.7 34552.0 36836.4 37008.0 53349.2 53905.5 54236.0 54267.7 56808.4 467010.0 467496.0 467612.0 468951.0 470100.0 27653.7 30586.0 30920.4 31030.1 31402.5 47530.0 48393.3 48549.3 49270.5 49733.5 40073.6 40716.0 40786.6 40933.2 41907.6 40409.8 41053.2 41327.6 41685.4 41932.8 40955.6 41502.0 41999.8 42702.6 42824.1 35316.0 36121.5 36794.0 36806.6 36828.0 28354.0 28426.3 28595.7 28645.7 28699.4 06:13:48 INFO - PROCESS | 16568 | 06:13:48 INFO - PROCESS | 16568 | [#2] jquery.html Cycles:180 Average:28167.41 Median:22962.70 stddev:74007.58 (322.3%) stddev-sans-first:74185.90 06:13:48 INFO - PROCESS | 16568 | Values: 436.5 439.9 440.6 442.7 451.8 19341.3 19587.7 19929.1 21177.4 21187.0 20986.0 21082.8 21088.3 21274.7 21359.6 5791.8 6012.2 6048.7 6057.9 6060.7 4610.5 5963.9 6057.8 6459.4 6787.8 6744.4 6764.3 6770.6 6771.0 6779.4 6443.2 6623.2 6624.0 6624.0 6631.7 4155.9 4324.6 5665.9 5903.2 5911.2 22792.1 23133.3 23141.3 23202.7 23362.6 2411.2 2473.3 2478.6 2570.4 2874.9 14476.6 15042.2 15231.4 15279.5 15365.4 2075.7 2084.2 2085.8 2086.2 2148.0 79683.0 81653.0 82610.2 82978.6 83015.6 11121.7 11202.2 11316.8 11420.0 11684.4 15920.9 16111.7 16112.4 16114.7 16149.7 8663.9 8820.9 8845.7 8935.7 8999.7 8475.3 8510.6 8526.7 8653.1 8661.5 6981.5 7046.5 7113.3 7117.9 7132.5 1800.5 1928.8 2023.1 2069.9 2071.9 1079.6 1137.0 1171.4 1180.1 1252.6 19828.3 19959.2 20119.7 20138.7 20814.2 1114.9 1136.2 1141.7 1178.5 1205.6 11631.2 11761.6 11789.1 11860.3 11895.3 393069.0 399527.0 401172.0 508670.0 520362.0 80346.6 83783.6 89551.0 89915.0 97047.5 1045.8 1077.4 1143.9 1147.0 1153.2 17867.3 17947.4 18076.4 18145.3 18354.6 26580.2 27059.3 39171.8 42191.4 43233.7 59579.4 60161.0 60211.1 60435.0 61266.0 9236.2 9291.4 9314.5 9525.3 9572.0 11678.8 13299.5 13653.9 13748.4 13794.8 11623.7 12320.4 12400.1 12419.1 12422.9 11530.6 11784.0 11834.7 12188.8 12446.6 12061.7 12237.3 12539.6 12548.6 12609.8 9024.6 9153.5 9170.9 9273.4 9340.0 12231.3 12358.4 12378.6 12410.2 12422.7 06:13:48 INFO - PROCESS | 16568 | 06:13:48 INFO - PROCESS | 16568 | [#3] mootools.html Cycles:180 Average:5896.49 Median:486.02 stddev:3287.35 (676.4%) stddev-sans-first:3279.12 06:13:48 INFO - PROCESS | 16568 | Values: 1389.0 1617.6 1620.5 1885.1 1975.5 8525.0 8744.4 8745.4 8746.4 8751.7 8570.3 8742.7 8752.4 8772.7 8776.1 2424.0 2440.3 2458.0 2458.6 2458.8 2421.6 2510.1 2528.4 2533.7 2534.7 2473.7 2494.7 2513.3 2532.8 2536.4 2458.6 2477.4 2484.8 2490.9 2505.1 2465.0 2481.5 2501.7 2507.2 2512.6 8538.5 8778.1 8821.6 8890.4 8905.1 5526.8 5645.7 5647.6 5653.7 5659.7 3626.3 3638.2 3663.7 3740.8 3757.1 1158.2 1162.6 1169.7 1197.7 1230.1 12262.6 12762.9 12778.0 12781.7 12787.6 4541.8 4665.1 4782.1 4789.2 4809.4 10025.8 10044.7 10049.2 10071.4 10073.0 5518.2 5543.7 5551.2 5551.8 5553.0 4375.2 4983.9 5091.8 5133.2 5133.3 3984.3 4004.2 4064.4 4090.7 4121.8 1208.5 1258.4 1261.3 1261.7 1277.4 920.7 1062.8 1076.3 1093.9 1100.6 6128.1 6278.5 6348.5 6422.9 6488.2 479.7 484.9 487.1 491.8 492.1 4150.0 4154.2 4154.7 4156.4 4171.0 10770.1 11217.9 11219.3 11226.7 11227.6 10174.4 11081.7 11081.7 11103.6 11115.6 8385.7 8417.9 8445.2 8514.4 8519.6 6035.3 6098.3 6105.4 6123.6 6229.0 9467.3 9474.4 9610.3 9782.6 9788.1 9944.0 10113.5 10228.1 10240.3 10425.2 7929.1 7934.4 7979.7 7983.6 8035.6 8624.2 8663.3 8704.8 8706.8 8719.3 7703.7 7715.7 7753.2 7825.6 8094.8 7621.3 7653.9 7676.9 7732.8 7919.9 6997.1 7012.0 7032.6 7041.5 7045.3 5077.3 5138.8 5207.6 5273.7 5285.4 5276.8 5303.6 5315.3 5316.1 5334.4 06:13:48 INFO - PROCESS | 16568 | 06:13:48 INFO - PROCESS | 16568 | [#4] prototype.html Cycles:180 Average:5631.65 Median:6361.37 stddev:1684.83 (26.5%) stddev-sans-first:1642.42 06:13:48 INFO - PROCESS | 16568 | Values: 358.9 361.0 368.1 371.2 375.0 6245.4 6291.5 6302.5 6306.7 6325.0 6087.9 6198.3 6257.2 6268.7 6277.5 4817.7 4884.8 4893.8 4913.2 4916.1 4917.4 4932.0 4950.5 4956.2 4964.8 4675.8 4746.0 4913.5 4926.5 4938.0 4842.7 4867.6 4881.2 4898.8 4911.4 4329.2 4334.9 4336.4 4338.0 4345.6 6134.2 6146.2 6159.2 6161.8 6166.6 5739.7 5740.9 5747.8 5750.7 5754.5 6557.5 6755.7 6768.7 6774.2 6793.8 4665.6 4703.7 4713.4 4713.7 4715.1 6950.2 6992.5 7028.0 7028.1 7036.8 4806.6 4812.6 4812.6 4815.8 4817.8 4883.3 4887.8 4888.4 4890.7 4895.8 5536.1 5641.4 5658.6 5662.2 5669.6 6804.4 6804.7 6827.6 6840.5 6848.8 1670.5 1694.7 1702.2 1709.4 1709.6 1046.7 1099.5 1100.7 1102.2 1112.4 6341.9 6380.8 6383.9 6390.6 6474.3 6925.5 6973.2 6998.8 7003.7 7013.3 6463.2 6465.6 6465.8 6467.0 6473.1 3669.6 3712.3 3748.8 3751.8 3753.8 7187.9 7189.5 7191.1 7195.9 7211.7 7029.1 7042.4 7055.9 7069.3 7071.3 7181.3 7186.6 7200.9 7202.2 7206.7 6728.4 6877.0 6884.8 6887.1 6893.9 6812.8 6828.4 6844.0 6846.1 6848.1 7158.3 7191.8 7202.0 7202.5 7216.9 4788.4 4791.4 4798.1 4801.2 4805.1 6858.3 6865.9 6882.7 6893.3 6898.9 6510.0 6660.4 6666.6 6676.5 6677.7 6632.9 6633.6 6638.3 6664.6 6677.5 6535.7 6553.1 6561.7 6563.6 6566.3 6617.6 6702.2 6710.4 6727.2 6734.2 6490.6 6579.1 6579.4 6586.5 6587.7 06:13:48 INFO - PROCESS | 16568 | 06:13:48 INFO - PROCESS | 16568 | [#5] yui.html Cycles:180 Average:15676.32 Median:4776.48 stddev:18217.55 (381.4%) stddev-sans-first:18234.89 06:13:48 INFO - PROCESS | 16568 | Values: 906.5 912.4 914.8 917.5 920.6 14240.6 14491.4 14551.3 14569.8 14571.1 14253.9 15652.7 15991.8 16002.5 16022.1 779.3 912.4 913.5 917.8 930.9 933.4 938.1 939.8 939.9 941.9 969.8 972.9 975.0 976.6 979.3 812.7 962.2 971.8 974.3 978.0 719.5 724.2 724.5 724.6 725.5 15201.8 15338.8 15368.5 15389.9 15391.8 14552.5 14802.5 14836.5 14848.8 14873.8 12279.9 12385.7 12438.8 12556.3 12681.0 3972.3 3976.8 4012.1 4031.2 4068.1 57374.0 57537.4 57565.4 57566.4 57959.7 11094.9 11500.1 11515.5 11728.1 11747.8 20687.8 20785.9 21360.3 21419.1 21452.0 8475.1 8511.8 8525.6 8748.7 8791.4 5032.4 5084.1 5093.6 5096.6 5123.9 3748.8 3778.1 3787.1 3787.9 3807.6 656.4 662.8 677.5 679.8 680.7 759.4 759.9 777.3 807.2 807.8 9598.7 9703.5 9800.6 10319.5 10500.1 651.0 782.9 801.2 831.8 849.1 4611.5 4644.1 4679.3 4737.3 4815.7 63429.0 64479.4 64760.7 64821.7 65100.7 57828.0 58813.7 59705.4 59868.4 59870.0 50856.0 51061.7 51571.0 51982.0 52356.0 9324.0 9387.7 9405.2 9406.2 9504.6 39131.2 39684.2 40044.0 40753.8 40807.6 49202.5 49387.5 49842.3 49944.5 51371.2 11439.7 11583.3 11661.6 11663.8 11873.5 12773.0 13090.4 13145.8 13172.6 13236.8 12253.7 12260.3 12399.8 12418.9 12484.9 12704.4 12755.8 12786.6 12786.8 12834.6 12027.4 12112.1 12126.2 12138.8 12165.5 10204.6 10231.5 10419.6 10423.8 10449.4 10073.8 10562.9 10715.7 10749.6 10764.8 06:13:48 INFO - PROCESS | 16568 | -------- Summary: end -------- 06:13:48 INFO - PROCESS | 16568 | 06:13:49 INFO - TEST-INFO | 16568: exit 0 06:13:49 INFO - TEST-OK | dromaeo_css | took 1111407ms 06:13:49 INFO - TEST-START | kraken 06:13:49 INFO - operating with platform_type : linux_ 06:13:49 INFO - Initialising browser for kraken test... 06:13:49 INFO - TEST-INFO | started process 16759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAvqrr/profile http://localhost:35347/getInfo.html) 06:13:53 INFO - PROCESS | 16759 | __metrics Screen width/height:1600/1200 06:13:53 INFO - PROCESS | 16759 | colorDepth:24 06:13:53 INFO - PROCESS | 16759 | Browser inner width/height: 1024/697 06:13:53 INFO - PROCESS | 16759 | __metrics 06:13:54 ERROR - PROCESS | 16759 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:13:55 INFO - TEST-INFO | 16759: exit 0 06:13:55 INFO - Browser initialized. 06:13:55 INFO - Running cycle 1/1 for kraken test... 06:13:55 INFO - TEST-INFO | started process 16854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxAvqrr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:06 INFO - PROCESS | 16854 | RSS: Main: 141332480 06:14:06 INFO - PROCESS | 16854 | 06:14:09 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35347/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:10 INFO - PROCESS | 16854 | RSS: Main: 197840896 06:14:10 INFO - PROCESS | 16854 | 06:14:12 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35347/tests/kraken/driver.html?testName=audio-dft) 06:14:13 INFO - PROCESS | 16854 | RSS: Main: 183873536 06:14:13 INFO - PROCESS | 16854 | 06:14:16 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35347/tests/kraken/driver.html?testName=audio-fft) 06:14:16 INFO - PROCESS | 16854 | RSS: Main: 272941056 06:14:16 INFO - PROCESS | 16854 | 06:14:18 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35347/tests/kraken/driver.html?testName=audio-oscillator) 06:14:19 INFO - PROCESS | 16854 | RSS: Main: 179621888 06:14:19 INFO - PROCESS | 16854 | 06:14:21 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:22 INFO - PROCESS | 16854 | RSS: Main: 177410048 06:14:22 INFO - PROCESS | 16854 | 06:14:25 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35347/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:25 INFO - PROCESS | 16854 | RSS: Main: 212774912 06:14:25 INFO - PROCESS | 16854 | 06:14:29 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35347/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:29 INFO - PROCESS | 16854 | RSS: Main: 212578304 06:14:29 INFO - PROCESS | 16854 | 06:14:32 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35347/tests/kraken/driver.html?testName=json-parse-financial) 06:14:33 INFO - PROCESS | 16854 | RSS: Main: 211406848 06:14:33 INFO - PROCESS | 16854 | 06:14:34 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:35 INFO - PROCESS | 16854 | RSS: Main: 190418944 06:14:35 INFO - PROCESS | 16854 | 06:14:36 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:37 INFO - PROCESS | 16854 | RSS: Main: 193900544 06:14:37 INFO - PROCESS | 16854 | 06:14:39 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:40 INFO - PROCESS | 16854 | RSS: Main: 210178048 06:14:40 INFO - PROCESS | 16854 | 06:14:42 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:43 INFO - PROCESS | 16854 | RSS: Main: 218501120 06:14:43 INFO - PROCESS | 16854 | 06:14:45 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:46 INFO - PROCESS | 16854 | RSS: Main: 214913024 06:14:46 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:35347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35347/tests/kraken/driver.html?testName=ai-astar) 06:14:48 INFO - PROCESS | 16854 | RSS: Main: 275517440 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | __start_tp_report 06:14:48 INFO - PROCESS | 16854 | _x_x_mozilla_page_load 06:14:48 INFO - PROCESS | 16854 | _x_x_mozilla_page_load_details 06:14:48 INFO - PROCESS | 16854 | |i|pagename|runs| 06:14:48 INFO - PROCESS | 16854 | |0;ai-astar;110;110;111;109;110;110;104;108;108;109 06:14:48 INFO - PROCESS | 16854 | |1;audio-beat-detection;155;126;158;182;128;152;162;127;180;126 06:14:48 INFO - PROCESS | 16854 | |2;audio-dft;160;161;161;161;160;159;160;161;162;160 06:14:48 INFO - PROCESS | 16854 | |3;audio-fft;76;76;75;165;73;76;76;82;162;77 06:14:48 INFO - PROCESS | 16854 | |4;audio-oscillator;91;92;146;91;92;92;147;91;91;148 06:14:48 INFO - PROCESS | 16854 | |5;imaging-gaussian-blur;116;117;117;124;116;116;116;117;117;116 06:14:48 INFO - PROCESS | 16854 | |6;imaging-darkroom;145;146;145;146;145;145;146;146;146;145 06:14:48 INFO - PROCESS | 16854 | |7;imaging-desaturate;94;95;95;95;95;94;94;94;95;94 06:14:48 INFO - PROCESS | 16854 | |8;json-parse-financial;55;56;55;56;57;56;59;74;55;55 06:14:48 INFO - PROCESS | 16854 | |9;json-stringify-tinderbox;58;57;59;58;58;57;57;58;58;59 06:14:48 INFO - PROCESS | 16854 | |10;stanford-crypto-aes;72;73;72;73;74;74;74;74;74;73 06:14:48 INFO - PROCESS | 16854 | |11;stanford-crypto-ccm;115;112;114;116;121;113;111;113;128;134 06:14:48 INFO - PROCESS | 16854 | |12;stanford-crypto-pbkdf2;160;167;164;160;162;159;167;160;159;166 06:14:48 INFO - PROCESS | 16854 | |13;stanford-crypto-sha256-iterative;66;68;66;66;66;67;66;65;66;66 06:14:48 INFO - PROCESS | 16854 | __end_tp_report 06:14:48 INFO - PROCESS | 16854 | __start_cc_report 06:14:48 INFO - PROCESS | 16854 | _x_x_mozilla_cycle_collect,1600 06:14:48 INFO - PROCESS | 16854 | __end_cc_report 06:14:48 INFO - PROCESS | 16854 | __startTimestamp1466255688330__endTimestamp 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | ------- Summary: start ------- 06:14:48 INFO - PROCESS | 16854 | Number of tests: 14 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:1.97 (1.8%) stddev-sans-first:2.05 06:14:48 INFO - PROCESS | 16854 | Values: 110.0 110.0 111.0 109.0 110.0 110.0 104.0 108.0 108.0 109.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.50 stddev:21.92 (14.0%) stddev-sans-first:23.16 06:14:48 INFO - PROCESS | 16854 | Values: 155.0 126.0 158.0 182.0 128.0 152.0 162.0 127.0 180.0 126.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 06:14:48 INFO - PROCESS | 16854 | Values: 160.0 161.0 161.0 161.0 160.0 159.0 160.0 161.0 162.0 160.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:36.81 (48.4%) stddev-sans-first:38.48 06:14:48 INFO - PROCESS | 16854 | Values: 76.0 76.0 75.0 165.0 73.0 76.0 76.0 82.0 162.0 77.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:91.00 stddev:26.85 (29.5%) stddev-sans-first:27.76 06:14:48 INFO - PROCESS | 16854 | Values: 91.0 92.0 146.0 91.0 92.0 92.0 147.0 91.0 91.0 148.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:2.44 (2.1%) stddev-sans-first:2.55 06:14:48 INFO - PROCESS | 16854 | Values: 116.0 117.0 117.0 124.0 116.0 116.0 116.0 117.0 117.0 116.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:14:48 INFO - PROCESS | 16854 | Values: 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 06:14:48 INFO - PROCESS | 16854 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:56.00 stddev:5.83 (10.4%) stddev-sans-first:6.09 06:14:48 INFO - PROCESS | 16854 | Values: 55.0 56.0 55.0 56.0 57.0 56.0 59.0 74.0 55.0 55.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 06:14:48 INFO - PROCESS | 16854 | Values: 58.0 57.0 59.0 58.0 58.0 57.0 57.0 58.0 58.0 59.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.73 06:14:48 INFO - PROCESS | 16854 | Values: 72.0 73.0 72.0 73.0 74.0 74.0 74.0 74.0 74.0 73.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:115.50 stddev:7.66 (6.6%) stddev-sans-first:8.06 06:14:48 INFO - PROCESS | 16854 | Values: 115.0 112.0 114.0 116.0 121.0 113.0 111.0 113.0 128.0 134.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:3.31 (2.0%) stddev-sans-first:3.39 06:14:48 INFO - PROCESS | 16854 | Values: 160.0 167.0 164.0 160.0 162.0 159.0 167.0 160.0 159.0 166.0 06:14:48 INFO - PROCESS | 16854 | 06:14:48 INFO - PROCESS | 16854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 06:14:48 INFO - PROCESS | 16854 | Values: 66.0 68.0 66.0 66.0 66.0 67.0 66.0 65.0 66.0 66.0 06:14:48 INFO - PROCESS | 16854 | -------- Summary: end -------- 06:14:48 INFO - PROCESS | 16854 | 06:14:49 INFO - TEST-INFO | 16854: exit 0 06:14:49 INFO - TEST-OK | kraken | took 59912ms 06:14:49 INFO - SUITE-END | took 1171s 06:14:49 INFO - Completed test suite (00:19:31) 06:14:49 INFO - javascript benchmark 06:14:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.1897385140646, 3362.9663703362976, 3368.124287685201, 3395.3039626876493, 3414.7097496712777, 5610.663360198386, 5646.915296270554, 5647.43525647435, 5680.431956804317, 5686.658800471974, 5549.889002219953, 5635.774569017234, 5639.210510528529, 5640.717964101799, 5660.9433905660935, 4994.775235114428, 5004.199328107504, 5086.5676417504465, 5150.0472412603785, 5208.791648334081, 5073.4926507349155, 5093.134167191586, 5093.847184584469, 5097.9490205097845, 5103.668261562986, 5007.974960125194, 5128.333316668828, 5146.3824341078935, 5160.277561141444, 5179.482051794828, 5171.534561889429, 5189.7405129743365, 5208.765605547722, 5212.0, 5246.842594722146, 4965.577925876305, 5015.749212539395, 5075.187969924795, 5100.311457953166, 5107.106256405114, 5454.945450545483, 5502.449755024506, 5521.779128834842, 5524.419935906712, 5536.723163841792, 6006.309274433453, 6019.789307374221, 6020.879582408371, 6028.909566356509, 6035.939640603582, 5999.790007349766, 6047.274327080734, 6072.262809999529, 6081.273088945718, 6117.418845209698, 5611.663300202001, 5662.858428539278, 5675.148727690879, 5680.772769089232, 5682.857928551819, 6049.243844519435, 6133.233345831771, 6141.6007959482495, 6144.4469997699525, 6156.846078848064, 5823.82528524145, 5909.025010873158, 5926.851828704231, 5939.376365481562, 5956.195913551702, 5968.1942937703725, 5974.641521508724, 5974.970125149346, 5983.820485385445, 5985.191999080069, 5820.767169313265, 5859.970700146558, 5942.7920022799, 5946.256717910262, 5950.494207992369, 5941.257342832146, 5944.64332140073, 5947.37552556984, 5950.67271300074, 5977.282726072899, 4515.096980603892, 4532.637389008872, 4534.002519445717, 4536.274196128604, 4560.749158796298, 4008.518977722692, 4024.879253622396, 4079.653229475528, 4088.0801819590947, 4117.0, 5661.235733175969, 5675.914861277084, 5681.204631351614, 5705.144228365695, 5714.7428365723645, 5967.16459695643, 5985.820425387245, 5993.31076926159, 5995.5803093783015, 6004.819855404345, 5563.554915606742, 5589.832305030855, 5662.009148399014, 5672.092465205547, 5679.545636349082, 5157.974210128926, 5163.044836705221, 5170.741462926914, 5171.198464238049, 5171.870703232449, 6180.134781130645, 6216.968915155395, 6223.782167624111, 6230.158928544679, 6231.813045608639, 5853.765849365977, 5961.970190149022, 5998.880022399615, 6056.06131049688, 6072.119542666377, 6134.375358695336, 6142.635597264296, 6162.722677479434, 6168.537359697951, 6172.938270617236, 5853.882922341614, 5868.09044598088, 5868.149118377897, 5869.148973398748, 5901.822945311647, 5855.590108692521, 5982.970085149546, 6026.879462410815, 6061.212042434456, 6068.120122582112, 5842.1820945068575, 5862.970685146547, 5863.20846685692, 5868.061110222344, 5871.882562348815, 5669.858253543694, 5808.6224395414165, 5836.620619659709, 5865.94134058654, 5869.559783016205, 5711.828645140652, 5779.104238842986, 5802.94197058024, 5803.767849285981, 5813.505852002627, 5820.5925585210325, 5843.503302219359, 5856.560757943086, 5862.882742345215, 5867.237259156283, 5640.887182256414, 5736.5410767139365, 5764.596478246483, 5766.855828604151, 5834.416558344132], "value": 5526.545748411162, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.2593894837779, 671.7279501801769, 672.5661948043515, 725.836686745482, 745.1282000059928, 33311.167220819494, 34172.658273417255, 34173.31653366937, 34194.65805341949, 34197.48703769442, 36601.63398366022, 42024.0, 42434.36348454776, 42455.78772106135, 42585.0, 8779.868301975459, 8967.192952634261, 8970.596323165473, 8977.236934860544, 8982.281417486585, 8354.289885359753, 8956.19394254517, 9091.454512729224, 10815.134789216843, 11096.33421994683, 10705.83941240882, 10739.194560407961, 10788.190885683565, 10792.460376981158, 10815.67552973412, 10478.266521343508, 10505.9474702626, 10546.736331591734, 10548.47257637115, 10552.736181595445, 10814.405207713573, 10879.673609791718, 10938.507767150497, 10979.505922233438, 11016.779664406668, 43005.35491967592, 43241.13517729628, 43540.3468947966, 43555.78222108901, 43591.782041089595, 3897.7466464679705, 3915.902102447433, 3988.641022308006, 4190.392393102983, 4706.505816889212, 33644.0, 34008.14979625504, 34020.829895850366, 34376.140596485035, 35341.29317413637, 4334.934975975363, 4406.515283318832, 4425.645948324126, 4461.821527138911, 4543.1140927519145, 323212.0, 324228.0, 324341.0, 324888.0, 325230.0, 40791.18417631631, 63380.0, 63624.36375636277, 64036.67981660062, 64168.67915660392, 38850.417243741365, 38988.41517377242, 39013.219735605126, 39016.219675606895, 39025.21949560993, 16187.919060404858, 16475.423360182576, 16478.67042659164, 16482.917585412237, 16490.58773530671, 12696.6825829355, 12929.418176182095, 13570.525031623845, 13607.863921360859, 13700.93149534246, 9547.379420337656, 9809.656662016796, 9840.163586095263, 9852.507374631383, 9857.901420985841, 3635.5092062571744, 3734.231115936465, 3762.285165818486, 3777.6033516480375, 3813.7139714521522, 1147.4434899073942, 1186.507599346279, 1204.1330242225583, 1208.5045131496045, 1291.9031072669588, 34424.48363274553, 34436.48345274823, 34566.65433345685, 34802.651973480446, 35403.82298088493, 1209.3529961470572, 1251.8184863194967, 1265.6139877337316, 1302.3683513495946, 1331.966700832487, 15690.921545392428, 16333.83666163347, 16545.751813722803, 16784.496465106065, 16871.57821054459, 522961.0, 529153.0, 529813.0, 530284.0, 530497.0, 60466.0, 61276.69361653163, 61319.6934015336, 61538.69230653818, 61794.69102654548, 1400.5098215624653, 1449.9347529360994, 1459.664277216225, 1473.911565306085, 1556.564162034632, 32589.0, 33583.66416335805, 34552.0, 36836.447453287685, 37008.0, 53349.19976200438, 53905.46094539161, 54236.0, 54267.72866135644, 56808.43191568197, 467010.0, 467496.0, 467612.0, 468951.0, 470100.0, 27653.723462765116, 30586.0, 30920.381592368478, 31030.0690979271, 31402.52896206513, 47530.0, 48393.27410088922, 48549.27176092291, 49270.50729492659, 49733.50266497434, 40073.59926400699, 40716.0, 40786.59213407947, 40933.1813363737, 41907.580924191585, 40409.797951010056, 41053.178936421704, 41327.58672413237, 41685.37471937984, 41932.79033604812, 40955.59044409518, 41501.96245093897, 41999.7900010498, 42702.57297426986, 42824.143517130105, 35316.0, 36121.47362428215, 36794.0, 36806.63193368032, 36828.0, 28354.0, 28426.28934276577, 28595.714042859305, 28645.713542864305, 28699.42601148007], "value": 20003.21847164958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.51546783070785, 439.8856297362687, 440.6496835016162, 442.70950180224645, 451.8395969430854, 19341.323053693122, 19587.706184407227, 19929.10319035645, 21177.364679059614, 21187.0, 20986.0, 21082.789172108274, 21088.261910833124, 21274.680879786814, 21359.57280854386, 5791.768329266834, 6012.18835457212, 6048.727807248684, 6057.909131363033, 6060.727267272983, 4610.492845786977, 5963.940360596382, 6057.757689692407, 6459.41865232129, 6787.830304242409, 6744.359285867835, 6764.255931847493, 6770.593764374129, 6771.0, 6779.35596118368, 6443.194600674916, 6623.205215374186, 6624.0, 6624.039514270428, 6631.701573429207, 4155.8753237402925, 4324.632406245441, 5665.943340566583, 5903.203067585864, 5911.172435858984, 22792.08831646749, 23133.30600082, 23141.305760827203, 23202.65196022061, 23362.64956025661, 2411.2043025801618, 2473.319837044809, 2478.5910324796387, 2570.4216551276, 2874.8850045998133, 14476.638084047878, 15042.172680502568, 15231.390744370212, 15279.465218717403, 15365.385384584602, 2075.6990236415786, 2084.176750183669, 2085.780992995744, 2086.1968142265187, 2147.95704085919, 79683.0, 81653.0, 82610.17389826085, 82978.58510707408, 83015.5849220756, 11121.721956951142, 11202.21584489078, 11316.830247546293, 11420.0, 11684.415779211005, 15920.920395398181, 16111.677766444605, 16112.436064737678, 16114.67770644604, 16149.677006459806, 8663.91336086631, 8820.911790882137, 8845.690400836069, 8935.687250946316, 8999.730008099768, 8475.321974242046, 8510.574471276412, 8526.74419767408, 8653.091425400367, 8661.523616201044, 6981.5461994970165, 7046.541974771623, 7113.253108423644, 7117.89323160153, 7132.536385135053, 1800.5066064215694, 1928.758905136858, 2023.1199428248758, 2069.9482512937298, 2071.8964051797348, 1079.5735684404617, 1136.9880806082592, 1171.4084387384316, 1180.073642190876, 1252.5866464066837, 19828.306009289605, 19959.20163193456, 20119.698204526943, 20138.69791953122, 20814.167433302802, 1114.9275297105823, 1136.2046567402851, 1141.668916014363, 1178.4780569581103, 1205.5659962413524, 11631.185816992729, 11761.588344407905, 11789.115816313812, 11860.347680877461, 11895.345755983504, 393069.0, 399527.0, 401172.0, 508670.0, 520362.0, 80346.59826700829, 83783.5810820942, 89551.0, 89915.0, 97047.51476242574, 1045.7960697663882, 1077.4128100185417, 1143.9199256052163, 1147.0422197465043, 1153.2273376837538, 17867.28530858751, 17947.371841985467, 18076.367327143485, 18145.27418903229, 18354.632907342046, 26580.202593922215, 27059.323516912234, 39171.80414097911, 42191.36712949247, 43233.70298891038, 59579.40420595912, 60161.0, 60211.09683354841, 60435.0, 61266.0, 9236.214921731727, 9291.442513449214, 9314.48770317639, 9525.333226674065, 9571.994940531144, 11678.766424671288, 13299.468021279428, 13653.931730341683, 13748.381322840296, 13794.793078104038, 11623.709407264549, 12320.383980801103, 12400.13199076056, 12419.130660853654, 12422.875771242172, 11530.57857849861, 11784.0, 11834.704132396759, 12188.817167742314, 12446.564370246997, 12061.698457538632, 12237.265764054186, 12539.561115361283, 12548.560800371943, 12609.810852837032, 9024.639014439348, 9153.450792952444, 9170.908290917272, 9273.397229180082, 9340.019297973886, 12231.266124032587, 12358.44387002569, 12378.566750163702, 12410.193337433038, 12422.689432764253], "value": 9882.23678424617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.9930550347246, 1617.6198593330569, 1620.4976457298235, 1885.145749694536, 1975.5357490989616, 8525.019622743386, 8744.43161194522, 8745.431546949443, 8746.431481953668, 8751.737447876565, 8570.314374850013, 8742.650293988232, 8752.387332886701, 8772.69295574655, 8776.122387761221, 2424.0425032112307, 2440.2679196241147, 2457.987710061447, 2458.6312053191987, 2458.754124587545, 2421.58167623512, 2510.083819405922, 2528.3931856354525, 2533.733957934418, 2534.721180670125, 2473.7155227148837, 2494.713107992577, 2513.3088400689776, 2532.7720505154534, 2536.365908522869, 2458.60662294033, 2477.3930387055198, 2484.813638977084, 2490.8505489670497, 2505.0981646607206, 2465.0386349323776, 2481.5161043596504, 2501.6622755927897, 2507.2102287779476, 2512.6105453654714, 8538.530380829052, 8778.078301778285, 8821.60302786376, 8890.377673562853, 8905.109489051109, 5526.806561770319, 5645.661260324394, 5647.632903861236, 5653.689047102408, 5659.688717120557, 3626.2747450510005, 3638.163222458823, 3663.6519530644546, 3740.756850804689, 3757.079515518688, 1158.2124155574206, 1162.639581729658, 1169.6783384569226, 1197.67662731063, 1230.0774419185611, 12262.570810021607, 12762.936185319108, 12778.041646876429, 12781.744365112645, 12787.5524356648, 4541.772911354419, 4665.090307390026, 4782.115308667908, 4789.209780386267, 4809.350737650442, 10025.849612255823, 10044.748881278027, 10049.24630652704, 10071.446070466194, 10072.992700729868, 5518.19986102021, 5543.722813859291, 5551.2228288039705, 5551.805686800943, 5553.0004599172535, 4375.16871794358, 4983.875403114951, 5091.796328146833, 5133.178691409356, 5133.307003554472, 3984.30274701926, 4004.2191772604065, 4064.4106604542176, 4090.652294554996, 4121.773302468333, 1208.4803534480081, 1258.4337048328289, 1261.2873726344585, 1261.7224210673821, 1277.3996221775935, 920.6547544670749, 1062.8193207154802, 1076.2896488317829, 1093.868735751715, 1100.6422912553453, 6128.1114238435175, 6278.465352708557, 6348.460380867678, 6422.903656445157, 6488.221413430419, 479.74813223058175, 484.94665586785425, 487.0867124142233, 491.7713263332496, 492.0626207075527, 4149.979250103791, 4154.189932963043, 4154.729942553724, 4156.355764856452, 4170.979145104255, 10770.138388928866, 11217.943910280397, 11219.32684038944, 11226.66320010401, 11227.550897964153, 10174.440405777754, 11081.667549973514, 11081.667549973514, 11103.555857765761, 11115.610953616584, 8385.664573416994, 8417.873731894026, 8445.155484451629, 8514.361422893184, 8519.57402129891, 6035.336113027652, 6098.298695650057, 6105.389461053859, 6123.632582045091, 6229.0, 9467.289953253672, 9474.38416502925, 9610.327277090537, 9782.608695652094, 9788.119069283799, 9943.950280248553, 10113.544890480092, 10228.130608898327, 10240.283180177315, 10425.218108642033, 7929.088154862034, 7934.365250780039, 7979.72070977513, 7983.560904150095, 8035.598220089089, 8624.223819855992, 8663.26362259215, 8704.78238044054, 8706.782330441789, 8719.258862996716, 7703.730369437043, 7715.729949451742, 7753.224677532202, 7825.569593672402, 8094.797630059295, 7621.31408173267, 7653.923460765321, 7676.923230767621, 7732.806679833049, 7919.920800791919, 6997.090378250795, 7012.0, 7032.613206273704, 7041.5422997505, 7045.260247674126, 5077.31456253401, 5138.820141295187, 5207.609429292743, 5273.6572122811895, 5285.365756109291, 5276.81531146408, 5303.602229832701, 5315.3090098286975, 5316.069687804541, 5334.3865455473115], "value": 4693.9432407393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.8959201831469, 360.98917032489015, 368.1459015085004, 371.2315506900717, 374.998125009375, 6245.375462453752, 6291.496680265579, 6302.527310451717, 6306.6846657667165, 6324.968375158123, 6087.878242435148, 6198.256209254884, 6257.155284036654, 6268.686565671721, 6277.5291853110975, 4817.6627636065405, 4884.780184891689, 4893.804247830082, 4913.189323761575, 4916.139675556781, 4917.434495033063, 4931.975340123312, 4950.455449900508, 4956.2070068789, 4964.801407943678, 4675.766211689419, 4745.976270118645, 4913.533214344631, 4926.45808961014, 4937.950620493785, 4842.685225460352, 4867.561919427251, 4881.243407271843, 4898.755062246873, 4911.361523001987, 4329.220740266751, 4334.913301733947, 4336.436263285784, 4338.0, 4345.608895199447, 6134.171886795315, 6146.231721034871, 6159.23009623797, 6161.815145545641, 6166.599171053867, 5739.741711622987, 5740.885182296331, 5747.827565173052, 5750.65496070233, 5754.510866576346, 6557.540972131953, 6755.695993680247, 6768.69540870662, 6774.153230846145, 6793.830154246134, 4665.573901571198, 4703.741294228816, 4713.363695901044, 4713.6936099153445, 4715.104130215248, 6950.235474097845, 6992.5105242633035, 7028.0, 7028.086348774677, 7036.824079398005, 4806.567408933143, 4812.590929771009, 4812.639052071108, 4815.807367705323, 4817.795551112222, 4883.291922671193, 4887.828925987574, 4888.364512613409, 4890.657653964259, 4895.804167833318, 5536.086545719912, 5641.40765219646, 5658.63218890779, 5662.235598194274, 5669.603127781016, 6804.353586409283, 6804.65976701163, 6827.6244806536115, 6840.521163518605, 6848.760293389708, 1670.4654510556504, 1694.7034269002875, 1702.1999660159704, 1709.376077731619, 1709.555515565937, 1046.7487802927242, 1099.4612639806437, 1100.7138144082437, 1102.1898904305328, 1112.4382186995515, 6341.936580634227, 6380.808575742735, 6383.872322553523, 6390.648514331663, 6474.255460622088, 6925.480588955848, 6973.198082220508, 6998.755043573552, 7003.684834182474, 7013.298670133048, 6463.15978922737, 6465.612063276124, 6465.77369792055, 6467.0, 6473.126127972758, 3669.5963444021136, 3712.276106159273, 3748.793816340073, 3751.8499260029294, 3753.849846006129, 7187.856242875113, 7189.532680375759, 7191.137063552407, 7195.856082878313, 7211.747588834365, 7029.051078104492, 7042.436605071582, 7055.9294407056295, 7069.328413800681, 7071.328223818729, 7181.281871812881, 7186.6047367395295, 7200.8919866201, 7202.20775714671, 7206.747763828241, 6728.428083612947, 6877.037214789833, 6884.827879303058, 6887.104676392037, 6893.862122757617, 6812.807758642317, 6828.385445309946, 6844.0, 6846.110005699227, 6848.14398200225, 7158.319959603829, 7191.7842464726145, 7201.963990180016, 7202.53183543068, 7216.9278307216255, 4788.449328327287, 4791.448983366818, 4798.088363211118, 4801.231802911518, 4805.063012712488, 6858.279880612464, 6865.897011544731, 6882.69027893756, 6893.276205998499, 6898.8620227594165, 6509.967450162909, 6660.367265109807, 6666.600003999775, 6676.532642715158, 6677.666116694243, 6632.933670663231, 6633.635150066792, 6638.269790323157, 6664.566803157779, 6677.532572719863, 6535.705893234911, 6553.082568440327, 6561.737530498726, 6563.573367731082, 6566.277709451861, 6617.569857959217, 6702.229243637044, 6710.396064354231, 6727.159105111861, 6734.225564060196, 6490.643014634241, 6579.144711187707, 6579.374959378852, 6586.5389422739945, 6587.736490540517], "value": 5081.64293564575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.5195446413401, 912.3659056955416, 914.7713071732067, 917.5366439947825, 920.6271460058674, 14240.57278281652, 14491.42034318626, 14551.345189466472, 14569.781453278196, 14571.125732456047, 14253.928730356334, 15652.686946261096, 15991.84008159918, 16002.519924402286, 16022.118783466905, 779.3180966654178, 912.3704643795793, 913.4975763330175, 917.8210249001447, 930.8650245714367, 933.3886304470583, 938.0900526489329, 939.8167357365317, 939.8778158839341, 941.8822647169104, 969.8157350103493, 972.8686627305294, 974.9756256093583, 976.599594166392, 979.2949076664826, 812.6749300279906, 962.1629182611138, 971.839646458337, 974.2644303550844, 978.041519311072, 719.467593980456, 724.2033762860812, 724.4819953733106, 724.5906063074347, 725.5102805606194, 15201.847981520154, 15338.846611533854, 15368.462103826312, 15389.923050384788, 15391.846081539154, 14552.490662826856, 14802.481913133097, 14836.480723174636, 14848.777268340984, 14873.776893346609, 12279.877201228051, 12385.690357741129, 12438.81341779874, 12556.309402982832, 12681.0, 3972.304846651853, 3976.8011599419915, 4012.137390461065, 4031.1534577738416, 4068.0643452005907, 57374.0, 57537.42462575363, 57565.42434575642, 57566.42433575653, 57959.71020144915, 11094.889051109385, 11500.079993600491, 11515.481803318704, 11728.120390970711, 11747.823782643267, 20687.793122068888, 20785.89607051955, 21360.252391166236, 21419.143234270767, 21452.0, 8475.110113438, 8511.787205319917, 8525.616347264264, 8748.737537873874, 8791.428557143765, 5032.421271553818, 5084.059449001947, 5093.643444958891, 5096.566791822736, 5123.923141152885, 3748.756330838487, 3778.0554861284677, 3787.0910981364273, 3787.886363409102, 3807.5621303550447, 656.3600489522677, 662.7514681994252, 677.5325025732229, 679.8334408070054, 680.7072958627739, 759.4038679636459, 759.946803723734, 777.2577188784697, 807.1807115777373, 807.8101646113158, 9598.712038638852, 9703.466309353053, 9800.55897484615, 10319.535620896928, 10500.107490863209, 650.9707063182168, 782.8825676148509, 801.1747899663357, 831.8419500295046, 849.0575461238021, 4611.492735799059, 4644.117617652702, 4679.27471241958, 4737.265723812815, 4815.686980346266, 63429.0, 64479.35520644827, 64760.67619661872, 64821.67589162024, 65100.674496627216, 57828.0, 58813.705931470926, 59705.40294596998, 59868.40131598628, 59870.0, 50856.0, 51061.744691276304, 51571.0, 51982.0, 52356.0, 9323.953380233326, 9387.718368448957, 9405.20055795265, 9406.247500200105, 9504.572294246915, 39131.217375652894, 39684.2063158741, 40044.0, 40753.796231018656, 40807.59192408038, 49202.50797491979, 49387.50612493829, 49842.25236621526, 49944.50055499544, 51371.2294315593, 11439.714007149554, 11583.305001699924, 11661.591844285409, 11663.825042624198, 11873.465694043616, 12773.0, 13090.410931507915, 13145.802812957621, 13172.60482185536, 13236.801447978096, 12253.69365765863, 12260.32568208757, 12399.75200496003, 12418.875811241773, 12484.937575312066, 12704.428300726675, 12755.80866287025, 12786.552470663853, 12786.808197877226, 12834.55079072228, 12027.398630068637, 12112.091593130373, 12126.211796233569, 12138.817917731065, 12165.513379464723, 10204.59181632756, 10231.48842557884, 10419.583216671248, 10423.791524169626, 10449.373037617766, 10073.798524029331, 10562.947185264025, 10715.732106697395, 10749.62376316825, 10764.784704306026], "value": 7189.487285852049, "unit": "score"}], "name": "dromaeo_css", "value": 7564.516233284743, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 109.0, 110.0, 110.0, 104.0, 108.0, 108.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 158.0, 182.0, 128.0, 152.0, 162.0, 127.0, 180.0, 126.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 160.0, 159.0, 160.0, 161.0, 162.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 165.0, 73.0, 76.0, 76.0, 82.0, 162.0, 77.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 146.0, 91.0, 92.0, 92.0, 147.0, 91.0, 91.0, 148.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 124.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 57.0, 56.0, 59.0, 74.0, 55.0, 55.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 59.0, 58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 74.0, 74.0, 74.0, 74.0, 74.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 114.0, 116.0, 121.0, 113.0, 111.0, 113.0, 128.0, 134.0], "value": 117.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 167.0, 164.0, 160.0, 162.0, 159.0, 167.0, 160.0, 159.0, 166.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1513.4000000000003, "alertThreshold": 2.0}]} 06:14:49 INFO - Return code: 0 06:14:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:14:49 ERROR - # TBPL SUCCESS # 06:14:49 INFO - Running post-action listener: _resource_record_post_action 06:14:49 INFO - Running post-run listener: _resource_record_post_run 06:14:50 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 464760832; Read time: 308; Write time: 345780 06:14:50 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 4096; Write bytes: 242188288; Read time: 228; Write time: 237584 06:14:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 221974528; Read time: 80; Write time: 108196 06:14:50 INFO - Running post-run listener: _upload_blobber_files 06:14:50 INFO - Blob upload gear active. 06:14:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:14:50 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:14:50 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:14:51 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:14:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:14:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:51 INFO - (blobuploader) - INFO - Done attempting. 06:14:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:14:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:14:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:52 INFO - (blobuploader) - INFO - Done attempting. 06:14:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:52 INFO - Return code: 0 06:14:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c7e0c9aa46cc1730f09548d8b90a6334267b6a1b5679ff3d1047e089f08490833dbc20a9a0ec772de1fca66526431bcfce4a9bd4b04ecfe423aed3f491ea18d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a07c7f9b04ad0c26660fcf3e6cc79c8367c0169020cff06e5fc12bcdd98c522b9ef0ec5557a5b72bd6e09a3b9a70e305b5eeee27718163a331a6a8173a1d398"} 06:14:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:52 INFO - Contents: 06:14:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c7e0c9aa46cc1730f09548d8b90a6334267b6a1b5679ff3d1047e089f08490833dbc20a9a0ec772de1fca66526431bcfce4a9bd4b04ecfe423aed3f491ea18d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a07c7f9b04ad0c26660fcf3e6cc79c8367c0169020cff06e5fc12bcdd98c522b9ef0ec5557a5b72bd6e09a3b9a70e305b5eeee27718163a331a6a8173a1d398"} 06:14:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:52 INFO - Copying logs to upload dir... 06:14:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.865082 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-18 06:14:52.592692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 06:14:52.595954) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511 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-Beta/sha512/c7e0c9aa46cc1730f09548d8b90a6334267b6a1b5679ff3d1047e089f08490833dbc20a9a0ec772de1fca66526431bcfce4a9bd4b04ecfe423aed3f491ea18d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a07c7f9b04ad0c26660fcf3e6cc79c8367c0169020cff06e5fc12bcdd98c522b9ef0ec5557a5b72bd6e09a3b9a70e305b5eeee27718163a331a6a8173a1d398"} build_url:https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/NEH0vN3PRzyhN8M0PmFNQA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c7e0c9aa46cc1730f09548d8b90a6334267b6a1b5679ff3d1047e089f08490833dbc20a9a0ec772de1fca66526431bcfce4a9bd4b04ecfe423aed3f491ea18d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2a07c7f9b04ad0c26660fcf3e6cc79c8367c0169020cff06e5fc12bcdd98c522b9ef0ec5557a5b72bd6e09a3b9a70e305b5eeee27718163a331a6a8173a1d398"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 06:14:52.622339) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 06:14:52.622692) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466254436.574025-1582632511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 06:14:52.704690) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 06:14:52.705078) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 06:14:52.705369) ========= ========= Total master_lag: 0.29 =========