builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1480670454.03 results: success (0) buildid: 20161202002443 builduid: 6be7fa5540fe419cac6221721ba785aa revision: f65ad27efe839ce9df0283840a1a40b4bbc9ead0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.033008) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.033466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.033741) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.049099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.049501) ========= 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=826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-02 01:20:54-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.6M=0s 2016-12-02 01:20:54 (87.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.190525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.190833) ========= 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=826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.241309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.241646) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f65ad27efe839ce9df0283840a1a40b4bbc9ead0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f65ad27efe839ce9df0283840a1a40b4bbc9ead0 --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=826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-02 01:20:54,333 truncating revision to first 12 chars 2016-12-02 01:20:54,333 Setting DEBUG logging. 2016-12-02 01:20:54,333 attempt 1/10 2016-12-02 01:20:54,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f65ad27efe83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 01:20:54,629 unpacking tar archive at: mozilla-central-f65ad27efe83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584850 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.840188) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.840488) ========= script_repo_revision: f65ad27efe839ce9df0283840a1a40b4bbc9ead0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.840912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.841208) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 01:20:54.850684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-02 01:20:54.851049) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:20:55 INFO - MultiFileLogger online at 20161202 01:20:55 in /builds/slave/test 01:20:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 01:20:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:20:55 INFO - {'append_to_log': False, 01:20:55 INFO - 'base_work_dir': '/builds/slave/test', 01:20:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:20:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:20:55 INFO - 'branch': 'Firefox-Non-PGO', 01:20:55 INFO - 'buildbot_json_path': 'buildprops.json', 01:20:55 INFO - 'config_files': ('talos/linux_config.py',), 01:20:55 INFO - 'default_actions': ('clobber', 01:20:55 INFO - 'read-buildbot-config', 01:20:55 INFO - 'download-and-extract', 01:20:55 INFO - 'populate-webroot', 01:20:55 INFO - 'create-virtualenv', 01:20:55 INFO - 'install', 01:20:55 INFO - 'run-tests'), 01:20:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:20:55 INFO - 'download_minidump_stackwalk': True, 01:20:55 INFO - 'download_symbols': 'ondemand', 01:20:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:20:55 INFO - 'tooltool.py': '/tools/tooltool.py', 01:20:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:20:55 INFO - '/tools/misc-python/virtualenv.py')}, 01:20:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:20:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:20:55 INFO - 'installer_path': 'installer.exe', 01:20:55 INFO - 'log_level': 'info', 01:20:55 INFO - 'log_name': 'talos', 01:20:55 INFO - 'log_to_console': True, 01:20:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:20:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:20:55 INFO - 'opt_config_files': (), 01:20:55 INFO - 'pip_index': False, 01:20:55 INFO - 'sps_profile': False, 01:20:55 INFO - 'sps_profile_interval': 0, 01:20:55 INFO - 'suite': 'dromaeojs', 01:20:55 INFO - 'system_bits': '32', 01:20:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:20:55 INFO - 'title': 'talos-linux64-ix-052', 01:20:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:20:55 INFO - 'use_talos_json': True, 01:20:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:20:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:20:55 INFO - 'work_dir': 'build'} 01:20:55 INFO - [mozharness: 2016-12-02 09:20:55.044011Z] Running clobber step. 01:20:55 INFO - Running pre-action listener: _resource_record_pre_action 01:20:55 INFO - Running main action method: clobber 01:20:55 INFO - rmtree: /builds/slave/test/build 01:20:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:20:55 INFO - Running post-action listener: _resource_record_post_action 01:20:55 INFO - [mozharness: 2016-12-02 09:20:55.498301Z] Finished clobber step (success) 01:20:55 INFO - [mozharness: 2016-12-02 09:20:55.498401Z] Running read-buildbot-config step. 01:20:55 INFO - Running pre-action listener: _resource_record_pre_action 01:20:55 INFO - Running main action method: read_buildbot_config 01:20:55 INFO - Using buildbot properties: 01:20:55 INFO - { 01:20:55 INFO - "project": "", 01:20:55 INFO - "product": "firefox", 01:20:55 INFO - "script_repo_revision": "production", 01:20:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:20:55 INFO - "repository": "", 01:20:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 01:20:55 INFO - "buildid": "20161202002443", 01:20:55 INFO - "pgo_build": "False", 01:20:55 INFO - "basedir": "/builds/slave/test", 01:20:55 INFO - "buildnumber": 320, 01:20:55 INFO - "slavename": "talos-linux64-ix-052", 01:20:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:20:55 INFO - "platform": "ubuntu64_hw", 01:20:55 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 01:20:55 INFO - "branch": "mozilla-central", 01:20:55 INFO - "repo_path": "mozilla-central", 01:20:55 INFO - "revision": "f65ad27efe839ce9df0283840a1a40b4bbc9ead0", 01:20:55 INFO - "stage_platform": "linux64", 01:20:55 INFO - "builduid": "6be7fa5540fe419cac6221721ba785aa", 01:20:55 INFO - "slavebuilddir": "test" 01:20:55 INFO - } 01:20:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 01:20:55 INFO - Running post-action listener: _resource_record_post_action 01:20:55 INFO - [mozharness: 2016-12-02 09:20:55.500858Z] Finished read-buildbot-config step (success) 01:20:55 INFO - [mozharness: 2016-12-02 09:20:55.500951Z] Running download-and-extract step. 01:20:55 INFO - Running pre-action listener: _resource_record_pre_action 01:20:55 INFO - Running main action method: download_and_extract 01:20:55 INFO - mkdir: /builds/slave/test/build/tests 01:20:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:20:55 INFO - trying https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:20:55 INFO - Downloading https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:20:56 INFO - Downloaded 1361 bytes. 01:20:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:20:56 INFO - Using the following test package requirements: 01:20:56 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:20:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:20:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:20:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:20:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:20:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:20:56 INFO - u'jsshell-linux-x86_64.zip'], 01:20:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:20:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:20:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:20:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:20:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:20:56 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:20:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:20:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:20:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:20:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:20:56 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:20:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:20:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:20:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:20:56 INFO - Fetch https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:20:56 INFO - Expected file size: 20209573 01:20:56 INFO - Obtained file size: 20209573 01:21:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:21:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:21:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:21:00 INFO - Fetch https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:21:01 INFO - Expected file size: 20209573 01:21:01 INFO - Obtained file size: 20209573 01:21:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 01:21:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:21:06 INFO - Fetch https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:21:07 INFO - Expected file size: 14409734 01:21:07 INFO - Obtained file size: 14409734 01:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:07 INFO - trying https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:21:07 INFO - Downloading https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:21:10 INFO - Downloaded 55692765 bytes. 01:21:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:21:10 INFO - mkdir: /builds/slave/test/properties 01:21:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:21:10 INFO - Writing to file /builds/slave/test/properties/build_url 01:21:10 INFO - Contents: 01:21:10 INFO - build_url:https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:21:10 INFO - Running post-action listener: _resource_record_post_action 01:21:10 INFO - Running post-action listener: set_extra_try_arguments 01:21:10 INFO - [mozharness: 2016-12-02 09:21:10.867483Z] Finished download-and-extract step (success) 01:21:10 INFO - [mozharness: 2016-12-02 09:21:10.867713Z] Running populate-webroot step. 01:21:10 INFO - Running pre-action listener: _resource_record_pre_action 01:21:10 INFO - Running main action method: populate_webroot 01:21:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:21:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:21:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:21:10 INFO - '--tppagecycles', 01:21:10 INFO - '7'], 01:21:10 INFO - 'tests': ['tsvgm']}}, 01:21:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:21:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:21:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:21:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:21:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:21:10 INFO - 'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:21:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:21:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:21:10 INFO - 'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['damp', 'tps']}, 01:21:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:21:10 INFO - 'tests': ['damp', 'tps']}, 01:21:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['dromaeo_dom']}, 01:21:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:21:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['basic_compositor_video']}, 01:21:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:21:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['a11yr', 01:21:10 INFO - 'ts_paint', 01:21:10 INFO - 'tpaint', 01:21:10 INFO - 'sessionrestore', 01:21:10 INFO - 'sessionrestore_no_auto_restore', 01:21:10 INFO - 'tabpaint']}, 01:21:10 INFO - 'other-e10s': {'tests': ['a11yr', 01:21:10 INFO - 'ts_paint', 01:21:10 INFO - 'tpaint', 01:21:10 INFO - 'sessionrestore', 01:21:10 INFO - 'sessionrestore_no_auto_restore', 01:21:10 INFO - 'tabpaint']}, 01:21:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:21:10 INFO - 'ts_paint', 01:21:10 INFO - 'tpaint', 01:21:10 INFO - 'sessionrestore', 01:21:10 INFO - 'sessionrestore_no_auto_restore', 01:21:10 INFO - 'tabpaint']}, 01:21:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:21:10 INFO - 'ts_paint', 01:21:10 INFO - 'tpaint', 01:21:10 INFO - 'sessionrestore', 01:21:10 INFO - 'sessionrestore_no_auto_restore', 01:21:10 INFO - 'tabpaint']}, 01:21:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['a11yr', 01:21:10 INFO - 'ts_paint', 01:21:10 INFO - 'tpaint', 01:21:10 INFO - 'sessionrestore', 01:21:10 INFO - 'sessionrestore_no_auto_restore', 01:21:10 INFO - 'tabpaint']}, 01:21:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['a11yr', 01:21:10 INFO - 'ts_paint', 01:21:10 INFO - 'tpaint', 01:21:10 INFO - 'sessionrestore', 01:21:10 INFO - 'sessionrestore_no_auto_restore', 01:21:10 INFO - 'tabpaint']}, 01:21:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['tsvgx', 01:21:10 INFO - 'tsvgr_opacity', 01:21:10 INFO - 'tart', 01:21:10 INFO - 'tscrollx', 01:21:10 INFO - 'cart', 01:21:10 INFO - 'tsvg_static']}, 01:21:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:21:10 INFO - 'tsvgr_opacity', 01:21:10 INFO - 'tart', 01:21:10 INFO - 'tscrollx', 01:21:10 INFO - 'cart', 01:21:10 INFO - 'tsvg_static']}, 01:21:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:21:10 INFO - 'talos_options': ['--disable-e10s'], 01:21:10 INFO - 'tests': ['tp5o']}, 01:21:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:21:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:21:10 INFO - 'talos_options': ['--disable-e10s', 01:21:10 INFO - '--xperf_path', 01:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:21:10 INFO - 'tests': ['tp5n']}, 01:21:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:21:10 INFO - 'talos_options': ['--xperf_path', 01:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:21:10 INFO - 'tests': ['tp5n']}}, 01:21:10 INFO - 'talos.zip': {'path': '', 01:21:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:21:10 INFO - Running post-action listener: _resource_record_post_action 01:21:10 INFO - [mozharness: 2016-12-02 09:21:10.889179Z] Finished populate-webroot step (success) 01:21:10 INFO - [mozharness: 2016-12-02 09:21:10.889268Z] Running create-virtualenv step. 01:21:10 INFO - Running pre-action listener: _resource_record_pre_action 01:21:10 INFO - Running main action method: create_virtualenv 01:21:10 INFO - Creating virtualenv /builds/slave/test/build/venv 01:21:10 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 01:21:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:21:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:21:10 INFO - Using real prefix '/usr' 01:21:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:21:11 INFO - Installing distribute.............................................................................................................................................................................................done. 01:21:13 INFO - Installing pip.................done. 01:21:13 INFO - Return code: 0 01:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:21:13 INFO - Reading from file tmpfile_stdout 01:21:13 INFO - Output received: 01:21:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:21:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:13 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 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:13 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 01:21:13 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 01:21:13 INFO - Using env: {'DISPLAY': ':0', 01:21:13 INFO - 'HOME': '/home/cltbld', 01:21:13 INFO - 'LANG': 'en_US.UTF-8', 01:21:13 INFO - 'LANGUAGE': 'en_US:en', 01:21:13 INFO - 'LOGNAME': 'cltbld', 01:21:13 INFO - 'MAIL': '/var/mail/cltbld', 01:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:13 INFO - 'MOZ_NO_REMOTE': '1', 01:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:13 INFO - 'NO_EM_RESTART': '1', 01:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:13 INFO - 'PWD': '/builds/slave/test', 01:21:13 INFO - 'SHELL': '/bin/bash', 01:21:13 INFO - 'SHLVL': '1', 01:21:13 INFO - 'TERM': 'linux', 01:21:13 INFO - 'TMOUT': '86400', 01:21:13 INFO - 'USER': 'cltbld', 01:21:13 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:13 INFO - '_': '/tools/buildbot/bin/python'} 01:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:13 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 01:21:13 INFO - Cleaning up... 01:21:13 INFO - Return code: 0 01:21:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:13 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:13 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>=3.1.1'] in /builds/slave/test/build 01:21:13 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>=3.1.1 01:21:13 INFO - Using env: {'DISPLAY': ':0', 01:21:13 INFO - 'HOME': '/home/cltbld', 01:21:13 INFO - 'LANG': 'en_US.UTF-8', 01:21:13 INFO - 'LANGUAGE': 'en_US:en', 01:21:13 INFO - 'LOGNAME': 'cltbld', 01:21:13 INFO - 'MAIL': '/var/mail/cltbld', 01:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:13 INFO - 'MOZ_NO_REMOTE': '1', 01:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:13 INFO - 'NO_EM_RESTART': '1', 01:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:13 INFO - 'PWD': '/builds/slave/test', 01:21:13 INFO - 'SHELL': '/bin/bash', 01:21:13 INFO - 'SHLVL': '1', 01:21:13 INFO - 'TERM': 'linux', 01:21:13 INFO - 'TMOUT': '86400', 01:21:13 INFO - 'USER': 'cltbld', 01:21:13 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:13 INFO - '_': '/tools/buildbot/bin/python'} 01:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:14 INFO - Downloading/unpacking psutil>=3.1.1 01:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:21:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:21:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:21:16 INFO - Installing collected packages: psutil 01:21:16 INFO - Running setup.py install for psutil 01:21:16 INFO - building 'psutil._psutil_linux' extension 01:21:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:21:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:21:16 INFO - building 'psutil._psutil_posix' extension 01:21:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:21:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:21:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:21:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:21:16 INFO - Successfully installed psutil 01:21:16 INFO - Cleaning up... 01:21:16 INFO - Return code: 0 01:21:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:16 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:16 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.3'] in /builds/slave/test/build 01:21:16 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.3 01:21:16 INFO - Using env: {'DISPLAY': ':0', 01:21:16 INFO - 'HOME': '/home/cltbld', 01:21:16 INFO - 'LANG': 'en_US.UTF-8', 01:21:16 INFO - 'LANGUAGE': 'en_US:en', 01:21:16 INFO - 'LOGNAME': 'cltbld', 01:21:16 INFO - 'MAIL': '/var/mail/cltbld', 01:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:16 INFO - 'MOZ_NO_REMOTE': '1', 01:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:16 INFO - 'NO_EM_RESTART': '1', 01:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:16 INFO - 'PWD': '/builds/slave/test', 01:21:16 INFO - 'SHELL': '/bin/bash', 01:21:16 INFO - 'SHLVL': '1', 01:21:16 INFO - 'TERM': 'linux', 01:21:16 INFO - 'TMOUT': '86400', 01:21:16 INFO - 'USER': 'cltbld', 01:21:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:16 INFO - '_': '/tools/buildbot/bin/python'} 01:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:21:16 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 01:21:16 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 01:21:16 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 01:21:16 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 01:21:16 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 01:21:16 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 01:21:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:21:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:21:19 INFO - Installing collected packages: mozsystemmonitor 01:21:19 INFO - Running setup.py install for mozsystemmonitor 01:21:19 INFO - Successfully installed mozsystemmonitor 01:21:19 INFO - Cleaning up... 01:21:19 INFO - Return code: 0 01:21:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:21:19 INFO - Using env: {'DISPLAY': ':0', 01:21:19 INFO - 'HOME': '/home/cltbld', 01:21:19 INFO - 'LANG': 'en_US.UTF-8', 01:21:19 INFO - 'LANGUAGE': 'en_US:en', 01:21:19 INFO - 'LOGNAME': 'cltbld', 01:21:19 INFO - 'MAIL': '/var/mail/cltbld', 01:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:19 INFO - 'MOZ_NO_REMOTE': '1', 01:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:19 INFO - 'NO_EM_RESTART': '1', 01:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:19 INFO - 'PWD': '/builds/slave/test', 01:21:19 INFO - 'SHELL': '/bin/bash', 01:21:19 INFO - 'SHLVL': '1', 01:21:19 INFO - 'TERM': 'linux', 01:21:19 INFO - 'TMOUT': '86400', 01:21:19 INFO - 'USER': 'cltbld', 01:21:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:19 INFO - '_': '/tools/buildbot/bin/python'} 01:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:19 INFO - Downloading/unpacking jsonschema==2.5.1 01:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:21:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:21 INFO - Downloading functools32-3.2.3-2.tar.gz 01:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:21:21 INFO - warning: no files found matching '*.txt' 01:21:21 INFO - no previously-included directories found matching 'build' 01:21:21 INFO - no previously-included directories found matching 'dist' 01:21:21 INFO - no previously-included directories found matching '.git*' 01:21:21 INFO - Installing collected packages: jsonschema, functools32 01:21:21 INFO - Running setup.py install for functools32 01:21:21 INFO - warning: no files found matching '*.txt' 01:21:21 INFO - no previously-included directories found matching 'build' 01:21:21 INFO - no previously-included directories found matching 'dist' 01:21:21 INFO - no previously-included directories found matching '.git*' 01:21:21 INFO - Successfully installed jsonschema functools32 01:21:21 INFO - Cleaning up... 01:21:21 INFO - Return code: 0 01:21:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:21:21 INFO - Using env: {'DISPLAY': ':0', 01:21:21 INFO - 'HOME': '/home/cltbld', 01:21:21 INFO - 'LANG': 'en_US.UTF-8', 01:21:21 INFO - 'LANGUAGE': 'en_US:en', 01:21:21 INFO - 'LOGNAME': 'cltbld', 01:21:21 INFO - 'MAIL': '/var/mail/cltbld', 01:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:21 INFO - 'MOZ_NO_REMOTE': '1', 01:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:21 INFO - 'NO_EM_RESTART': '1', 01:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:21 INFO - 'PWD': '/builds/slave/test', 01:21:21 INFO - 'SHELL': '/bin/bash', 01:21:21 INFO - 'SHLVL': '1', 01:21:21 INFO - 'TERM': 'linux', 01:21:21 INFO - 'TMOUT': '86400', 01:21:21 INFO - 'USER': 'cltbld', 01:21:21 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:21 INFO - '_': '/tools/buildbot/bin/python'} 01:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:21:22 INFO - Cleaning up... 01:21:22 INFO - Return code: 0 01:21:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:21:22 INFO - Using env: {'DISPLAY': ':0', 01:21:22 INFO - 'HOME': '/home/cltbld', 01:21:22 INFO - 'LANG': 'en_US.UTF-8', 01:21:22 INFO - 'LANGUAGE': 'en_US:en', 01:21:22 INFO - 'LOGNAME': 'cltbld', 01:21:22 INFO - 'MAIL': '/var/mail/cltbld', 01:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:22 INFO - 'MOZ_NO_REMOTE': '1', 01:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:22 INFO - 'NO_EM_RESTART': '1', 01:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:22 INFO - 'PWD': '/builds/slave/test', 01:21:22 INFO - 'SHELL': '/bin/bash', 01:21:22 INFO - 'SHLVL': '1', 01:21:22 INFO - 'TERM': 'linux', 01:21:22 INFO - 'TMOUT': '86400', 01:21:22 INFO - 'USER': 'cltbld', 01:21:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:22 INFO - '_': '/tools/buildbot/bin/python'} 01:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:22 INFO - Downloading/unpacking blobuploader==1.2.4 01:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:24 INFO - Downloading blobuploader-1.2.4.tar.gz 01:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:21:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:21:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:24 INFO - Downloading docopt-0.6.1.tar.gz 01:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:21:25 INFO - Installing collected packages: blobuploader, requests, docopt 01:21:25 INFO - Running setup.py install for blobuploader 01:21:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:21:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:21:25 INFO - Running setup.py install for requests 01:21:25 INFO - Running setup.py install for docopt 01:21:25 INFO - Successfully installed blobuploader requests docopt 01:21:25 INFO - Cleaning up... 01:21:25 INFO - Return code: 0 01:21:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:21:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:25 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 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:25 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 01:21:25 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 01:21:25 INFO - Using env: {'DISPLAY': ':0', 01:21:25 INFO - 'HOME': '/home/cltbld', 01:21:25 INFO - 'LANG': 'en_US.UTF-8', 01:21:25 INFO - 'LANGUAGE': 'en_US:en', 01:21:25 INFO - 'LOGNAME': 'cltbld', 01:21:25 INFO - 'MAIL': '/var/mail/cltbld', 01:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:25 INFO - 'MOZ_NO_REMOTE': '1', 01:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:25 INFO - 'NO_EM_RESTART': '1', 01:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:25 INFO - 'PWD': '/builds/slave/test', 01:21:25 INFO - 'SHELL': '/bin/bash', 01:21:25 INFO - 'SHLVL': '1', 01:21:25 INFO - 'TERM': 'linux', 01:21:25 INFO - 'TMOUT': '86400', 01:21:25 INFO - 'USER': 'cltbld', 01:21:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:25 INFO - '_': '/tools/buildbot/bin/python'} 01:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:21:25 INFO - Running setup.py (path:/tmp/pip-UyKM4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:21:25 INFO - Running setup.py (path:/tmp/pip-moqYUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:21:25 INFO - Running setup.py (path:/tmp/pip-kVjpzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:21:26 INFO - Running setup.py (path:/tmp/pip-3PltyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:21:26 INFO - Running setup.py (path:/tmp/pip-nlbMO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:21:26 INFO - Running setup.py (path:/tmp/pip-T3GqFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:21:26 INFO - Running setup.py (path:/tmp/pip-XGYiE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:21:26 INFO - Running setup.py (path:/tmp/pip-OWRZ2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:21:26 INFO - Running setup.py (path:/tmp/pip-fx4u_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:21:26 INFO - Running setup.py (path:/tmp/pip-Fdv61G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:21:26 INFO - Running setup.py (path:/tmp/pip-eJrlV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:21:26 INFO - Running setup.py (path:/tmp/pip-n0TGjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:21:26 INFO - Running setup.py (path:/tmp/pip-ZXxZJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:21:26 INFO - Running setup.py (path:/tmp/pip-ZIceAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:26 INFO - Running setup.py (path:/tmp/pip-5LMqSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:21:26 INFO - Running setup.py (path:/tmp/pip-wKZ_a3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:21:26 INFO - Running setup.py (path:/tmp/pip-pAYWCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:21:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:21:27 INFO - Running setup.py install for manifestparser 01:21:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:21:27 INFO - Running setup.py install for mozcrash 01:21:27 INFO - Running setup.py install for mozdebug 01:21:27 INFO - Running setup.py install for mozdevice 01:21:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:21:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:21:27 INFO - Running setup.py install for mozfile 01:21:27 INFO - Running setup.py install for mozhttpd 01:21:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:21:27 INFO - Running setup.py install for mozinfo 01:21:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:21:27 INFO - Running setup.py install for mozInstall 01:21:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:21:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:21:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:21:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:21:27 INFO - Running setup.py install for mozleak 01:21:27 INFO - Running setup.py install for mozlog 01:21:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:21:28 INFO - Running setup.py install for moznetwork 01:21:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:21:28 INFO - Running setup.py install for mozprocess 01:21:28 INFO - Running setup.py install for mozprofile 01:21:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:21:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:21:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:21:28 INFO - Running setup.py install for mozrunner 01:21:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:21:28 INFO - Running setup.py install for mozscreenshot 01:21:28 INFO - Running setup.py install for moztest 01:21:28 INFO - Running setup.py install for mozversion 01:21:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:21:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:21:28 INFO - Cleaning up... 01:21:28 INFO - Return code: 0 01:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:28 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 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:28 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 01:21:28 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 01:21:28 INFO - Using env: {'DISPLAY': ':0', 01:21:28 INFO - 'HOME': '/home/cltbld', 01:21:28 INFO - 'LANG': 'en_US.UTF-8', 01:21:28 INFO - 'LANGUAGE': 'en_US:en', 01:21:28 INFO - 'LOGNAME': 'cltbld', 01:21:28 INFO - 'MAIL': '/var/mail/cltbld', 01:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:28 INFO - 'MOZ_NO_REMOTE': '1', 01:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:28 INFO - 'NO_EM_RESTART': '1', 01:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:28 INFO - 'PWD': '/builds/slave/test', 01:21:28 INFO - 'SHELL': '/bin/bash', 01:21:28 INFO - 'SHLVL': '1', 01:21:28 INFO - 'TERM': 'linux', 01:21:28 INFO - 'TMOUT': '86400', 01:21:28 INFO - 'USER': 'cltbld', 01:21:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:28 INFO - '_': '/tools/buildbot/bin/python'} 01:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:21:29 INFO - Running setup.py (path:/tmp/pip-cMUQtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:21:29 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:21:29 INFO - Running setup.py (path:/tmp/pip-aG4rpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:21:29 INFO - Running setup.py (path:/tmp/pip-FW0NC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:21:29 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:21:29 INFO - Running setup.py (path:/tmp/pip-LgTiyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:21:29 INFO - Running setup.py (path:/tmp/pip-kbqFp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:21:29 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:21:29 INFO - Running setup.py (path:/tmp/pip-3IAzVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:21:29 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:21:29 INFO - Running setup.py (path:/tmp/pip-laXpVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:21:29 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:21:29 INFO - Running setup.py (path:/tmp/pip-TSNHZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:21:29 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:21:29 INFO - Running setup.py (path:/tmp/pip-AKYalx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:21:29 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:21:29 INFO - Running setup.py (path:/tmp/pip-UkjR9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:21:29 INFO - Running setup.py (path:/tmp/pip-HvlWct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:21:29 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:21:29 INFO - Running setup.py (path:/tmp/pip-g6mutk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 01:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:21:29 INFO - Running setup.py (path:/tmp/pip-MdAUcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:21:30 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)) 01:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:21:30 INFO - Running setup.py (path:/tmp/pip-1SVMCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 01:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:30 INFO - Running setup.py (path:/tmp/pip-oRnh5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:21:30 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)) 01:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:21:30 INFO - Running setup.py (path:/tmp/pip-fl3iYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:21:30 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)) 01:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:21:30 INFO - Running setup.py (path:/tmp/pip-I72l_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:21:30 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)) 01:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:21:30 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)) 01:21:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:21:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:21:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:21:32 INFO - Downloading blessings-1.6.tar.gz 01:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:21:32 INFO - Installing collected packages: blessings 01:21:32 INFO - Running setup.py install for blessings 01:21:32 INFO - Successfully installed blessings 01:21:32 INFO - Cleaning up... 01:21:32 INFO - Return code: 0 01:21:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:21:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:21:32 INFO - Reading from file tmpfile_stdout 01:21:32 INFO - Current package versions: 01:21:32 INFO - argparse == 1.2.1 01:21:32 INFO - blessings == 1.6 01:21:32 INFO - blobuploader == 1.2.4 01:21:32 INFO - docopt == 0.6.1 01:21:32 INFO - functools32 == 3.2.3-2 01:21:32 INFO - jsonschema == 2.5.1 01:21:32 INFO - manifestparser == 1.1 01:21:32 INFO - mozInstall == 1.12 01:21:32 INFO - mozcrash == 1.0 01:21:32 INFO - mozdebug == 0.1 01:21:32 INFO - mozdevice == 0.49 01:21:32 INFO - mozfile == 1.2 01:21:32 INFO - mozhttpd == 0.7 01:21:32 INFO - mozinfo == 0.9 01:21:32 INFO - mozleak == 0.1 01:21:32 INFO - mozlog == 3.4 01:21:32 INFO - moznetwork == 0.27 01:21:32 INFO - mozprocess == 0.23 01:21:32 INFO - mozprofile == 0.28 01:21:32 INFO - mozrunner == 6.13 01:21:32 INFO - mozscreenshot == 0.1 01:21:32 INFO - mozsystemmonitor == 0.3 01:21:32 INFO - moztest == 0.7 01:21:32 INFO - mozversion == 1.4 01:21:32 INFO - psutil == 3.1.1 01:21:32 INFO - requests == 1.2.3 01:21:32 INFO - wsgiref == 0.1.2 01:21:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:32 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 01:21:32 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 01:21:32 INFO - Using env: {'DISPLAY': ':0', 01:21:32 INFO - 'HOME': '/home/cltbld', 01:21:32 INFO - 'LANG': 'en_US.UTF-8', 01:21:32 INFO - 'LANGUAGE': 'en_US:en', 01:21:32 INFO - 'LOGNAME': 'cltbld', 01:21:32 INFO - 'MAIL': '/var/mail/cltbld', 01:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:32 INFO - 'MOZ_NO_REMOTE': '1', 01:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:32 INFO - 'NO_EM_RESTART': '1', 01:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:32 INFO - 'PWD': '/builds/slave/test', 01:21:32 INFO - 'SHELL': '/bin/bash', 01:21:32 INFO - 'SHLVL': '1', 01:21:32 INFO - 'TERM': 'linux', 01:21:32 INFO - 'TMOUT': '86400', 01:21:32 INFO - 'USER': 'cltbld', 01:21:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:32 INFO - '_': '/tools/buildbot/bin/python'} 01:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:32 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)) 01:21:32 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)) 01:21:32 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)) 01:21:32 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)) 01:21:32 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)) 01:21:32 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)) 01:21:32 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)) 01:21:32 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)) 01:21:32 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)) 01:21:32 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)) 01:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:21:32 INFO - Cleaning up... 01:21:32 INFO - Return code: 0 01:21:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4aa2ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a85a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, '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': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', '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 01:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:21:32 INFO - Using env: {'DISPLAY': ':0', 01:21:32 INFO - 'HOME': '/home/cltbld', 01:21:32 INFO - 'LANG': 'en_US.UTF-8', 01:21:32 INFO - 'LANGUAGE': 'en_US:en', 01:21:32 INFO - 'LOGNAME': 'cltbld', 01:21:32 INFO - 'MAIL': '/var/mail/cltbld', 01:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:32 INFO - 'MOZ_NO_REMOTE': '1', 01:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:32 INFO - 'NO_EM_RESTART': '1', 01:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:32 INFO - 'PWD': '/builds/slave/test', 01:21:32 INFO - 'SHELL': '/bin/bash', 01:21:32 INFO - 'SHLVL': '1', 01:21:32 INFO - 'TERM': 'linux', 01:21:32 INFO - 'TMOUT': '86400', 01:21:32 INFO - 'USER': 'cltbld', 01:21:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:32 INFO - '_': '/tools/buildbot/bin/python'} 01:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:21:33 INFO - Cleaning up... 01:21:33 INFO - Return code: 0 01:21:33 INFO - Running post-action listener: _resource_record_post_action 01:21:33 INFO - Running post-action listener: _start_resource_monitoring 01:21:33 INFO - Starting resource monitoring. 01:21:33 INFO - [mozharness: 2016-12-02 09:21:33.215381Z] Finished create-virtualenv step (success) 01:21:33 INFO - [mozharness: 2016-12-02 09:21:33.215889Z] Running install step. 01:21:33 INFO - Running pre-action listener: _resource_record_pre_action 01:21:33 INFO - Running main action method: install 01:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:21:33 INFO - Reading from file tmpfile_stdout 01:21:33 INFO - Detecting whether we're running mozinstall >=1.0... 01:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:21:33 INFO - Reading from file tmpfile_stdout 01:21:33 INFO - Output received: 01:21:33 INFO - Usage: mozinstall [options] installer 01:21:33 INFO - Options: 01:21:33 INFO - -h, --help show this help message and exit 01:21:33 INFO - -d DEST, --destination=DEST 01:21:33 INFO - Directory to install application into. [default: 01:21:33 INFO - "/builds/slave/test"] 01:21:33 INFO - --app=APP Application being installed. [default: firefox] 01:21:33 INFO - mkdir: /builds/slave/test/build/application 01:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:21:49 INFO - Reading from file tmpfile_stdout 01:21:49 INFO - Output received: 01:21:49 INFO - /builds/slave/test/build/application/firefox/firefox 01:21:49 INFO - Running post-action listener: _resource_record_post_action 01:21:49 INFO - [mozharness: 2016-12-02 09:21:49.550481Z] Finished install step (success) 01:21:49 INFO - [mozharness: 2016-12-02 09:21:49.550726Z] Running run-tests step. 01:21:49 INFO - Running pre-action listener: _resource_record_pre_action 01:21:49 INFO - Running main action method: run_tests 01:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:21:49 INFO - Python 2.7.3 01:21:49 INFO - Return code: 0 01:21:49 INFO - grabbing minidump binary from tooltool 01:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:49 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3f20>, '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 0x1c20c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:21:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:21:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:21:49 INFO - Calling ['/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'] with output_timeout 600 01:21:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:21:49 INFO - Return code: 0 01:21:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:21:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:21:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:21:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:21:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 01:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 01:21:49 INFO - Using env: {'DISPLAY': ':0', 01:21:49 INFO - 'HOME': '/home/cltbld', 01:21:49 INFO - 'LANG': 'en_US.UTF-8', 01:21:49 INFO - 'LANGUAGE': 'en_US:en', 01:21:49 INFO - 'LOGNAME': 'cltbld', 01:21:49 INFO - 'MAIL': '/var/mail/cltbld', 01:21:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:21:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:49 INFO - 'MOZ_NO_REMOTE': '1', 01:21:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:49 INFO - 'NO_EM_RESTART': '1', 01:21:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:49 INFO - 'PWD': '/builds/slave/test', 01:21:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:21:49 INFO - 'SHELL': '/bin/bash', 01:21:49 INFO - 'SHLVL': '1', 01:21:49 INFO - 'TERM': 'linux', 01:21:49 INFO - 'TMOUT': '86400', 01:21:49 INFO - 'USER': 'cltbld', 01:21:49 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220', 01:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:49 INFO - '_': '/tools/buildbot/bin/python'} 01:21:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 01:21:49 INFO - mozversion application_buildid: 20161202002443 01:21:49 INFO - mozversion application_changeset: f65ad27efe839ce9df0283840a1a40b4bbc9ead0 01:21:49 INFO - mozversion application_display_name: Nightly 01:21:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:21:49 INFO - mozversion application_name: Firefox 01:21:49 INFO - mozversion application_remotingname: firefox 01:21:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:21:49 INFO - mozversion application_vendor: Mozilla 01:21:49 INFO - mozversion application_version: 53.0a1 01:21:49 INFO - mozversion platform_buildid: 20161202002443 01:21:49 INFO - mozversion platform_changeset: f65ad27efe839ce9df0283840a1a40b4bbc9ead0 01:21:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:21:49 INFO - mozversion platform_version: 53.0a1 01:21:49 INFO - using testdate: 1480670509 01:21:49 INFO - actual date: 1480670509 01:21:49 INFO - starting webserver on 'localhost:42734' 01:21:49 INFO - SUITE-START | Running 2 tests 01:21:49 INFO - TEST-START | dromaeo_css 01:21:49 INFO - operating with platform_type : linux_ 01:21:49 INFO - Initialising browser for dromaeo_css test... 01:21:49 INFO - TEST-INFO | started process 4396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvs_Iqk/profile http://localhost:42734/getInfo.html) 01:21:54 INFO - PROCESS | 4396 | __metrics Screen width/height:1600/1200 01:21:54 INFO - PROCESS | 4396 | colorDepth:24 01:21:54 INFO - PROCESS | 4396 | Browser inner width/height: 1024/697 01:21:54 INFO - PROCESS | 4396 | __metrics 01:21:54 INFO - PROCESS | 4396 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:21:54 INFO - PROCESS | 4396 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:21:55 INFO - PROCESS | 4396 | console.error: PushService: 01:21:55 INFO - PROCESS | 4396 | stateChangeProcessEnqueue: Error transitioning state 01:21:55 INFO - PROCESS | 4396 | UnknownError 01:21:56 INFO - TEST-INFO | 4396: exit 0 01:21:56 INFO - Browser initialized. 01:21:56 INFO - Running cycle 1/1 for dromaeo_css test... 01:21:56 INFO - TEST-INFO | started process 4478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvs_Iqk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:22:08 INFO - PROCESS | 4478 | RSS: Main: 174882816 01:22:08 INFO - PROCESS | 4478 | 01:22:59 INFO - PROCESS | 4478 | 1480670579529 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] 01:25:12 INFO - PROCESS | 4478 | Cycle 1(1): loaded http://localhost:42734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42734/tests/dromaeo/cssquery-ext.html) 01:25:15 INFO - PROCESS | 4478 | RSS: Main: 413458432 01:25:15 INFO - PROCESS | 4478 | 01:28:18 INFO - PROCESS | 4478 | Cycle 1(1): loaded http://localhost:42734/tests/dromaeo/cssquery-ext.html (next: http://localhost:42734/tests/dromaeo/cssquery-jquery.html) 01:28:19 INFO - PROCESS | 4478 | RSS: Main: 295559168 01:28:19 INFO - PROCESS | 4478 | 01:31:21 INFO - PROCESS | 4478 | Cycle 1(1): loaded http://localhost:42734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42734/tests/dromaeo/cssquery-mootools.html) 01:31:22 INFO - PROCESS | 4478 | RSS: Main: 220360704 01:31:22 INFO - PROCESS | 4478 | 01:34:24 INFO - PROCESS | 4478 | Cycle 1(1): loaded http://localhost:42734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42734/tests/dromaeo/cssquery-prototype.html) 01:34:25 INFO - PROCESS | 4478 | RSS: Main: 220209152 01:34:25 INFO - PROCESS | 4478 | 01:37:28 INFO - PROCESS | 4478 | Cycle 1(1): loaded http://localhost:42734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42734/tests/dromaeo/cssquery-yui.html) 01:37:28 INFO - PROCESS | 4478 | RSS: Main: 223211520 01:37:28 INFO - PROCESS | 4478 | 01:40:31 INFO - PROCESS | 4478 | Cycle 1(1): loaded http://localhost:42734/tests/dromaeo/cssquery-yui.html (next: http://localhost:42734/tests/dromaeo/cssquery-dojo.html) 01:40:32 INFO - PROCESS | 4478 | RSS: Main: 311955456 01:40:32 INFO - PROCESS | 4478 | 01:40:32 INFO - PROCESS | 4478 | __start_tp_report 01:40:32 INFO - PROCESS | 4478 | _x_x_mozilla_page_load 01:40:32 INFO - PROCESS | 4478 | _x_x_mozilla_page_load_details 01:40:32 INFO - PROCESS | 4478 | |i|pagename|runs| 01:40:32 INFO - PROCESS | 4478 | |0;dojo.html;2642.9339266518336;2654.8938042478303;2664.8934042638302;2690.9461810763787;2700.66241719785;4697.812087516504;4744.098621261966;4801.807927682893;4842.297866809315;4884.85345439637;4738.810447582093;4786.042791441708;4798.520147985199;4818.397700287464;4873.537013983666;4432.290833466646;4434.290513517838;4455.376247325377;4482.17079840229;4486.394336764544;4395.802188901491;4435.290353543433;4522.209668787535;4528.139653465831;4589.518100599439;4516.819327226907;4575.290829921368;4575.908481830362;4607.470140933785;4609.7234165949985;4287.678424118172;4322.978385108086;4332.090261045184;4374.431323927869;4514.706544074625;4363.192809330284;4364.978175109136;4371.27873900806;4399.5820397062225;4434.512203657595;4701.294805779126;4736.786844592001;4750.406199225097;4760.071786001731;4781.115493633689;4943.431505376891;4970.776315065831;5105.5149760772665;5109.821156259551;5143.717095559743;5060.089183946888;5112.386513618352;5174.741262936838;5183.377994640629;5248.265242866002;4812.687175333592;4815.2054910939305;4815.831445899376;4822.758862056953;4864.756762161877;5296.629235953524;5307.814226502054;5312.5218730314455;5314.840554783363;5319.5744340452675;4855.902881942341;4879.634027447955;4880.194767863334;5052.242163675478;5082.1360368737405;5193.246979187997;5204.4535323791215;5204.8178313758835;5234.555062819627;5257.684538927677;5115.897682046339;5140.717260550706;5152.355955505562;5203.063448579216;5208.479152084761;4822.445418776815;4841.612670986313;4846.29728689338;5082.517160869711;5145.819896303611;4444.755538445352;4477.171723231213;4479.417675702203;4492.775361231926;4533.546645335506;3890.3775395936514;3899.863504777319;3899.980500097538;3937.1338305572726;3947.388154836005;4282.807273672693;4461.576150265784;4473.888152796206;4479.238529450001;4513.277875539898;5038.823641172541;5154.639175257771;5156.8968620627375;5158.63889527737;5266.815661451831;4437.090396468716;4444.377787109807;4444.577765112309;4448.377227188196;4488.304312831517;4714.6464015199;4715.528447155257;4721.244600863914;4722.858314250578;4762.333273341735;4658.440987081572;4684.414448193976;4684.5549672781035;4722.574968252874;4730.101280756645;5086.821961231339;5112;5121.92317115251;5123.001014802077;5128.948710512847;4725.692829966041;4728.645351598575;4731.645126615449;4733.573978341966;4733.739644319596;5038.622103342191;5039.2944987702485;5040.168372218543;5041.1430056889685;5041.168207245763;5062.974685126551;5113.488651134857;5115.616328775282;5116.386033675983;5119.385673719177;4987.127252730685;5005.749712514287;5006.873453472939;5007.499250074963;5009.499050094962;4998.300237966615;5016.774245159049;5020.42265139499;5042.873928151826;5094.694318340911;5017.197248440232;5018.598512118949;5019.62352823547;5024.522670346311;5073.568746656428;4902.583280421061;4919.926201107058;4985.551300382983;5089.338386009795;5129.333186685707;4926.704397736147;4989;5029;5035.697858128524;5048.091343558048 01:40:32 INFO - PROCESS | 4478 | |1;ext.html;558.9580781441393;562.2044806598664;566.450542973316;568.9004424225759;570.4666137161754;37241.44137837931;38720.806395968015;38942.22115557691;41747.37378939318;41767.37348939768;38967.41548876762;39333.80333098338;39389.212215755666;39488;39534.8023259884;7309.926900731004;7576.545407275554;7720.189380115091;7724;7726.729564465245;7264.4914855960105;7471.738489152881;7474.364679002291;7476.289752473534;9598.664046758366;9622.951885240564;9948.25388095892;9958.153556947667;9973.501324933724;9975.50122493876;9898.604055837757;9974.152197063258;9974.202063834911;9984.700458986243;9986.151177149952;9799.216062714966;9875;9879.506024698809;9882.604695812159;9882.752931176707;36712.449313260324;36978.44532332017;37039.629603704154;37093;37103.81448092769;2806.957895631567;2964.8962286320093;3010.4280186764445;3046.329807442359;3232.903012909593;27447.725522744717;27755.306117347027;27946.720532794614;28630;29790.404191916256;3017.9396412071856;3119.2201949512623;3152.5113607390663;3198.1684761961824;3239.1578189670618;245240;246342;246369;247263;247948;47620;47943.760281199066;48031.5196848034;48056;48074.519254807004;55940;56309.15536266959;56333.71833140808;56351.154732679046;56367.15449268264;13703;13871.167729936236;13875.861241387456;13877.097988630707;13878.097923635134;10339.741506462398;10346.172306215485;10356.430396328124;10369.792604147875;10405.375677459226;14956.551303460914;15294.94683908765;16651.91674041622;16964.915175424292;17271.56821079483;6393.552451328455;6530.836729081716;6573.309802470767;6587.901181482282;6680.23177334603;785.5051317669831;810.6190090657382;864.2783275964514;880.5509190312987;985.2216748768536;26898;26956.59565106525;27333.726662733516;27640.58539121915;27664;909.3907082254905;971.7813491964251;975.5366201054584;983.2920297385871;1027.0807627173788;14286.571402857931;14655.706885862222;14681.559553213421;14721.263936803118;14951.40194392234;377928;379658;380141;380353.0982345071;380974;47365;47919.76040119777;47934.48753393404;47974.28038579424;47983;1132.8697199822127;1133.3596517967321;1174.7591743692522;1176.3471273442979;1176.3823992404057;25583;26669.333266668487;26802.195934122006;27464.313392165357;27558.311042224104;41515.7924210377;41736.58263417448;41764.373534397615;41777.791111045466;41805.79097104495;328993;329266;329737;330132;330631;24931.87534062318;25306.240812775646;25348.239552813444;25353.450516928013;25371.112011079524;39690.60309396869;40243;41194.58805411908;41495.377569337084;41593.79203103965;33245.667543324256;34503.827480862434;34545.30909381848;35053.123671908405;35687.82156089307;34101.48847767335;34825.82587087048;34889.302213956085;35373.292534148655;36314;30663.2334191647;30976.535351969287;31093.68906310908;31567.84216078905;35153.64846351504;29957.85021074968;31006.379872401976;31557.684423155475;31637.20906977344;31952.520712189802;23963.05071529237;24109.74227344671;24387.14644987417;24732.134375296777;24743.62884556769 01:40:32 INFO - PROCESS | 4478 | |2;jquery.html;339.1769240333209;360.57092060448065;371.99070023249413;377.7997661239543;385.9208862183253;12457.314847683374;12522.874771252285;13273.867261327383;13553.457861685521;17163.91418042908;16507.33970641176;16683.666326673458;16713.164341782893;16864.83135168648;16903.07033113178;4828.975855120737;4852.951470485303;5047;5069.417017043051;5071.1632580624155;3553.9111522211892;3749.5875453700073;4979.626528010395;5075.695458272497;5079.212722028092;3719.423489359154;3755.4978008796425;3761.454589084581;3868.78721670308;5795.565332600051;5813.331466881278;5814.796482123126;5827.912581311284;5830.183774271605;5835.941640583625;4929.7781599828095;5085.618578606583;5091.0581542414775;5111.693298402108;5113.258577506278;19587.216511339528;20128.194872205095;20131;20218.79781202184;20343.5931281375;2190.299104286629;2427.1990243219693;2439.5852705040184;2480.6279058141245;2485.328961180471;12121.818172727417;12212.450439730233;12814.935925320313;13361.866381336256;13493.527726529524;1627.8697704183637;1643.391944980353;1661.6676664667116;1676.5221911755214;1678.899266044029;72251.63874180596;72761.6361918187;72913;73465.63267183684;73916;8953.194212520904;9041.412308199946;9127.726168214964;9258.537073146315;9316.906830931739;12072.215306005082;12089.939550302368;12091.45588448522;12180.939095304468;12185.573504927284;6617.735290588419;6626.271110177877;6761.8647627047185;6884.483663725241;7003.54476958996;6768.255491895888;6900.965495172492;6908.965455172692;7170.533915295489;7193.5324203926575;3682.8158592070827;3725.3294407006997;3760;3802.543694756647;3802.9809850951124;1573.5830005048672;1625.2280166920855;1629.9185040747916;1635.6973959817471;1646.382606522554;814.4543156085437;826.8222332198607;862.2756884217163;870.6952566601639;881.8544940084943;15611.921940390226;16376.83623163777;16528.917355413145;16771;16866.662666746597;856.3448961544424;859.1709000814244;875.9868601970848;881.2333270055093;899.0964081098585;8750.737477875675;8850.468971861708;9309.581068851918;9325.813483730422;9513.904860951441;283694;287495;392806;393444;405293.8941221159;53638;75963.62018189873;83223;84635;85739.14260857312;876.7282142535835;890.5235698901057;920.4799288402031;928.4800511713462;928.7770934975557;14851.405943762129;15067.853059601244;15508.767368489256;15795.684086318439;15874.52376428709;36429.45355819718;36565;36684.86411902389;37206;37639.42425469576;52536.73731631317;52825.471745282055;53160;53693.463065368844;54975;7047.6123813188715;7052.435805135679;7174.461915356474;7245.963770181115;7282.3809976152625;8532.616032278687;10949.069329107115;11512.53949841997;11852.229605075643;12243.32661703615;9904.455254961047;9921.305508614329;10183.236257280585;10221.131203847459;10422.895771042193;9652.324337296603;9828.4102953823;9870.75323116899;10023.398596084258;10161.898381016095;9735;10079.647212347532;10140;10457.895421045692;10931.070858976758;6963.199232088375;7088.964555177191;7116.608586527791;7195.424366050808;7379.446541509301;9465;9706.320557561185;10497.47512624381;10637.627683031365;10799.13606911461 01:40:32 INFO - PROCESS | 4478 | |3;mootools.html;1298.2664794391171;1363.5295822941084;1397.5737400092974;1623.7970253718286;1628.560288722045;6496.642684652342;6728.7215429068565;7046.203218179364;7451.776446706607;7456.142543607487;6958.756443524478;7293.854122917552;7307.451941104412;7326.853462930738;7458.552486850793;1989.6319180951498;2045.6829191475272;2054.352878843167;2062.4019034479984;2066.5143691232547;1695.5167777183506;1752.2990803678504;1972.3984184823623;2000.7999200080021;2001.7497812773404;1854.9629007419844;1923.7499125113716;1924.5765931495048;1924.653562358775;1931.9613607727838;1932.2271091563346;1941.1555973151653;1956.7847536771087;1959.6374670685898;1959.8824070555813;1981.5244341358114;1988.67186914159;2000.0299854570521;2000.1299434745786;2001.559656875485;7076.681549330293;7147.463295391463;7174.03150574671;7176.174739904925;7387.815304617374;4362.258416069276;4463.575960283768;4501.122281155176;4501.167284052461;4501.4598248210095;2593.312772115391;2877.1800036989357;2896.2469757862896;2901.361700425903;2902.622659054309;804.7304153108715;858.6307887608326;871.5859966515918;875.1467319363633;895.3240303570827;9534.237261019101;9736.561854716483;9769.706908792748;9808.16630586401;9831.262655300881;3825.464434979105;3886.018130753336;4002.179553191647;4014;4027.35562310029;8430.957845210858;8432;8432.45189062709;8437.240648341678;8446.915530844735;4350.499692535335;4436.423264975532;4438.267685831866;4439.200943830142;4440.511543730187;4019.2966230909474;4046.352583586671;4058.0869304406865;4058.979705101515;4060.8578699745367;3263.7878537894962;3347.1799409144915;3399.7280217582534;3401.9659803402146;3430.091025878144;988.4069558264983;1055.883852776194;1092.3609688332415;1095.1567293184203;1099.428297285407;680.7746057097205;757.7310054930421;794.6860989908954;816.9135050382977;842.4439869685978;4792.113459010095;4888.5111488850835;4942.678725882806;4945.2582112683385;4990.076835785391;860.8149247911729;883.8939327280767;893.8525143351275;900.6802585082202;905.6649039855164;3232.69289417505;3237.902862914116;3268.7875288106197;3288.128645908836;3579.2304654498885;8652.264557512555;8965.551722413853;9049.954750226207;9070.54647267634;9130.406523575946;8404.243618074403;8767.561621918878;8971.820563588692;8990.685326013689;9004.41471304363;6722.932770672329;6882.759103431456;6892.172939247323;6892.793216203522;6900.723971041102;4857.125717370907;4957.82647607332;4975.278584605285;5041.8487445376695;5142.485751424828;7912.525248485109;7961.482503637245;8005.879911801211;8048.798780030312;8127.918720812716;8040.5979701015885;8140.959295203486;8174.509529428254;8282.792930176794;8338.87491687613;6123.112148738319;6241.656708881055;6249.7500099997305;6253.593516421418;6270.0908368287255;6757;6898.241193468814;6951.652417379009;6957.304269573205;6997;4765.8570242892765;5915.852103697442;6158.291796443466;6198.318184999556;6261.060840873905;6147.631142131487;6171.444569988723;6180.227471566054;6223.719932602953;6413.134226879311;5808.157817116579;5828.94171058284;5863.970680146572;5869.148973398748;5886.529077673861;4113.773742444194;4130.421740956329;4292.055747735493;4322.113966636769;4421.115776844708;4198.118395137056;4205.17998990194;4350.303951367766;4354.976580503642;4355.4538138960215 01:40:32 INFO - PROCESS | 4478 | |4;prototype.html;274.39632807822795;284.4566877264425;285.6272564303584;286.537242353599;291.45061558961356;4734.4081989751285;4854.19905715557;4857.73282469464;4865.951340486598;4900.166971614825;4856;4867.683600565961;4868.683535570185;4877.341558889549;4895.608351331894;3597.460380942853;3693.686036686885;3825.101101241206;3826.330392181371;3833.4249862520564;3621.583517895436;3705.981470092646;3738.6261373862667;3743.4384842273603;3759.514991578325;3687.078230442389;3690.5940346561856;3721.79530125843;3724.757890737107;3737.9252414951684;3546.733994950363;3693.261347730465;3714.3499887519574;3730.1420673245034;3737.7383583149053;3129.7809153359276;3175;3187.362527494487;3193.9459978207137;3220.3559288142233;4642.466116396624;4646.3495110684535;4653.720776753372;4653.953460465385;4696.906061878777;4179.226843034018;4182.330827067654;4202.726822756511;4237.0890258594245;4239.40648309237;4966.031623833354;5003.624728145403;5006.74966251686;5009.1215794077225;5046.419661738873;3458.8758653437735;3466.0641626760885;3479.8434070466888;3491.0923159978333;3497.9475307870403;5241.68549887008;5267.209918512254;5293.6294459387855;5299.39057008449;5313.6014798889855;3451.6030656474327;3552.2717842842158;3590.8563657453933;3632.3824949758605;3634.9818250908575;3613.4941108244866;3628.401313783196;3632.9091772705365;3639.454081887738;3648.2521083178417;4170.687198460067;4180.749155050646;4217.219814334358;4225.239456897788;4232.798944548817;4968.373087646039;5033.874153146127;5049.141645920203;5061.215511595708;5093.337866077386;1217.72601164739;1231.8337024501757;1235.7899157143306;1236.9381530923597;1237.7833879071127;829.6598394658162;841.146236569882;857.6826574167474;861.67687117331;862.7066797288952;4243.384709217146;4283.31466965284;4290.549492303263;4294.377315289265;4306.784660766949;4936.284238785356;5076.7207803571155;5084.262781896604;5188.714620695822;5219.947800521946;4405.383246345515;4437.356583295404;4464.129494748558;4466.240739074366;4479.46246450428;2585.8060645451665;2649.807586586044;2672.47886662099;2677.759001689857;2684.7986401020003;4658.254679251304;4674.854660608173;4689.366935463737;4708.163816111719;4713.81144754206;5142.6400151989;5150.403374953777;5167.940572182693;5193.610479214074;5213.869653258699;4458.420405347284;4631.536846315409;4662.836800712027;4670.065986802653;4695.483496815347;4997.850494386239;5007.222436035301;5027.371578552681;5038.974805125951;5083.38999320084;4945.208766597327;4947.960928204973;4965.677230979974;4965.900681986413;4969.527894849984;4436.755978421218;4623.237165867594;4683.78922948475;4700.647451441224;4743.430788305287;3543.557055368079;3546.8758593449106;3548.9530588475945;3560.323538527775;3564.500969864273;5015.52352526524;5033.766727151871;5046.545810877039;5047.974760126176;5064.18972964324;4875.488073752205;4881.560659540658;4893.90212195747;4897.4857639947295;4900.8774780630765;4647.628189744744;4819.614430845454;4865.197242455097;4890.510948905081;4896.9471563614;4806.49531799156;4819;4820.25286080658;4820.3369837406035;4832.613390928647;4909.558139767438;4911.263310503453;4932.7533623319405;4949.480304568113;4953.1425715356745;4586.839460618996;4793.784279707352;4810.63920205993;4843.660943733905;4847.345608342828 01:40:32 INFO - PROCESS | 4478 | |5;yui.html;620.8851362497938;621.7337803705493;696.1993707236677;720.3121019426449;725.2566119727283;12611;12971.092023558354;13040.869591304085;13057.086003979724;13412.463501459943;11914.582989595367;12215.755684886319;12221.877781222185;12225.633231003061;12229.143959922787;753.5629334985723;764.8814433762748;765.8200322924108;766.6626684258908;769.3768047881234;602.8312072619674;626.9498440124779;723.9058922340089;750.5909279442717;750.6884642873201;792.1049214387763;792.9801754956144;794.6582969323189;796.6534557467492;796.7052190689453;781.1251398433734;782.1279273609913;782.1435528096725;782.9451938364317;783.1933108897845;469.36869909971034;478.96886702364236;561.3768716724433;574.431313000131;580.9919789165793;11647.184697071209;11648.971267470519;11657.183997120204;11666.708332291675;11668.766624667544;11373.431328433628;11490.310581365145;11768.117391195608;12029.09781766371;12263.75472490554;11361.886381136166;11460.255083419634;11477.540898364055;11672.941635291769;11694.883051169549;4187.497500299953;4198.5591512891315;4200.915981680349;4281.293586558214;4410.25025745624;64012.679936600485;65498.67250663764;67047;67727.66136169338;69310.30689693139;10201;10268.435236062089;10394.22043346752;10462.215333849992;10529.631462898762;19071.523211919535;19120.713189302172;19141.425757227305;19276.32532861343;19328.1302341395;6657.667116644246;6712.664366781642;6774.187097548326;6890.345417185359;7033.156021277479;3553.9289214216087;3569.1077230692326;3569.7322700797545;3620.9275814483562;3663.9633603663624;2631.3947792007943;2712.498187835257;2718.6873509546654;2722.5507791214227;2727.3999720061556;429.9634531064832;438.81131113620813;439.92081425343747;445.0054129021634;448.5536890793681;497.67651026832846;504.4854248666413;513.3352308760165;521.668740349873;532.475511621053;6950.200726916368;7602.201768814305;7704.114026886868;7859.803504912423;7929.881051784228;439.87463572881575;451.08429887328776;473.19556753519157;512.1472747874747;523.4320761973225;3563.3942229820473;3669.5779985302033;3708.2398108387715;3784;3884.6698030667144;73002.63498682472;73635.26364736391;74469.62765186139;75324.62337688386;75454.24545754472;63153.68423157855;63513;65002;66221;67720.6613966927;48642.27036594454;53725.731371342896;58044;58487.12269315964;59685.70157149187;7527.548347099191;8305.335573154012;8418.971147796407;8514.616842242238;8581.227689507974;38591;39522.41910323555;40348;40385.59614403819;40411;46495.53504464912;52493.475065250386;54054.45945540494;54311.91376172534;55389;11959.581414650793;12033.4584943676;12046.879531204926;12170.330631815335;12486.188397754117;12604.180728252633;12736.23582585048;13060.738785224432;13559.525416610371;13658.658533536742;11124.332540047622;11321.320720756781;11633.243839150427;11643.301401915913;12149.453274602842;10612.522436490532;11075.612353567909;11492.48283827213;12267.938660306641;12317.876821231674;11557.884421156017;11712.531498739954;11735.882641173479;12292.446839892405;12486.875131248571;8886.422382545114;9063.728088157102;9179.632814687338;9281.118293762082;9490;8695.695645653203;9902.900970990198;9912.950435247778;10093.646722364681;10109.518955972675 01:40:32 INFO - PROCESS | 4478 | __end_tp_report 01:40:32 INFO - PROCESS | 4478 | __start_cc_report 01:40:32 INFO - PROCESS | 4478 | _x_x_mozilla_cycle_collect,2735 01:40:32 INFO - PROCESS | 4478 | __end_cc_report 01:40:32 INFO - PROCESS | 4478 | __startTimestamp1480671632171__endTimestamp 01:40:32 INFO - PROCESS | 4478 | 01:40:32 INFO - PROCESS | 4478 | ------- Summary: start ------- 01:40:32 INFO - PROCESS | 4478 | Number of tests: 6 01:40:32 INFO - PROCESS | 4478 | 01:40:32 INFO - PROCESS | 4478 | [#0] dojo.html Cycles:165 Average:4753.59 Median:4841.61 stddev:485.78 (10.0%) stddev-sans-first:458.19 01:40:32 INFO - PROCESS | 4478 | Values: 2642.9 2654.9 2664.9 2690.9 2700.7 4697.8 4744.1 4801.8 4842.3 4884.9 4738.8 4786.0 4798.5 4818.4 4873.5 4432.3 4434.3 4455.4 4482.2 4486.4 4395.8 4435.3 4522.2 4528.1 4589.5 4516.8 4575.3 4575.9 4607.5 4609.7 4287.7 4323.0 4332.1 4374.4 4514.7 4363.2 4365.0 4371.3 4399.6 4434.5 4701.3 4736.8 4750.4 4760.1 4781.1 4943.4 4970.8 5105.5 5109.8 5143.7 5060.1 5112.4 5174.7 5183.4 5248.3 4812.7 4815.2 4815.8 4822.8 4864.8 5296.6 5307.8 5312.5 5314.8 5319.6 4855.9 4879.6 4880.2 5052.2 5082.1 5193.2 5204.5 5204.8 5234.6 5257.7 5115.9 5140.7 5152.4 5203.1 5208.5 4822.4 4841.6 4846.3 5082.5 5145.8 4444.8 4477.2 4479.4 4492.8 4533.5 3890.4 3899.9 3900.0 3937.1 3947.4 4282.8 4461.6 4473.9 4479.2 4513.3 5038.8 5154.6 5156.9 5158.6 5266.8 4437.1 4444.4 4444.6 4448.4 4488.3 4714.6 4715.5 4721.2 4722.9 4762.3 4658.4 4684.4 4684.6 4722.6 4730.1 5086.8 5112.0 5121.9 5123.0 5128.9 4725.7 4728.6 4731.6 4733.6 4733.7 5038.6 5039.3 5040.2 5041.1 5041.2 5063.0 5113.5 5115.6 5116.4 5119.4 4987.1 5005.7 5006.9 5007.5 5009.5 4998.3 5016.8 5020.4 5042.9 5094.7 5017.2 5018.6 5019.6 5024.5 5073.6 4902.6 4919.9 4985.6 5089.3 5129.3 4926.7 4989.0 5029.0 5035.7 5048.1 01:40:32 INFO - PROCESS | 4478 | 01:40:32 INFO - PROCESS | 4478 | [#1] ext.html Cycles:180 Average:46896.30 Median:36513.22 stddev:85136.93 (233.2%) stddev-sans-first:85304.67 01:40:32 INFO - PROCESS | 4478 | Values: 559.0 562.2 566.5 568.9 570.5 37241.4 38720.8 38942.2 41747.4 41767.4 38967.4 39333.8 39389.2 39488.0 39534.8 7309.9 7576.5 7720.2 7724.0 7726.7 7264.5 7471.7 7474.4 7476.3 9598.7 9623.0 9948.3 9958.2 9973.5 9975.5 9898.6 9974.2 9974.2 9984.7 9986.2 9799.2 9875.0 9879.5 9882.6 9882.8 36712.4 36978.4 37039.6 37093.0 37103.8 2807.0 2964.9 3010.4 3046.3 3232.9 27447.7 27755.3 27946.7 28630.0 29790.4 3017.9 3119.2 3152.5 3198.2 3239.2 245240.0 246342.0 246369.0 247263.0 247948.0 47620.0 47943.8 48031.5 48056.0 48074.5 55940.0 56309.2 56333.7 56351.2 56367.2 13703.0 13871.2 13875.9 13877.1 13878.1 10339.7 10346.2 10356.4 10369.8 10405.4 14956.6 15294.9 16651.9 16964.9 17271.6 6393.6 6530.8 6573.3 6587.9 6680.2 785.5 810.6 864.3 880.6 985.2 26898.0 26956.6 27333.7 27640.6 27664.0 909.4 971.8 975.5 983.3 1027.1 14286.6 14655.7 14681.6 14721.3 14951.4 377928.0 379658.0 380141.0 380353.1 380974.0 47365.0 47919.8 47934.5 47974.3 47983.0 1132.9 1133.4 1174.8 1176.3 1176.4 25583.0 26669.3 26802.2 27464.3 27558.3 41515.8 41736.6 41764.4 41777.8 41805.8 328993.0 329266.0 329737.0 330132.0 330631.0 24931.9 25306.2 25348.2 25353.5 25371.1 39690.6 40243.0 41194.6 41495.4 41593.8 33245.7 34503.8 34545.3 35053.1 35687.8 34101.5 34825.8 34889.3 35373.3 36314.0 30663.2 30976.5 31093.7 31567.8 35153.6 29957.9 31006.4 31557.7 31637.2 31952.5 23963.1 24109.7 24387.1 24732.1 24743.6 01:40:32 INFO - PROCESS | 4478 | 01:40:32 INFO - PROCESS | 4478 | [#2] jquery.html Cycles:180 Average:23190.62 Median:399368.95 stddev:59386.51 (14.9%) stddev-sans-first:59528.32 01:40:32 INFO - PROCESS | 4478 | Values: 339.2 360.6 372.0 377.8 385.9 12457.3 12522.9 13273.9 13553.5 17163.9 16507.3 16683.7 16713.2 16864.8 16903.1 4829.0 4853.0 5047.0 5069.4 5071.2 3553.9 3749.6 4979.6 5075.7 5079.2 3719.4 3755.5 3761.5 3868.8 5795.6 5813.3 5814.8 5827.9 5830.2 5835.9 4929.8 5085.6 5091.1 5111.7 5113.3 19587.2 20128.2 20131.0 20218.8 20343.6 2190.3 2427.2 2439.6 2480.6 2485.3 12121.8 12212.5 12814.9 13361.9 13493.5 1627.9 1643.4 1661.7 1676.5 1678.9 72251.6 72761.6 72913.0 73465.6 73916.0 8953.2 9041.4 9127.7 9258.5 9316.9 12072.2 12089.9 12091.5 12180.9 12185.6 6617.7 6626.3 6761.9 6884.5 7003.5 6768.3 6901.0 6909.0 7170.5 7193.5 3682.8 3725.3 3760.0 3802.5 3803.0 1573.6 1625.2 1629.9 1635.7 1646.4 814.5 826.8 862.3 870.7 881.9 15611.9 16376.8 16528.9 16771.0 16866.7 856.3 859.2 876.0 881.2 899.1 8750.7 8850.5 9309.6 9325.8 9513.9 283694.0 287495.0 392806.0 393444.0 405293.9 53638.0 75963.6 83223.0 84635.0 85739.1 876.7 890.5 920.5 928.5 928.8 14851.4 15067.9 15508.8 15795.7 15874.5 36429.5 36565.0 36684.9 37206.0 37639.4 52536.7 52825.5 53160.0 53693.5 54975.0 7047.6 7052.4 7174.5 7246.0 7282.4 8532.6 10949.1 11512.5 11852.2 12243.3 9904.5 9921.3 10183.2 10221.1 10422.9 9652.3 9828.4 9870.8 10023.4 10161.9 9735.0 10079.6 10140.0 10457.9 10931.1 6963.2 7089.0 7116.6 7195.4 7379.4 9465.0 9706.3 10497.5 10637.6 10799.1 01:40:32 INFO - PROCESS | 4478 | 01:40:32 INFO - PROCESS | 4478 | [#3] mootools.html Cycles:180 Average:4758.95 Median:5818.55 stddev:2633.71 (45.3%) stddev-sans-first:2628.26 01:40:32 INFO - PROCESS | 4478 | Values: 1298.3 1363.5 1397.6 1623.8 1628.6 6496.6 6728.7 7046.2 7451.8 7456.1 6958.8 7293.9 7307.5 7326.9 7458.6 1989.6 2045.7 2054.4 2062.4 2066.5 1695.5 1752.3 1972.4 2000.8 2001.7 1855.0 1923.7 1924.6 1924.7 1932.0 1932.2 1941.2 1956.8 1959.6 1959.9 1981.5 1988.7 2000.0 2000.1 2001.6 7076.7 7147.5 7174.0 7176.2 7387.8 4362.3 4463.6 4501.1 4501.2 4501.5 2593.3 2877.2 2896.2 2901.4 2902.6 804.7 858.6 871.6 875.1 895.3 9534.2 9736.6 9769.7 9808.2 9831.3 3825.5 3886.0 4002.2 4014.0 4027.4 8431.0 8432.0 8432.5 8437.2 8446.9 4350.5 4436.4 4438.3 4439.2 4440.5 4019.3 4046.4 4058.1 4059.0 4060.9 3263.8 3347.2 3399.7 3402.0 3430.1 988.4 1055.9 1092.4 1095.2 1099.4 680.8 757.7 794.7 816.9 842.4 4792.1 4888.5 4942.7 4945.3 4990.1 860.8 883.9 893.9 900.7 905.7 3232.7 3237.9 3268.8 3288.1 3579.2 8652.3 8965.6 9050.0 9070.5 9130.4 8404.2 8767.6 8971.8 8990.7 9004.4 6722.9 6882.8 6892.2 6892.8 6900.7 4857.1 4957.8 4975.3 5041.8 5142.5 7912.5 7961.5 8005.9 8048.8 8127.9 8040.6 8141.0 8174.5 8282.8 8338.9 6123.1 6241.7 6249.8 6253.6 6270.1 6757.0 6898.2 6951.7 6957.3 6997.0 4765.9 5915.9 6158.3 6198.3 6261.1 6147.6 6171.4 6180.2 6223.7 6413.1 5808.2 5828.9 5864.0 5869.1 5886.5 4113.8 4130.4 4292.1 4322.1 4421.1 4198.1 4205.2 4350.3 4355.0 4355.5 01:40:32 INFO - PROCESS | 4478 | 01:40:32 INFO - PROCESS | 4478 | [#4] prototype.html Cycles:180 Average:4101.53 Median:4660.55 stddev:1196.49 (25.7%) stddev-sans-first:1164.86 01:40:32 INFO - PROCESS | 4478 | Values: 274.4 284.5 285.6 286.5 291.5 4734.4 4854.2 4857.7 4866.0 4900.2 4856.0 4867.7 4868.7 4877.3 4895.6 3597.5 3693.7 3825.1 3826.3 3833.4 3621.6 3706.0 3738.6 3743.4 3759.5 3687.1 3690.6 3721.8 3724.8 3737.9 3546.7 3693.3 3714.3 3730.1 3737.7 3129.8 3175.0 3187.4 3193.9 3220.4 4642.5 4646.3 4653.7 4654.0 4696.9 4179.2 4182.3 4202.7 4237.1 4239.4 4966.0 5003.6 5006.7 5009.1 5046.4 3458.9 3466.1 3479.8 3491.1 3497.9 5241.7 5267.2 5293.6 5299.4 5313.6 3451.6 3552.3 3590.9 3632.4 3635.0 3613.5 3628.4 3632.9 3639.5 3648.3 4170.7 4180.7 4217.2 4225.2 4232.8 4968.4 5033.9 5049.1 5061.2 5093.3 1217.7 1231.8 1235.8 1236.9 1237.8 829.7 841.1 857.7 861.7 862.7 4243.4 4283.3 4290.5 4294.4 4306.8 4936.3 5076.7 5084.3 5188.7 5219.9 4405.4 4437.4 4464.1 4466.2 4479.5 2585.8 2649.8 2672.5 2677.8 2684.8 4658.3 4674.9 4689.4 4708.2 4713.8 5142.6 5150.4 5167.9 5193.6 5213.9 4458.4 4631.5 4662.8 4670.1 4695.5 4997.9 5007.2 5027.4 5039.0 5083.4 4945.2 4948.0 4965.7 4965.9 4969.5 4436.8 4623.2 4683.8 4700.6 4743.4 3543.6 3546.9 3549.0 3560.3 3564.5 5015.5 5033.8 5046.5 5048.0 5064.2 4875.5 4881.6 4893.9 4897.5 4900.9 4647.6 4819.6 4865.2 4890.5 4896.9 4806.5 4819.0 4820.3 4820.3 4832.6 4909.6 4911.3 4932.8 4949.5 4953.1 4586.8 4793.8 4810.6 4843.7 4847.3 01:40:32 INFO - PROCESS | 4478 | 01:40:32 INFO - PROCESS | 4478 | [#5] yui.html Cycles:180 Average:15721.28 Median:2427.63 stddev:20575.04 (847.5%) stddev-sans-first:20601.51 01:40:32 INFO - PROCESS | 4478 | Values: 620.9 621.7 696.2 720.3 725.3 12611.0 12971.1 13040.9 13057.1 13412.5 11914.6 12215.8 12221.9 12225.6 12229.1 753.6 764.9 765.8 766.7 769.4 602.8 626.9 723.9 750.6 750.7 792.1 793.0 794.7 796.7 796.7 781.1 782.1 782.1 782.9 783.2 469.4 479.0 561.4 574.4 581.0 11647.2 11649.0 11657.2 11666.7 11668.8 11373.4 11490.3 11768.1 12029.1 12263.8 11361.9 11460.3 11477.5 11672.9 11694.9 4187.5 4198.6 4200.9 4281.3 4410.3 64012.7 65498.7 67047.0 67727.7 69310.3 10201.0 10268.4 10394.2 10462.2 10529.6 19071.5 19120.7 19141.4 19276.3 19328.1 6657.7 6712.7 6774.2 6890.3 7033.2 3553.9 3569.1 3569.7 3620.9 3664.0 2631.4 2712.5 2718.7 2722.6 2727.4 430.0 438.8 439.9 445.0 448.6 497.7 504.5 513.3 521.7 532.5 6950.2 7602.2 7704.1 7859.8 7929.9 439.9 451.1 473.2 512.1 523.4 3563.4 3669.6 3708.2 3784.0 3884.7 73002.6 73635.3 74469.6 75324.6 75454.2 63153.7 63513.0 65002.0 66221.0 67720.7 48642.3 53725.7 58044.0 58487.1 59685.7 7527.5 8305.3 8419.0 8514.6 8581.2 38591.0 39522.4 40348.0 40385.6 40411.0 46495.5 52493.5 54054.5 54311.9 55389.0 11959.6 12033.5 12046.9 12170.3 12486.2 12604.2 12736.2 13060.7 13559.5 13658.7 11124.3 11321.3 11633.2 11643.3 12149.5 10612.5 11075.6 11492.5 12267.9 12317.9 11557.9 11712.5 11735.9 12292.4 12486.9 8886.4 9063.7 9179.6 9281.1 9490.0 8695.7 9902.9 9913.0 10093.6 10109.5 01:40:32 INFO - PROCESS | 4478 | -------- Summary: end -------- 01:40:32 INFO - PROCESS | 4478 | 01:40:33 INFO - TEST-INFO | 4478: exit 0 01:40:33 INFO - TEST-OK | dromaeo_css | took 1123419ms 01:40:33 INFO - TEST-START | kraken 01:40:33 INFO - operating with platform_type : linux_ 01:40:33 INFO - Initialising browser for kraken test... 01:40:33 INFO - TEST-INFO | started process 4782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE5cKt0/profile http://localhost:42734/getInfo.html) 01:40:37 INFO - PROCESS | 4782 | __metrics Screen width/height:1600/1200 01:40:37 INFO - PROCESS | 4782 | colorDepth:24 01:40:37 INFO - PROCESS | 4782 | Browser inner width/height: 1024/697 01:40:37 INFO - PROCESS | 4782 | __metrics 01:40:37 INFO - PROCESS | 4782 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:40:37 INFO - PROCESS | 4782 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:40:38 INFO - PROCESS | 4782 | console.error: PushService: 01:40:38 INFO - PROCESS | 4782 | stateChangeProcessEnqueue: Error transitioning state 01:40:38 INFO - PROCESS | 4782 | UnknownError 01:40:39 INFO - TEST-INFO | 4782: exit 0 01:40:39 INFO - Browser initialized. 01:40:39 INFO - Running cycle 1/1 for kraken test... 01:40:39 INFO - TEST-INFO | started process 4865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE5cKt0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:40:51 INFO - PROCESS | 4865 | RSS: Main: 175382528 01:40:51 INFO - PROCESS | 4865 | 01:40:53 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42734/tests/kraken/driver.html?testName=audio-beat-detection) 01:40:54 INFO - PROCESS | 4865 | RSS: Main: 236253184 01:40:54 INFO - PROCESS | 4865 | 01:40:57 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42734/tests/kraken/driver.html?testName=audio-dft) 01:40:58 INFO - PROCESS | 4865 | RSS: Main: 218460160 01:40:58 INFO - PROCESS | 4865 | 01:41:01 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42734/tests/kraken/driver.html?testName=audio-fft) 01:41:02 INFO - PROCESS | 4865 | RSS: Main: 300290048 01:41:02 INFO - PROCESS | 4865 | 01:41:04 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42734/tests/kraken/driver.html?testName=audio-oscillator) 01:41:04 INFO - PROCESS | 4865 | RSS: Main: 210591744 01:41:04 INFO - PROCESS | 4865 | 01:41:07 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:41:07 INFO - PROCESS | 4865 | RSS: Main: 215158784 01:41:07 INFO - PROCESS | 4865 | 01:41:10 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42734/tests/kraken/driver.html?testName=imaging-darkroom) 01:41:11 INFO - PROCESS | 4865 | RSS: Main: 254246912 01:41:11 INFO - PROCESS | 4865 | 01:41:14 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42734/tests/kraken/driver.html?testName=imaging-desaturate) 01:41:15 INFO - PROCESS | 4865 | RSS: Main: 248401920 01:41:15 INFO - PROCESS | 4865 | 01:41:18 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42734/tests/kraken/driver.html?testName=json-parse-financial) 01:41:19 INFO - PROCESS | 4865 | RSS: Main: 250220544 01:41:19 INFO - PROCESS | 4865 | 01:41:20 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:41:21 INFO - PROCESS | 4865 | RSS: Main: 213430272 01:41:21 INFO - PROCESS | 4865 | 01:41:23 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42734/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:41:23 INFO - PROCESS | 4865 | RSS: Main: 220946432 01:41:23 INFO - PROCESS | 4865 | 01:41:26 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:41:26 INFO - PROCESS | 4865 | RSS: Main: 229216256 01:41:26 INFO - PROCESS | 4865 | 01:41:29 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:41:30 INFO - PROCESS | 4865 | RSS: Main: 238669824 01:41:30 INFO - PROCESS | 4865 | 01:41:33 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:41:34 INFO - PROCESS | 4865 | RSS: Main: 235229184 01:41:34 INFO - PROCESS | 4865 | 01:41:35 INFO - PROCESS | 4865 | Cycle 1(1): loaded http://localhost:42734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42734/tests/kraken/driver.html?testName=ai-astar) 01:41:36 INFO - PROCESS | 4865 | RSS: Main: 285450240 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | __start_tp_report 01:41:36 INFO - PROCESS | 4865 | _x_x_mozilla_page_load 01:41:36 INFO - PROCESS | 4865 | _x_x_mozilla_page_load_details 01:41:36 INFO - PROCESS | 4865 | |i|pagename|runs| 01:41:36 INFO - PROCESS | 4865 | |0;ai-astar;108;114;115;116;115;115;115;115;113;114 01:41:36 INFO - PROCESS | 4865 | |1;audio-beat-detection;154;136;129;183;134;130;131;138;164;130 01:41:36 INFO - PROCESS | 4865 | |2;audio-dft;161;161;162;162;163;162;163;162;162;159 01:41:36 INFO - PROCESS | 4865 | |3;audio-fft;76;75;77;111;78;79;77;77;90;77 01:41:36 INFO - PROCESS | 4865 | |4;audio-oscillator;85;84;106;84;84;83;108;83;83;108 01:41:36 INFO - PROCESS | 4865 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;116 01:41:36 INFO - PROCESS | 4865 | |6;imaging-darkroom;148;149;147;148;147;149;148;147;148;147 01:41:36 INFO - PROCESS | 4865 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 01:41:36 INFO - PROCESS | 4865 | |8;json-parse-financial;68;67;68;68;67;69;68;68;68;69 01:41:36 INFO - PROCESS | 4865 | |9;json-stringify-tinderbox;65;67;66;66;67;67;67;67;69;68 01:41:36 INFO - PROCESS | 4865 | |10;stanford-crypto-aes;85;85;83;84;84;91;84;94;83;85 01:41:36 INFO - PROCESS | 4865 | |11;stanford-crypto-ccm;148;145;148;152;148;153;144;143;196;139 01:41:36 INFO - PROCESS | 4865 | |12;stanford-crypto-pbkdf2;182;178;178;176;175;181;178;177;183;177 01:41:36 INFO - PROCESS | 4865 | |13;stanford-crypto-sha256-iterative;71;73;71;71;72;71;72;70;71;71 01:41:36 INFO - PROCESS | 4865 | __end_tp_report 01:41:36 INFO - PROCESS | 4865 | __start_cc_report 01:41:36 INFO - PROCESS | 4865 | _x_x_mozilla_cycle_collect,1976 01:41:36 INFO - PROCESS | 4865 | __end_cc_report 01:41:36 INFO - PROCESS | 4865 | __startTimestamp1480671696103__endTimestamp 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | ------- Summary: start ------- 01:41:36 INFO - PROCESS | 4865 | Number of tests: 14 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:2.26 (2.0%) stddev-sans-first:0.87 01:41:36 INFO - PROCESS | 4865 | Values: 108.0 114.0 115.0 116.0 115.0 115.0 115.0 115.0 113.0 114.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:137.00 stddev:18.24 (13.3%) stddev-sans-first:18.90 01:41:36 INFO - PROCESS | 4865 | Values: 154.0 136.0 129.0 183.0 134.0 130.0 131.0 138.0 164.0 130.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 01:41:36 INFO - PROCESS | 4865 | Values: 161.0 161.0 162.0 162.0 163.0 162.0 163.0 162.0 162.0 159.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#3] audio-fft Cycles:10 Average:81.70 Median:77.00 stddev:11.13 (14.4%) stddev-sans-first:11.61 01:41:36 INFO - PROCESS | 4865 | Values: 76.0 75.0 77.0 111.0 78.0 79.0 77.0 77.0 90.0 77.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:83.50 stddev:11.44 (13.7%) stddev-sans-first:11.94 01:41:36 INFO - PROCESS | 4865 | Values: 85.0 84.0 106.0 84.0 84.0 83.0 108.0 83.0 83.0 108.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:41:36 INFO - PROCESS | 4865 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 01:41:36 INFO - PROCESS | 4865 | Values: 148.0 149.0 147.0 148.0 147.0 149.0 148.0 147.0 148.0 147.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:41:36 INFO - PROCESS | 4865 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:41:36 INFO - PROCESS | 4865 | Values: 68.0 67.0 68.0 68.0 67.0 69.0 68.0 68.0 68.0 69.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:0.93 01:41:36 INFO - PROCESS | 4865 | Values: 65.0 67.0 66.0 66.0 67.0 67.0 67.0 67.0 69.0 68.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:3.68 (4.3%) stddev-sans-first:3.89 01:41:36 INFO - PROCESS | 4865 | Values: 85.0 85.0 83.0 84.0 84.0 91.0 84.0 94.0 83.0 85.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:148.00 stddev:16.15 (10.9%) stddev-sans-first:17.07 01:41:36 INFO - PROCESS | 4865 | Values: 148.0 145.0 148.0 152.0 148.0 153.0 144.0 143.0 196.0 139.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:178.00 stddev:2.64 (1.5%) stddev-sans-first:2.47 01:41:36 INFO - PROCESS | 4865 | Values: 182.0 178.0 178.0 176.0 175.0 181.0 178.0 177.0 183.0 177.0 01:41:36 INFO - PROCESS | 4865 | 01:41:36 INFO - PROCESS | 4865 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 01:41:36 INFO - PROCESS | 4865 | Values: 71.0 73.0 71.0 71.0 72.0 71.0 72.0 70.0 71.0 71.0 01:41:36 INFO - PROCESS | 4865 | -------- Summary: end -------- 01:41:36 INFO - PROCESS | 4865 | 01:41:37 INFO - TEST-INFO | 4865: exit 0 01:41:37 INFO - TEST-OK | kraken | took 64202ms 01:41:37 INFO - SUITE-END | took 1187s 01:41:37 INFO - Completed test suite (00:19:47) 01:41:37 INFO - javascript benchmark 01:41:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.9339266518336, 2654.8938042478303, 2664.8934042638302, 2690.9461810763787, 2700.66241719785, 4697.812087516504, 4744.098621261966, 4801.807927682893, 4842.297866809315, 4884.85345439637, 4738.810447582093, 4786.042791441708, 4798.520147985199, 4818.397700287464, 4873.537013983666, 4432.290833466646, 4434.290513517838, 4455.376247325377, 4482.17079840229, 4486.394336764544, 4395.802188901491, 4435.290353543433, 4522.209668787535, 4528.139653465831, 4589.518100599439, 4516.819327226907, 4575.290829921368, 4575.908481830362, 4607.470140933785, 4609.7234165949985, 4287.678424118172, 4322.978385108086, 4332.090261045184, 4374.431323927869, 4514.706544074625, 4363.192809330284, 4364.978175109136, 4371.27873900806, 4399.5820397062225, 4434.512203657595, 4701.294805779126, 4736.786844592001, 4750.406199225097, 4760.071786001731, 4781.115493633689, 4943.431505376891, 4970.776315065831, 5105.5149760772665, 5109.821156259551, 5143.717095559743, 5060.089183946888, 5112.386513618352, 5174.741262936838, 5183.377994640629, 5248.265242866002, 4812.687175333592, 4815.2054910939305, 4815.831445899376, 4822.758862056953, 4864.756762161877, 5296.629235953524, 5307.814226502054, 5312.5218730314455, 5314.840554783363, 5319.5744340452675, 4855.902881942341, 4879.634027447955, 4880.194767863334, 5052.242163675478, 5082.1360368737405, 5193.246979187997, 5204.4535323791215, 5204.8178313758835, 5234.555062819627, 5257.684538927677, 5115.897682046339, 5140.717260550706, 5152.355955505562, 5203.063448579216, 5208.479152084761, 4822.445418776815, 4841.612670986313, 4846.29728689338, 5082.517160869711, 5145.819896303611, 4444.755538445352, 4477.171723231213, 4479.417675702203, 4492.775361231926, 4533.546645335506, 3890.3775395936514, 3899.863504777319, 3899.980500097538, 3937.1338305572726, 3947.388154836005, 4282.807273672693, 4461.576150265784, 4473.888152796206, 4479.238529450001, 4513.277875539898, 5038.823641172541, 5154.639175257771, 5156.8968620627375, 5158.63889527737, 5266.815661451831, 4437.090396468716, 4444.377787109807, 4444.577765112309, 4448.377227188196, 4488.304312831517, 4714.6464015199, 4715.528447155257, 4721.244600863914, 4722.858314250578, 4762.333273341735, 4658.440987081572, 4684.414448193976, 4684.5549672781035, 4722.574968252874, 4730.101280756645, 5086.821961231339, 5112.0, 5121.92317115251, 5123.001014802077, 5128.948710512847, 4725.692829966041, 4728.645351598575, 4731.645126615449, 4733.573978341966, 4733.739644319596, 5038.622103342191, 5039.2944987702485, 5040.168372218543, 5041.1430056889685, 5041.168207245763, 5062.974685126551, 5113.488651134857, 5115.616328775282, 5116.386033675983, 5119.385673719177, 4987.127252730685, 5005.749712514287, 5006.873453472939, 5007.499250074963, 5009.499050094962, 4998.300237966615, 5016.774245159049, 5020.42265139499, 5042.873928151826, 5094.694318340911, 5017.197248440232, 5018.598512118949, 5019.62352823547, 5024.522670346311, 5073.568746656428, 4902.583280421061, 4919.926201107058, 4985.551300382983, 5089.338386009795, 5129.333186685707, 4926.704397736147, 4989.0, 5029.0, 5035.697858128524, 5048.091343558048], "value": 4723.093451101766, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9580781441393, 562.2044806598664, 566.450542973316, 568.9004424225759, 570.4666137161754, 37241.44137837931, 38720.806395968015, 38942.22115557691, 41747.37378939318, 41767.37348939768, 38967.41548876762, 39333.80333098338, 39389.212215755666, 39488.0, 39534.8023259884, 7309.926900731004, 7576.545407275554, 7720.189380115091, 7724.0, 7726.729564465245, 7264.4914855960105, 7471.738489152881, 7474.364679002291, 7476.289752473534, 9598.664046758366, 9622.951885240564, 9948.25388095892, 9958.153556947667, 9973.501324933724, 9975.50122493876, 9898.604055837757, 9974.152197063258, 9974.202063834911, 9984.700458986243, 9986.151177149952, 9799.216062714966, 9875.0, 9879.506024698809, 9882.604695812159, 9882.752931176707, 36712.449313260324, 36978.44532332017, 37039.629603704154, 37093.0, 37103.81448092769, 2806.957895631567, 2964.8962286320093, 3010.4280186764445, 3046.329807442359, 3232.903012909593, 27447.725522744717, 27755.306117347027, 27946.720532794614, 28630.0, 29790.404191916256, 3017.9396412071856, 3119.2201949512623, 3152.5113607390663, 3198.1684761961824, 3239.1578189670618, 245240.0, 246342.0, 246369.0, 247263.0, 247948.0, 47620.0, 47943.760281199066, 48031.5196848034, 48056.0, 48074.519254807004, 55940.0, 56309.15536266959, 56333.71833140808, 56351.154732679046, 56367.15449268264, 13703.0, 13871.167729936236, 13875.861241387456, 13877.097988630707, 13878.097923635134, 10339.741506462398, 10346.172306215485, 10356.430396328124, 10369.792604147875, 10405.375677459226, 14956.551303460914, 15294.94683908765, 16651.91674041622, 16964.915175424292, 17271.56821079483, 6393.552451328455, 6530.836729081716, 6573.309802470767, 6587.901181482282, 6680.23177334603, 785.5051317669831, 810.6190090657382, 864.2783275964514, 880.5509190312987, 985.2216748768536, 26898.0, 26956.59565106525, 27333.726662733516, 27640.58539121915, 27664.0, 909.3907082254905, 971.7813491964251, 975.5366201054584, 983.2920297385871, 1027.0807627173788, 14286.571402857931, 14655.706885862222, 14681.559553213421, 14721.263936803118, 14951.40194392234, 377928.0, 379658.0, 380141.0, 380353.0982345071, 380974.0, 47365.0, 47919.76040119777, 47934.48753393404, 47974.28038579424, 47983.0, 1132.8697199822127, 1133.3596517967321, 1174.7591743692522, 1176.3471273442979, 1176.3823992404057, 25583.0, 26669.333266668487, 26802.195934122006, 27464.313392165357, 27558.311042224104, 41515.7924210377, 41736.58263417448, 41764.373534397615, 41777.791111045466, 41805.79097104495, 328993.0, 329266.0, 329737.0, 330132.0, 330631.0, 24931.87534062318, 25306.240812775646, 25348.239552813444, 25353.450516928013, 25371.112011079524, 39690.60309396869, 40243.0, 41194.58805411908, 41495.377569337084, 41593.79203103965, 33245.667543324256, 34503.827480862434, 34545.30909381848, 35053.123671908405, 35687.82156089307, 34101.48847767335, 34825.82587087048, 34889.302213956085, 35373.292534148655, 36314.0, 30663.2334191647, 30976.535351969287, 31093.68906310908, 31567.84216078905, 35153.64846351504, 29957.85021074968, 31006.379872401976, 31557.684423155475, 31637.20906977344, 31952.520712189802, 23963.05071529237, 24109.74227344671, 24387.14644987417, 24732.134375296777, 24743.62884556769], "value": 17352.31643933649, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.1769240333209, 360.57092060448065, 371.99070023249413, 377.7997661239543, 385.9208862183253, 12457.314847683374, 12522.874771252285, 13273.867261327383, 13553.457861685521, 17163.91418042908, 16507.33970641176, 16683.666326673458, 16713.164341782893, 16864.83135168648, 16903.07033113178, 4828.975855120737, 4852.951470485303, 5047.0, 5069.417017043051, 5071.1632580624155, 3553.9111522211892, 3749.5875453700073, 4979.626528010395, 5075.695458272497, 5079.212722028092, 3719.423489359154, 3755.4978008796425, 3761.454589084581, 3868.78721670308, 5795.565332600051, 5813.331466881278, 5814.796482123126, 5827.912581311284, 5830.183774271605, 5835.941640583625, 4929.7781599828095, 5085.618578606583, 5091.0581542414775, 5111.693298402108, 5113.258577506278, 19587.216511339528, 20128.194872205095, 20131.0, 20218.79781202184, 20343.5931281375, 2190.299104286629, 2427.1990243219693, 2439.5852705040184, 2480.6279058141245, 2485.328961180471, 12121.818172727417, 12212.450439730233, 12814.935925320313, 13361.866381336256, 13493.527726529524, 1627.8697704183637, 1643.391944980353, 1661.6676664667116, 1676.5221911755214, 1678.899266044029, 72251.63874180596, 72761.6361918187, 72913.0, 73465.63267183684, 73916.0, 8953.194212520904, 9041.412308199946, 9127.726168214964, 9258.537073146315, 9316.906830931739, 12072.215306005082, 12089.939550302368, 12091.45588448522, 12180.939095304468, 12185.573504927284, 6617.735290588419, 6626.271110177877, 6761.8647627047185, 6884.483663725241, 7003.54476958996, 6768.255491895888, 6900.965495172492, 6908.965455172692, 7170.533915295489, 7193.5324203926575, 3682.8158592070827, 3725.3294407006997, 3760.0, 3802.543694756647, 3802.9809850951124, 1573.5830005048672, 1625.2280166920855, 1629.9185040747916, 1635.6973959817471, 1646.382606522554, 814.4543156085437, 826.8222332198607, 862.2756884217163, 870.6952566601639, 881.8544940084943, 15611.921940390226, 16376.83623163777, 16528.917355413145, 16771.0, 16866.662666746597, 856.3448961544424, 859.1709000814244, 875.9868601970848, 881.2333270055093, 899.0964081098585, 8750.737477875675, 8850.468971861708, 9309.581068851918, 9325.813483730422, 9513.904860951441, 283694.0, 287495.0, 392806.0, 393444.0, 405293.8941221159, 53638.0, 75963.62018189873, 83223.0, 84635.0, 85739.14260857312, 876.7282142535835, 890.5235698901057, 920.4799288402031, 928.4800511713462, 928.7770934975557, 14851.405943762129, 15067.853059601244, 15508.767368489256, 15795.684086318439, 15874.52376428709, 36429.45355819718, 36565.0, 36684.86411902389, 37206.0, 37639.42425469576, 52536.73731631317, 52825.471745282055, 53160.0, 53693.463065368844, 54975.0, 7047.6123813188715, 7052.435805135679, 7174.461915356474, 7245.963770181115, 7282.3809976152625, 8532.616032278687, 10949.069329107115, 11512.53949841997, 11852.229605075643, 12243.32661703615, 9904.455254961047, 9921.305508614329, 10183.236257280585, 10221.131203847459, 10422.895771042193, 9652.324337296603, 9828.4102953823, 9870.75323116899, 10023.398596084258, 10161.898381016095, 9735.0, 10079.647212347532, 10140.0, 10457.895421045692, 10931.070858976758, 6963.199232088375, 7088.964555177191, 7116.608586527791, 7195.424366050808, 7379.446541509301, 9465.0, 9706.320557561185, 10497.47512624381, 10637.627683031365, 10799.13606911461], "value": 7966.5374279741045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.2664794391171, 1363.5295822941084, 1397.5737400092974, 1623.7970253718286, 1628.560288722045, 6496.642684652342, 6728.7215429068565, 7046.203218179364, 7451.776446706607, 7456.142543607487, 6958.756443524478, 7293.854122917552, 7307.451941104412, 7326.853462930738, 7458.552486850793, 1989.6319180951498, 2045.6829191475272, 2054.352878843167, 2062.4019034479984, 2066.5143691232547, 1695.5167777183506, 1752.2990803678504, 1972.3984184823623, 2000.7999200080021, 2001.7497812773404, 1854.9629007419844, 1923.7499125113716, 1924.5765931495048, 1924.653562358775, 1931.9613607727838, 1932.2271091563346, 1941.1555973151653, 1956.7847536771087, 1959.6374670685898, 1959.8824070555813, 1981.5244341358114, 1988.67186914159, 2000.0299854570521, 2000.1299434745786, 2001.559656875485, 7076.681549330293, 7147.463295391463, 7174.03150574671, 7176.174739904925, 7387.815304617374, 4362.258416069276, 4463.575960283768, 4501.122281155176, 4501.167284052461, 4501.4598248210095, 2593.312772115391, 2877.1800036989357, 2896.2469757862896, 2901.361700425903, 2902.622659054309, 804.7304153108715, 858.6307887608326, 871.5859966515918, 875.1467319363633, 895.3240303570827, 9534.237261019101, 9736.561854716483, 9769.706908792748, 9808.16630586401, 9831.262655300881, 3825.464434979105, 3886.018130753336, 4002.179553191647, 4014.0, 4027.35562310029, 8430.957845210858, 8432.0, 8432.45189062709, 8437.240648341678, 8446.915530844735, 4350.499692535335, 4436.423264975532, 4438.267685831866, 4439.200943830142, 4440.511543730187, 4019.2966230909474, 4046.352583586671, 4058.0869304406865, 4058.979705101515, 4060.8578699745367, 3263.7878537894962, 3347.1799409144915, 3399.7280217582534, 3401.9659803402146, 3430.091025878144, 988.4069558264983, 1055.883852776194, 1092.3609688332415, 1095.1567293184203, 1099.428297285407, 680.7746057097205, 757.7310054930421, 794.6860989908954, 816.9135050382977, 842.4439869685978, 4792.113459010095, 4888.5111488850835, 4942.678725882806, 4945.2582112683385, 4990.076835785391, 860.8149247911729, 883.8939327280767, 893.8525143351275, 900.6802585082202, 905.6649039855164, 3232.69289417505, 3237.902862914116, 3268.7875288106197, 3288.128645908836, 3579.2304654498885, 8652.264557512555, 8965.551722413853, 9049.954750226207, 9070.54647267634, 9130.406523575946, 8404.243618074403, 8767.561621918878, 8971.820563588692, 8990.685326013689, 9004.41471304363, 6722.932770672329, 6882.759103431456, 6892.172939247323, 6892.793216203522, 6900.723971041102, 4857.125717370907, 4957.82647607332, 4975.278584605285, 5041.8487445376695, 5142.485751424828, 7912.525248485109, 7961.482503637245, 8005.879911801211, 8048.798780030312, 8127.918720812716, 8040.5979701015885, 8140.959295203486, 8174.509529428254, 8282.792930176794, 8338.87491687613, 6123.112148738319, 6241.656708881055, 6249.7500099997305, 6253.593516421418, 6270.0908368287255, 6757.0, 6898.241193468814, 6951.652417379009, 6957.304269573205, 6997.0, 4765.8570242892765, 5915.852103697442, 6158.291796443466, 6198.318184999556, 6261.060840873905, 6147.631142131487, 6171.444569988723, 6180.227471566054, 6223.719932602953, 6413.134226879311, 5808.157817116579, 5828.94171058284, 5863.970680146572, 5869.148973398748, 5886.529077673861, 4113.773742444194, 4130.421740956329, 4292.055747735493, 4322.113966636769, 4421.115776844708, 4198.118395137056, 4205.17998990194, 4350.303951367766, 4354.976580503642, 4355.4538138960215], "value": 3849.4798085028806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.39632807822795, 284.4566877264425, 285.6272564303584, 286.537242353599, 291.45061558961356, 4734.4081989751285, 4854.19905715557, 4857.73282469464, 4865.951340486598, 4900.166971614825, 4856.0, 4867.683600565961, 4868.683535570185, 4877.341558889549, 4895.608351331894, 3597.460380942853, 3693.686036686885, 3825.101101241206, 3826.330392181371, 3833.4249862520564, 3621.583517895436, 3705.981470092646, 3738.6261373862667, 3743.4384842273603, 3759.514991578325, 3687.078230442389, 3690.5940346561856, 3721.79530125843, 3724.757890737107, 3737.9252414951684, 3546.733994950363, 3693.261347730465, 3714.3499887519574, 3730.1420673245034, 3737.7383583149053, 3129.7809153359276, 3175.0, 3187.362527494487, 3193.9459978207137, 3220.3559288142233, 4642.466116396624, 4646.3495110684535, 4653.720776753372, 4653.953460465385, 4696.906061878777, 4179.226843034018, 4182.330827067654, 4202.726822756511, 4237.0890258594245, 4239.40648309237, 4966.031623833354, 5003.624728145403, 5006.74966251686, 5009.1215794077225, 5046.419661738873, 3458.8758653437735, 3466.0641626760885, 3479.8434070466888, 3491.0923159978333, 3497.9475307870403, 5241.68549887008, 5267.209918512254, 5293.6294459387855, 5299.39057008449, 5313.6014798889855, 3451.6030656474327, 3552.2717842842158, 3590.8563657453933, 3632.3824949758605, 3634.9818250908575, 3613.4941108244866, 3628.401313783196, 3632.9091772705365, 3639.454081887738, 3648.2521083178417, 4170.687198460067, 4180.749155050646, 4217.219814334358, 4225.239456897788, 4232.798944548817, 4968.373087646039, 5033.874153146127, 5049.141645920203, 5061.215511595708, 5093.337866077386, 1217.72601164739, 1231.8337024501757, 1235.7899157143306, 1236.9381530923597, 1237.7833879071127, 829.6598394658162, 841.146236569882, 857.6826574167474, 861.67687117331, 862.7066797288952, 4243.384709217146, 4283.31466965284, 4290.549492303263, 4294.377315289265, 4306.784660766949, 4936.284238785356, 5076.7207803571155, 5084.262781896604, 5188.714620695822, 5219.947800521946, 4405.383246345515, 4437.356583295404, 4464.129494748558, 4466.240739074366, 4479.46246450428, 2585.8060645451665, 2649.807586586044, 2672.47886662099, 2677.759001689857, 2684.7986401020003, 4658.254679251304, 4674.854660608173, 4689.366935463737, 4708.163816111719, 4713.81144754206, 5142.6400151989, 5150.403374953777, 5167.940572182693, 5193.610479214074, 5213.869653258699, 4458.420405347284, 4631.536846315409, 4662.836800712027, 4670.065986802653, 4695.483496815347, 4997.850494386239, 5007.222436035301, 5027.371578552681, 5038.974805125951, 5083.38999320084, 4945.208766597327, 4947.960928204973, 4965.677230979974, 4965.900681986413, 4969.527894849984, 4436.755978421218, 4623.237165867594, 4683.78922948475, 4700.647451441224, 4743.430788305287, 3543.557055368079, 3546.8758593449106, 3548.9530588475945, 3560.323538527775, 3564.500969864273, 5015.52352526524, 5033.766727151871, 5046.545810877039, 5047.974760126176, 5064.18972964324, 4875.488073752205, 4881.560659540658, 4893.90212195747, 4897.4857639947295, 4900.8774780630765, 4647.628189744744, 4819.614430845454, 4865.197242455097, 4890.510948905081, 4896.9471563614, 4806.49531799156, 4819.0, 4820.25286080658, 4820.3369837406035, 4832.613390928647, 4909.558139767438, 4911.263310503453, 4932.7533623319405, 4949.480304568113, 4953.1425715356745, 4586.839460618996, 4793.784279707352, 4810.63920205993, 4843.660943733905, 4847.345608342828], "value": 3718.565736592976, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.8851362497938, 621.7337803705493, 696.1993707236677, 720.3121019426449, 725.2566119727283, 12611.0, 12971.092023558354, 13040.869591304085, 13057.086003979724, 13412.463501459943, 11914.582989595367, 12215.755684886319, 12221.877781222185, 12225.633231003061, 12229.143959922787, 753.5629334985723, 764.8814433762748, 765.8200322924108, 766.6626684258908, 769.3768047881234, 602.8312072619674, 626.9498440124779, 723.9058922340089, 750.5909279442717, 750.6884642873201, 792.1049214387763, 792.9801754956144, 794.6582969323189, 796.6534557467492, 796.7052190689453, 781.1251398433734, 782.1279273609913, 782.1435528096725, 782.9451938364317, 783.1933108897845, 469.36869909971034, 478.96886702364236, 561.3768716724433, 574.431313000131, 580.9919789165793, 11647.184697071209, 11648.971267470519, 11657.183997120204, 11666.708332291675, 11668.766624667544, 11373.431328433628, 11490.310581365145, 11768.117391195608, 12029.09781766371, 12263.75472490554, 11361.886381136166, 11460.255083419634, 11477.540898364055, 11672.941635291769, 11694.883051169549, 4187.497500299953, 4198.5591512891315, 4200.915981680349, 4281.293586558214, 4410.25025745624, 64012.679936600485, 65498.67250663764, 67047.0, 67727.66136169338, 69310.30689693139, 10201.0, 10268.435236062089, 10394.22043346752, 10462.215333849992, 10529.631462898762, 19071.523211919535, 19120.713189302172, 19141.425757227305, 19276.32532861343, 19328.1302341395, 6657.667116644246, 6712.664366781642, 6774.187097548326, 6890.345417185359, 7033.156021277479, 3553.9289214216087, 3569.1077230692326, 3569.7322700797545, 3620.9275814483562, 3663.9633603663624, 2631.3947792007943, 2712.498187835257, 2718.6873509546654, 2722.5507791214227, 2727.3999720061556, 429.9634531064832, 438.81131113620813, 439.92081425343747, 445.0054129021634, 448.5536890793681, 497.67651026832846, 504.4854248666413, 513.3352308760165, 521.668740349873, 532.475511621053, 6950.200726916368, 7602.201768814305, 7704.114026886868, 7859.803504912423, 7929.881051784228, 439.87463572881575, 451.08429887328776, 473.19556753519157, 512.1472747874747, 523.4320761973225, 3563.3942229820473, 3669.5779985302033, 3708.2398108387715, 3784.0, 3884.6698030667144, 73002.63498682472, 73635.26364736391, 74469.62765186139, 75324.62337688386, 75454.24545754472, 63153.68423157855, 63513.0, 65002.0, 66221.0, 67720.6613966927, 48642.27036594454, 53725.731371342896, 58044.0, 58487.12269315964, 59685.70157149187, 7527.548347099191, 8305.335573154012, 8418.971147796407, 8514.616842242238, 8581.227689507974, 38591.0, 39522.41910323555, 40348.0, 40385.59614403819, 40411.0, 46495.53504464912, 52493.475065250386, 54054.45945540494, 54311.91376172534, 55389.0, 11959.581414650793, 12033.4584943676, 12046.879531204926, 12170.330631815335, 12486.188397754117, 12604.180728252633, 12736.23582585048, 13060.738785224432, 13559.525416610371, 13658.658533536742, 11124.332540047622, 11321.320720756781, 11633.243839150427, 11643.301401915913, 12149.453274602842, 10612.522436490532, 11075.612353567909, 11492.48283827213, 12267.938660306641, 12317.876821231674, 11557.884421156017, 11712.531498739954, 11735.882641173479, 12292.446839892405, 12486.875131248571, 8886.422382545114, 9063.728088157102, 9179.632814687338, 9281.118293762082, 9490.0, 8695.695645653203, 9902.900970990198, 9912.950435247778, 10093.646722364681, 10109.518955972675], "value": 6216.00486503685, "unit": "score"}], "name": "dromaeo_css", "value": 6223.467864530433, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 136.0, 129.0, 183.0, 134.0, 130.0, 131.0, 138.0, 164.0, 130.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 163.0, 162.0, 163.0, 162.0, 162.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 111.0, 78.0, 79.0, 77.0, 77.0, 90.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 106.0, 84.0, 84.0, 83.0, 108.0, 83.0, 83.0, 108.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 147.0, 149.0, 148.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 68.0, 69.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 69.0, 68.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 84.0, 84.0, 91.0, 84.0, 94.0, 83.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 148.0, 152.0, 148.0, 153.0, 144.0, 143.0, 196.0, 139.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 178.0, 178.0, 176.0, 175.0, 181.0, 178.0, 177.0, 183.0, 177.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 71.0, 71.0, 72.0, 71.0, 72.0, 70.0, 71.0, 71.0], "value": 71.3, "unit": "score"}], "name": "kraken", "value": 1572.7999999999997, "alertThreshold": 2.0}]} 01:41:37 INFO - Return code: 0 01:41:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:41:37 INFO - # TBPL SUCCESS # 01:41:37 INFO - Running post-action listener: _resource_record_post_action 01:41:37 INFO - [mozharness: 2016-12-02 09:41:37.888755Z] Finished run-tests step (success) 01:41:37 INFO - Running post-run listener: _resource_record_post_run 01:41:37 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404406272; Read time: 20; Write time: 249016 01:41:37 INFO - TinderboxPrint: CPU usage
13.1% 01:41:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 01:41:37 INFO - TinderboxPrint: I/O write bytes / time
404,406,272 / 249,016 01:41:37 INFO - TinderboxPrint: CPU idle
8,345.9 (86.9%) 01:41:37 INFO - TinderboxPrint: CPU user
1,214.1 (12.6%) 01:41:37 INFO - TinderboxPrint: Swap in / out
0 / 0 01:41:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99954688; Read time: 0; Write time: 59912 01:41:37 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 293163008; Read time: 0; Write time: 186364 01:41:38 INFO - Running post-run listener: _upload_blobber_files 01:41:38 INFO - Blob upload gear active. 01:41:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:41:38 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 01:41:38 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:41:38 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:41:38 INFO - (blobuploader) - INFO - Open directory for files ... 01:41:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:41:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:41:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:41:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:41:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:41:39 INFO - (blobuploader) - INFO - Done attempting. 01:41:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:41:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:41:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:41:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:41:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:41:43 INFO - (blobuploader) - INFO - Done attempting. 01:41:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:41:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:41:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:41:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:41:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:41:44 INFO - (blobuploader) - INFO - Done attempting. 01:41:44 INFO - (blobuploader) - INFO - Iteration through files over. 01:41:44 INFO - Return code: 0 01:41:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:41:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:41:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/386188adec05041fe6cc0645f5bfaa35907c78068784340eb8889010d346ccc81d12b6eefb676e2398a5bc61c0a4b3cd522d6bf4add8aa66953e32020cbb6ca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9ce2db0c8f349a2e3902ff3c0387f34a212088fe90123e498f16d42210386eddf435bc4f60fa386616876b3688ace4635bbe9865f82d9461df5c97e93626e55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57ef0d85cc89f1f2d15f9aa8e41062e6e8961ef8d87917046c4dd4f0dbf627edaa3ee7df02652f73e177261c3dcde7534a52ee98bd993b18a42fcadb76bdc2d5"} 01:41:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:41:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:41:44 INFO - Contents: 01:41:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/386188adec05041fe6cc0645f5bfaa35907c78068784340eb8889010d346ccc81d12b6eefb676e2398a5bc61c0a4b3cd522d6bf4add8aa66953e32020cbb6ca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9ce2db0c8f349a2e3902ff3c0387f34a212088fe90123e498f16d42210386eddf435bc4f60fa386616876b3688ace4635bbe9865f82d9461df5c97e93626e55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57ef0d85cc89f1f2d15f9aa8e41062e6e8961ef8d87917046c4dd4f0dbf627edaa3ee7df02652f73e177261c3dcde7534a52ee98bd993b18a42fcadb76bdc2d5"} 01:41:44 INFO - Running post-run listener: copy_logs_to_upload_dir 01:41:44 INFO - Copying logs to upload dir... 01:41:44 INFO - mkdir: /builds/slave/test/build/upload/logs 01:41:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.148141 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-02 01:41:44.007958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 01:41:44.011394) ========= 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=826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/386188adec05041fe6cc0645f5bfaa35907c78068784340eb8889010d346ccc81d12b6eefb676e2398a5bc61c0a4b3cd522d6bf4add8aa66953e32020cbb6ca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9ce2db0c8f349a2e3902ff3c0387f34a212088fe90123e498f16d42210386eddf435bc4f60fa386616876b3688ace4635bbe9865f82d9461df5c97e93626e55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57ef0d85cc89f1f2d15f9aa8e41062e6e8961ef8d87917046c4dd4f0dbf627edaa3ee7df02652f73e177261c3dcde7534a52ee98bd993b18a42fcadb76bdc2d5"} build_url:https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/emkZsaj_RU6wKTOJ71jKHg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/386188adec05041fe6cc0645f5bfaa35907c78068784340eb8889010d346ccc81d12b6eefb676e2398a5bc61c0a4b3cd522d6bf4add8aa66953e32020cbb6ca6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9ce2db0c8f349a2e3902ff3c0387f34a212088fe90123e498f16d42210386eddf435bc4f60fa386616876b3688ace4635bbe9865f82d9461df5c97e93626e55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57ef0d85cc89f1f2d15f9aa8e41062e6e8961ef8d87917046c4dd4f0dbf627edaa3ee7df02652f73e177261c3dcde7534a52ee98bd993b18a42fcadb76bdc2d5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 01:41:44.037700) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 01:41:44.038083) ========= 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=826874ccc97bd7bf541b4875000001d5-1480669953.68423-1574680220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 01:41:44.120504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 01:41:44.120924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 01:41:44.121316) ========= ========= Total master_lag: 0.16 =========