builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1483613598.85 results: success (0) buildid: 20170105010338 builduid: 4b20215d9c2443ed8a12cc624b3c1093 revision: 36ec7bc916d72028da0677ef1d14ef4782b6a963 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:18.849285) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:18.849862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:18.850161) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:18.865000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:18.865582) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 02:53:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.2M=0s 2017-01-05 02:53:19 (34.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:18.999711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:19.000029) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016918 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:19.051220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 02:53:19.051749) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 36ec7bc916d72028da0677ef1d14ef4782b6a963 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 36ec7bc916d72028da0677ef1d14ef4782b6a963 --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=3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 02:53:19,715 truncating revision to first 12 chars 2017-01-05 02:53:19,715 Setting DEBUG logging. 2017-01-05 02:53:19,715 attempt 1/10 2017-01-05 02:53:19,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/36ec7bc916d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 02:53:20,616 unpacking tar archive at: mozilla-beta-36ec7bc916d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.228441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 02:53:20.294451) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:20.294837) ========= script_repo_revision: 36ec7bc916d72028da0677ef1d14ef4782b6a963 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:20.295266) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:20.295555) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 02:53:20.304991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-05 02:53:20.305375) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:53:21 INFO - MultiFileLogger online at 20170105 02:53:21 in /builds/slave/test 02:53:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:53:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:53:21 INFO - {'append_to_log': False, 02:53:21 INFO - 'base_work_dir': '/builds/slave/test', 02:53:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:53:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:53:21 INFO - 'branch': 'Mozilla-Beta', 02:53:21 INFO - 'buildbot_json_path': 'buildprops.json', 02:53:21 INFO - 'config_files': ('talos/linux_config.py',), 02:53:21 INFO - 'default_actions': ('clobber', 02:53:21 INFO - 'read-buildbot-config', 02:53:21 INFO - 'download-and-extract', 02:53:21 INFO - 'populate-webroot', 02:53:21 INFO - 'create-virtualenv', 02:53:21 INFO - 'install', 02:53:21 INFO - 'run-tests'), 02:53:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:53:21 INFO - 'download_minidump_stackwalk': True, 02:53:21 INFO - 'download_symbols': 'ondemand', 02:53:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:53:21 INFO - 'tooltool.py': '/tools/tooltool.py', 02:53:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:53:21 INFO - '/tools/misc-python/virtualenv.py')}, 02:53:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:53:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:53:21 INFO - 'installer_path': 'installer.exe', 02:53:21 INFO - 'log_level': 'info', 02:53:21 INFO - 'log_name': 'talos', 02:53:21 INFO - 'log_to_console': True, 02:53:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:53:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:53:21 INFO - 'opt_config_files': (), 02:53:21 INFO - 'pip_index': False, 02:53:21 INFO - 'sps_profile': False, 02:53:21 INFO - 'sps_profile_interval': 0, 02:53:21 INFO - 'suite': 'dromaeojs', 02:53:21 INFO - 'system_bits': '32', 02:53:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:53:21 INFO - 'title': 'talos-linux64-ix-059', 02:53:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:53:21 INFO - 'use_talos_json': True, 02:53:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:53:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:53:21 INFO - 'work_dir': 'build'} 02:53:21 INFO - [mozharness: 2017-01-05 10:53:21.065468Z] Running clobber step. 02:53:21 INFO - Running pre-action listener: _resource_record_pre_action 02:53:21 INFO - Running main action method: clobber 02:53:21 INFO - rmtree: /builds/slave/test/build 02:53:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:53:21 INFO - Running post-action listener: _resource_record_post_action 02:53:21 INFO - [mozharness: 2017-01-05 10:53:21.524318Z] Finished clobber step (success) 02:53:21 INFO - [mozharness: 2017-01-05 10:53:21.524418Z] Running read-buildbot-config step. 02:53:21 INFO - Running pre-action listener: _resource_record_pre_action 02:53:21 INFO - Running main action method: read_buildbot_config 02:53:21 INFO - Using buildbot properties: 02:53:21 INFO - { 02:53:21 INFO - "project": "", 02:53:21 INFO - "product": "firefox", 02:53:21 INFO - "script_repo_revision": "production", 02:53:21 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 02:53:21 INFO - "repository": "", 02:53:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 02:53:21 INFO - "buildid": "20170105010338", 02:53:21 INFO - "pgo_build": "True", 02:53:21 INFO - "basedir": "/builds/slave/test", 02:53:21 INFO - "buildnumber": 75, 02:53:21 INFO - "slavename": "talos-linux64-ix-059", 02:53:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:53:21 INFO - "platform": "ubuntu64_hw", 02:53:21 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 02:53:21 INFO - "branch": "mozilla-beta", 02:53:21 INFO - "repo_path": "releases/mozilla-beta", 02:53:21 INFO - "revision": "36ec7bc916d72028da0677ef1d14ef4782b6a963", 02:53:21 INFO - "stage_platform": "linux64-pgo", 02:53:21 INFO - "builduid": "4b20215d9c2443ed8a12cc624b3c1093", 02:53:21 INFO - "slavebuilddir": "test" 02:53:21 INFO - } 02:53:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 02:53:21 INFO - Running post-action listener: _resource_record_post_action 02:53:21 INFO - [mozharness: 2017-01-05 10:53:21.526879Z] Finished read-buildbot-config step (success) 02:53:21 INFO - [mozharness: 2017-01-05 10:53:21.526967Z] Running download-and-extract step. 02:53:21 INFO - Running pre-action listener: _resource_record_pre_action 02:53:21 INFO - Running main action method: download_and_extract 02:53:21 INFO - mkdir: /builds/slave/test/build/tests 02:53: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')]} 02:53:21 INFO - trying https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 02:53:21 INFO - Downloading https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 02:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:53:22 INFO - Downloaded 1327 bytes. 02:53:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 02:53:22 INFO - Using the following test package requirements: 02:53:22 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 02:53:22 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 02:53:22 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 02:53:22 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 02:53:22 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 02:53:22 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 02:53:22 INFO - u'jsshell-linux-x86_64.zip'], 02:53:22 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 02:53:22 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 02:53:22 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 02:53:22 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 02:53:22 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 02:53:22 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 02:53:22 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 02:53:22 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 02:53:22 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 02:53:22 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 02:53:22 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 02:53:22 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:53:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 02:53:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:53:22 INFO - Fetch https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 02:53:22 INFO - Expected file size: 21970839 02:53:26 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:53:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 02:53:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:53:26 INFO - Fetch https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 02:53:27 INFO - Expected file size: 21970839 02:53:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 02:53:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:53:32 INFO - Fetch https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 02:53:32 INFO - Expected file size: 14414089 02:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:33 INFO - trying https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 02:53:33 INFO - Downloading https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 02:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:53:34 INFO - Downloaded 56966574 bytes. 02:53:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 02:53:34 INFO - mkdir: /builds/slave/test/properties 02:53:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:53:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:53:34 INFO - Contents: 02:53:34 INFO - build_url:https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 02:53:34 INFO - Running post-action listener: _resource_record_post_action 02:53:34 INFO - Running post-action listener: set_extra_try_arguments 02:53:34 INFO - [mozharness: 2017-01-05 10:53:34.894639Z] Finished download-and-extract step (success) 02:53:34 INFO - [mozharness: 2017-01-05 10:53:34.894868Z] Running populate-webroot step. 02:53:34 INFO - Running pre-action listener: _resource_record_pre_action 02:53:34 INFO - Running main action method: populate_webroot 02:53:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:53:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:53:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:53:34 INFO - '--tppagecycles', 02:53:34 INFO - '7'], 02:53:34 INFO - 'tests': ['tsvgm']}}, 02:53:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:53:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:53:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:53:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:53:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:34 INFO - 'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:34 INFO - 'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['damp', 'tps']}, 02:53:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:34 INFO - 'tests': ['damp', 'tps']}, 02:53:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['dromaeo_dom']}, 02:53:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:53:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['basic_compositor_video']}, 02:53:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:53:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['a11yr', 02:53:34 INFO - 'ts_paint', 02:53:34 INFO - 'tpaint', 02:53:34 INFO - 'sessionrestore', 02:53:34 INFO - 'sessionrestore_no_auto_restore', 02:53:34 INFO - 'tabpaint']}, 02:53:34 INFO - 'other-e10s': {'tests': ['a11yr', 02:53:34 INFO - 'ts_paint', 02:53:34 INFO - 'tpaint', 02:53:34 INFO - 'sessionrestore', 02:53:34 INFO - 'sessionrestore_no_auto_restore', 02:53:34 INFO - 'tabpaint']}, 02:53:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:53:34 INFO - 'ts_paint', 02:53:34 INFO - 'tpaint', 02:53:34 INFO - 'sessionrestore', 02:53:34 INFO - 'sessionrestore_no_auto_restore', 02:53:34 INFO - 'tabpaint']}, 02:53:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:53:34 INFO - 'ts_paint', 02:53:34 INFO - 'tpaint', 02:53:34 INFO - 'sessionrestore', 02:53:34 INFO - 'sessionrestore_no_auto_restore', 02:53:34 INFO - 'tabpaint']}, 02:53:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['a11yr', 02:53:34 INFO - 'ts_paint', 02:53:34 INFO - 'tpaint', 02:53:34 INFO - 'sessionrestore', 02:53:34 INFO - 'sessionrestore_no_auto_restore', 02:53:34 INFO - 'tabpaint']}, 02:53:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['a11yr', 02:53:34 INFO - 'ts_paint', 02:53:34 INFO - 'tpaint', 02:53:34 INFO - 'sessionrestore', 02:53:34 INFO - 'sessionrestore_no_auto_restore', 02:53:34 INFO - 'tabpaint']}, 02:53:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['tsvgx', 02:53:34 INFO - 'tsvgr_opacity', 02:53:34 INFO - 'tart', 02:53:34 INFO - 'tscrollx', 02:53:34 INFO - 'cart']}, 02:53:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:53:34 INFO - 'tsvgr_opacity', 02:53:34 INFO - 'tart', 02:53:34 INFO - 'tscrollx', 02:53:34 INFO - 'cart']}, 02:53:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:34 INFO - 'talos_options': ['--disable-e10s'], 02:53:34 INFO - 'tests': ['tp5o']}, 02:53:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:34 INFO - 'tests': ['tp5o']}, 02:53:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:34 INFO - 'talos_options': ['--disable-e10s', 02:53:34 INFO - '--xperf_path', 02:53:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:34 INFO - 'tests': ['tp5n']}, 02:53:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:34 INFO - 'talos_options': ['--xperf_path', 02:53:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:34 INFO - 'tests': ['tp5n']}}, 02:53:34 INFO - 'talos.zip': {'path': '', 02:53:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:53:34 INFO - Running post-action listener: _resource_record_post_action 02:53:34 INFO - [mozharness: 2017-01-05 10:53:34.911565Z] Finished populate-webroot step (success) 02:53:34 INFO - [mozharness: 2017-01-05 10:53:34.911659Z] Running create-virtualenv step. 02:53:34 INFO - Running pre-action listener: _resource_record_pre_action 02:53:34 INFO - Running main action method: create_virtualenv 02:53:34 INFO - Creating virtualenv /builds/slave/test/build/venv 02:53:34 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 02:53:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:53:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:53:35 INFO - Using real prefix '/usr' 02:53:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:53:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:53:37 INFO - Installing pip.................done. 02:53:37 INFO - Return code: 0 02:53:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:53:37 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')]} 02:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:37 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')]} 02:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:37 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:37 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 02:53:37 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 02:53:37 INFO - Using env: {'DISPLAY': ':0', 02:53:37 INFO - 'HOME': '/home/cltbld', 02:53:37 INFO - 'LANG': 'en_US.UTF-8', 02:53:37 INFO - 'LANGUAGE': 'en_US:en', 02:53:37 INFO - 'LOGNAME': 'cltbld', 02:53:37 INFO - 'MAIL': '/var/mail/cltbld', 02:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:37 INFO - 'MOZ_NO_REMOTE': '1', 02:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:37 INFO - 'NO_EM_RESTART': '1', 02:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:37 INFO - 'PWD': '/builds/slave/test', 02:53:37 INFO - 'SHELL': '/bin/bash', 02:53:37 INFO - 'SHLVL': '1', 02:53:37 INFO - 'TERM': 'linux', 02:53:37 INFO - 'TMOUT': '86400', 02:53:37 INFO - 'USER': 'cltbld', 02:53:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:37 INFO - '_': '/tools/buildbot/bin/python'} 02:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:37 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 02:53:37 INFO - Cleaning up... 02:53:37 INFO - Return code: 0 02:53:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:53:37 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')]} 02:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:37 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')]} 02:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:37 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:37 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 02:53:37 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 02:53:37 INFO - Using env: {'DISPLAY': ':0', 02:53:37 INFO - 'HOME': '/home/cltbld', 02:53:37 INFO - 'LANG': 'en_US.UTF-8', 02:53:37 INFO - 'LANGUAGE': 'en_US:en', 02:53:37 INFO - 'LOGNAME': 'cltbld', 02:53:37 INFO - 'MAIL': '/var/mail/cltbld', 02:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:37 INFO - 'MOZ_NO_REMOTE': '1', 02:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:37 INFO - 'NO_EM_RESTART': '1', 02:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:37 INFO - 'PWD': '/builds/slave/test', 02:53:37 INFO - 'SHELL': '/bin/bash', 02:53:37 INFO - 'SHLVL': '1', 02:53:37 INFO - 'TERM': 'linux', 02:53:37 INFO - 'TMOUT': '86400', 02:53:37 INFO - 'USER': 'cltbld', 02:53:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:37 INFO - '_': '/tools/buildbot/bin/python'} 02:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:37 INFO - Downloading/unpacking psutil>=3.1.1 02:53:37 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 02:53:37 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 02:53:37 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 02:53:37 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 02:53:37 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 02:53:37 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 02:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:53:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:40 INFO - Installing collected packages: psutil 02:53:40 INFO - Running setup.py install for psutil 02:53:40 INFO - building 'psutil._psutil_linux' extension 02:53:40 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 02:53:40 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 02:53:40 INFO - building 'psutil._psutil_posix' extension 02:53:40 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 02:53:40 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 02:53:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:40 INFO - Successfully installed psutil 02:53:40 INFO - Cleaning up... 02:53:40 INFO - Return code: 0 02:53:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:53:40 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')]} 02:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:40 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')]} 02:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:40 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:40 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 02:53:40 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 02:53:40 INFO - Using env: {'DISPLAY': ':0', 02:53:40 INFO - 'HOME': '/home/cltbld', 02:53:40 INFO - 'LANG': 'en_US.UTF-8', 02:53:40 INFO - 'LANGUAGE': 'en_US:en', 02:53:40 INFO - 'LOGNAME': 'cltbld', 02:53:40 INFO - 'MAIL': '/var/mail/cltbld', 02:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:40 INFO - 'MOZ_NO_REMOTE': '1', 02:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:40 INFO - 'NO_EM_RESTART': '1', 02:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:40 INFO - 'PWD': '/builds/slave/test', 02:53:40 INFO - 'SHELL': '/bin/bash', 02:53:40 INFO - 'SHLVL': '1', 02:53:40 INFO - 'TERM': 'linux', 02:53:40 INFO - 'TMOUT': '86400', 02:53:40 INFO - 'USER': 'cltbld', 02:53:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:40 INFO - '_': '/tools/buildbot/bin/python'} 02:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:53:40 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 02:53:40 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 02:53:40 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 02:53:40 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 02:53:40 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 02:53:40 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 02:53:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:53:42 INFO - Installing collected packages: mozsystemmonitor 02:53:42 INFO - Running setup.py install for mozsystemmonitor 02:53:42 INFO - Successfully installed mozsystemmonitor 02:53:42 INFO - Cleaning up... 02:53:43 INFO - Return code: 0 02:53:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:43 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:43 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 02:53:43 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 02:53:43 INFO - Using env: {'DISPLAY': ':0', 02:53:43 INFO - 'HOME': '/home/cltbld', 02:53:43 INFO - 'LANG': 'en_US.UTF-8', 02:53:43 INFO - 'LANGUAGE': 'en_US:en', 02:53:43 INFO - 'LOGNAME': 'cltbld', 02:53:43 INFO - 'MAIL': '/var/mail/cltbld', 02:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:43 INFO - 'MOZ_NO_REMOTE': '1', 02:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:43 INFO - 'NO_EM_RESTART': '1', 02:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:43 INFO - 'PWD': '/builds/slave/test', 02:53:43 INFO - 'SHELL': '/bin/bash', 02:53:43 INFO - 'SHLVL': '1', 02:53:43 INFO - 'TERM': 'linux', 02:53:43 INFO - 'TMOUT': '86400', 02:53:43 INFO - 'USER': 'cltbld', 02:53:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:43 INFO - '_': '/tools/buildbot/bin/python'} 02:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:43 INFO - Downloading/unpacking jsonschema==2.5.1 02:53:43 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 02:53:43 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 02:53:43 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 02:53:43 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 02:53:43 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 02:53:43 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 02:53:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:53:45 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 02:53:45 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 02:53:45 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 02:53:45 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 02:53:45 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 02:53:45 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 02:53:45 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:45 INFO - warning: no files found matching '*.txt' 02:53:45 INFO - no previously-included directories found matching 'build' 02:53:45 INFO - no previously-included directories found matching 'dist' 02:53:45 INFO - no previously-included directories found matching '.git*' 02:53:45 INFO - Installing collected packages: jsonschema, functools32 02:53:45 INFO - Running setup.py install for functools32 02:53:45 INFO - warning: no files found matching '*.txt' 02:53:45 INFO - no previously-included directories found matching 'build' 02:53:45 INFO - no previously-included directories found matching 'dist' 02:53:45 INFO - no previously-included directories found matching '.git*' 02:53:45 INFO - Successfully installed jsonschema functools32 02:53:45 INFO - Cleaning up... 02:53:45 INFO - Return code: 0 02:53:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:45 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:45 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 02:53:45 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 02:53:45 INFO - Using env: {'DISPLAY': ':0', 02:53:45 INFO - 'HOME': '/home/cltbld', 02:53:45 INFO - 'LANG': 'en_US.UTF-8', 02:53:45 INFO - 'LANGUAGE': 'en_US:en', 02:53:45 INFO - 'LOGNAME': 'cltbld', 02:53:45 INFO - 'MAIL': '/var/mail/cltbld', 02:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:45 INFO - 'MOZ_NO_REMOTE': '1', 02:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:45 INFO - 'NO_EM_RESTART': '1', 02:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:45 INFO - 'PWD': '/builds/slave/test', 02:53:45 INFO - 'SHELL': '/bin/bash', 02:53:45 INFO - 'SHLVL': '1', 02:53:45 INFO - 'TERM': 'linux', 02:53:45 INFO - 'TMOUT': '86400', 02:53:45 INFO - 'USER': 'cltbld', 02:53:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:45 INFO - '_': '/tools/buildbot/bin/python'} 02:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:53:45 INFO - Cleaning up... 02:53:45 INFO - Return code: 0 02:53:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:45 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:45 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 02:53:45 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 02:53:45 INFO - Using env: {'DISPLAY': ':0', 02:53:45 INFO - 'HOME': '/home/cltbld', 02:53:45 INFO - 'LANG': 'en_US.UTF-8', 02:53:45 INFO - 'LANGUAGE': 'en_US:en', 02:53:45 INFO - 'LOGNAME': 'cltbld', 02:53:45 INFO - 'MAIL': '/var/mail/cltbld', 02:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:45 INFO - 'MOZ_NO_REMOTE': '1', 02:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:45 INFO - 'NO_EM_RESTART': '1', 02:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:45 INFO - 'PWD': '/builds/slave/test', 02:53:45 INFO - 'SHELL': '/bin/bash', 02:53:45 INFO - 'SHLVL': '1', 02:53:45 INFO - 'TERM': 'linux', 02:53:45 INFO - 'TMOUT': '86400', 02:53:45 INFO - 'USER': 'cltbld', 02:53:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:45 INFO - '_': '/tools/buildbot/bin/python'} 02:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:46 INFO - Downloading/unpacking blobuploader==1.2.4 02:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:48 INFO - Downloading blobuploader-1.2.4.tar.gz 02:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:53:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:53:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:48 INFO - Downloading docopt-0.6.1.tar.gz 02:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:53:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:53:48 INFO - Running setup.py install for blobuploader 02:53:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:53:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:53:49 INFO - Running setup.py install for requests 02:53:49 INFO - Running setup.py install for docopt 02:53:49 INFO - Successfully installed blobuploader requests docopt 02:53:49 INFO - Cleaning up... 02:53:49 INFO - Return code: 0 02:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53: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')]} 02:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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')]} 02:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:49 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:49 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 02:53:49 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 02:53:49 INFO - Using env: {'DISPLAY': ':0', 02:53:49 INFO - 'HOME': '/home/cltbld', 02:53:49 INFO - 'LANG': 'en_US.UTF-8', 02:53:49 INFO - 'LANGUAGE': 'en_US:en', 02:53:49 INFO - 'LOGNAME': 'cltbld', 02:53:49 INFO - 'MAIL': '/var/mail/cltbld', 02:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:49 INFO - 'MOZ_NO_REMOTE': '1', 02:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:49 INFO - 'NO_EM_RESTART': '1', 02:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:49 INFO - 'PWD': '/builds/slave/test', 02:53:49 INFO - 'SHELL': '/bin/bash', 02:53:49 INFO - 'SHLVL': '1', 02:53:49 INFO - 'TERM': 'linux', 02:53:49 INFO - 'TMOUT': '86400', 02:53:49 INFO - 'USER': 'cltbld', 02:53:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:49 INFO - '_': '/tools/buildbot/bin/python'} 02:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:49 INFO - Running setup.py (path:/tmp/pip-utc91e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:49 INFO - Running setup.py (path:/tmp/pip-7g0usA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:49 INFO - Running setup.py (path:/tmp/pip-LC5c8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:50 INFO - Running setup.py (path:/tmp/pip-WcA0m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:50 INFO - Running setup.py (path:/tmp/pip-hjNpt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:50 INFO - Running setup.py (path:/tmp/pip-6FhEQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:50 INFO - Running setup.py (path:/tmp/pip-SCQMaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:50 INFO - Running setup.py (path:/tmp/pip-DwJVOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:50 INFO - Running setup.py (path:/tmp/pip-wrUsyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:50 INFO - Running setup.py (path:/tmp/pip-PIYqC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:50 INFO - Running setup.py (path:/tmp/pip-_5hCoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:50 INFO - Running setup.py (path:/tmp/pip-CiocTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:50 INFO - Running setup.py (path:/tmp/pip-Voy7Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:50 INFO - Running setup.py (path:/tmp/pip-mrv4dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:50 INFO - Running setup.py (path:/tmp/pip-eyRfYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:50 INFO - Running setup.py (path:/tmp/pip-A3XR6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:50 INFO - Running setup.py (path:/tmp/pip-BRR44k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:53:51 INFO - Running setup.py install for manifestparser 02:53:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:53:51 INFO - Running setup.py install for mozcrash 02:53:51 INFO - Running setup.py install for mozdebug 02:53:51 INFO - Running setup.py install for mozdevice 02:53:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:53:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:53:51 INFO - Running setup.py install for mozfile 02:53:51 INFO - Running setup.py install for mozhttpd 02:53:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:53:51 INFO - Running setup.py install for mozinfo 02:53:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:53:51 INFO - Running setup.py install for mozInstall 02:53:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:53:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:53:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:53:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:53:51 INFO - Running setup.py install for mozleak 02:53:51 INFO - Running setup.py install for mozlog 02:53:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:53:52 INFO - Running setup.py install for moznetwork 02:53:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:53:52 INFO - Running setup.py install for mozprocess 02:53:52 INFO - Running setup.py install for mozprofile 02:53:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:53:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:53:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:53:52 INFO - Running setup.py install for mozrunner 02:53:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:53:52 INFO - Running setup.py install for mozscreenshot 02:53:52 INFO - Running setup.py install for moztest 02:53:52 INFO - Running setup.py install for mozversion 02:53:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:53:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:53:52 INFO - Cleaning up... 02:53:52 INFO - Return code: 0 02:53:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:52 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:52 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 02:53:52 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 02:53:52 INFO - Using env: {'DISPLAY': ':0', 02:53:52 INFO - 'HOME': '/home/cltbld', 02:53:52 INFO - 'LANG': 'en_US.UTF-8', 02:53:52 INFO - 'LANGUAGE': 'en_US:en', 02:53:52 INFO - 'LOGNAME': 'cltbld', 02:53:52 INFO - 'MAIL': '/var/mail/cltbld', 02:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:52 INFO - 'MOZ_NO_REMOTE': '1', 02:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:52 INFO - 'NO_EM_RESTART': '1', 02:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:52 INFO - 'PWD': '/builds/slave/test', 02:53:52 INFO - 'SHELL': '/bin/bash', 02:53:52 INFO - 'SHLVL': '1', 02:53:52 INFO - 'TERM': 'linux', 02:53:52 INFO - 'TMOUT': '86400', 02:53:52 INFO - 'USER': 'cltbld', 02:53:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:52 INFO - '_': '/tools/buildbot/bin/python'} 02:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:53 INFO - Running setup.py (path:/tmp/pip-jWoH49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:53 INFO - Running setup.py (path:/tmp/pip-iGNAtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:53 INFO - Running setup.py (path:/tmp/pip-VlphWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:53 INFO - Running setup.py (path:/tmp/pip-KI7KYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:53 INFO - Running setup.py (path:/tmp/pip-1qwRtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:53 INFO - Running setup.py (path:/tmp/pip-XkjQLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:53 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)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:53 INFO - Running setup.py (path:/tmp/pip-RMD4ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:53 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)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:53 INFO - Running setup.py (path:/tmp/pip-JMn8Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:53 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)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:53 INFO - Running setup.py (path:/tmp/pip-dpz2vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:53 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)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:53 INFO - Running setup.py (path:/tmp/pip-jPxumv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:53 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)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:53 INFO - Running setup.py (path:/tmp/pip-TJmBgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:53 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)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:53 INFO - Running setup.py (path:/tmp/pip-yn2gcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:53 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)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:53 INFO - Running setup.py (path:/tmp/pip-Hi5TBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:53 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)) 02:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:53 INFO - Running setup.py (path:/tmp/pip-u1T9F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:54 INFO - Running setup.py (path:/tmp/pip-ox3lFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:54 INFO - Running setup.py (path:/tmp/pip-MZTgDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:54 INFO - Running setup.py (path:/tmp/pip-FacUTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:56 INFO - Downloading blessings-1.6.tar.gz 02:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:56 INFO - Installing collected packages: blessings 02:53:56 INFO - Running setup.py install for blessings 02:53:56 INFO - Successfully installed blessings 02:53:56 INFO - Cleaning up... 02:53:56 INFO - Return code: 0 02:53:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:56 INFO - Reading from file tmpfile_stdout 02:53:56 INFO - Current package versions: 02:53:56 INFO - argparse == 1.2.1 02:53:56 INFO - blessings == 1.6 02:53:56 INFO - blobuploader == 1.2.4 02:53:56 INFO - docopt == 0.6.1 02:53:56 INFO - functools32 == 3.2.3-2 02:53:56 INFO - jsonschema == 2.5.1 02:53:56 INFO - manifestparser == 1.1 02:53:56 INFO - mozInstall == 1.12 02:53:56 INFO - mozcrash == 0.17 02:53:56 INFO - mozdebug == 0.1 02:53:56 INFO - mozdevice == 0.48 02:53:56 INFO - mozfile == 1.2 02:53:56 INFO - mozhttpd == 0.7 02:53:56 INFO - mozinfo == 0.9 02:53:56 INFO - mozleak == 0.1 02:53:56 INFO - mozlog == 3.4 02:53:56 INFO - moznetwork == 0.27 02:53:56 INFO - mozprocess == 0.23 02:53:56 INFO - mozprofile == 0.28 02:53:56 INFO - mozrunner == 6.12 02:53:56 INFO - mozscreenshot == 0.1 02:53:56 INFO - mozsystemmonitor == 0.3 02:53:56 INFO - moztest == 0.7 02:53:56 INFO - mozversion == 1.4 02:53:56 INFO - psutil == 3.1.1 02:53:56 INFO - requests == 1.2.3 02:53:56 INFO - wsgiref == 0.1.2 02:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:56 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')]} 02:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:56 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')]} 02:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:56 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:56 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 02:53:56 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 02:53:56 INFO - Using env: {'DISPLAY': ':0', 02:53:56 INFO - 'HOME': '/home/cltbld', 02:53:56 INFO - 'LANG': 'en_US.UTF-8', 02:53:56 INFO - 'LANGUAGE': 'en_US:en', 02:53:56 INFO - 'LOGNAME': 'cltbld', 02:53:56 INFO - 'MAIL': '/var/mail/cltbld', 02:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:56 INFO - 'MOZ_NO_REMOTE': '1', 02:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:56 INFO - 'NO_EM_RESTART': '1', 02:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:56 INFO - 'PWD': '/builds/slave/test', 02:53:56 INFO - 'SHELL': '/bin/bash', 02:53:56 INFO - 'SHLVL': '1', 02:53:56 INFO - 'TERM': 'linux', 02:53:56 INFO - 'TMOUT': '86400', 02:53:56 INFO - 'USER': 'cltbld', 02:53:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:56 INFO - '_': '/tools/buildbot/bin/python'} 02:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:56 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)) 02:53:56 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)) 02:53:56 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)) 02:53:56 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)) 02:53:56 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)) 02:53:56 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)) 02:53:56 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)) 02:53:56 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)) 02:53:56 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)) 02:53:56 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)) 02:53:56 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)) 02:53:56 INFO - Cleaning up... 02:53:56 INFO - Return code: 0 02:53:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53:56 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')]} 02:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:56 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')]} 02:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:56 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 0x7f232c7f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x163bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', '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 02:53:56 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 02:53:56 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 02:53:56 INFO - Using env: {'DISPLAY': ':0', 02:53:56 INFO - 'HOME': '/home/cltbld', 02:53:56 INFO - 'LANG': 'en_US.UTF-8', 02:53:56 INFO - 'LANGUAGE': 'en_US:en', 02:53:56 INFO - 'LOGNAME': 'cltbld', 02:53:56 INFO - 'MAIL': '/var/mail/cltbld', 02:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:56 INFO - 'MOZ_NO_REMOTE': '1', 02:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:56 INFO - 'NO_EM_RESTART': '1', 02:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:56 INFO - 'PWD': '/builds/slave/test', 02:53:56 INFO - 'SHELL': '/bin/bash', 02:53:56 INFO - 'SHLVL': '1', 02:53:56 INFO - 'TERM': 'linux', 02:53:56 INFO - 'TMOUT': '86400', 02:53:56 INFO - 'USER': 'cltbld', 02:53:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:56 INFO - '_': '/tools/buildbot/bin/python'} 02:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:53:57 INFO - Cleaning up... 02:53:57 INFO - Return code: 0 02:53:57 INFO - Running post-action listener: _resource_record_post_action 02:53:57 INFO - Running post-action listener: _start_resource_monitoring 02:53:57 INFO - Starting resource monitoring. 02:53:57 INFO - [mozharness: 2017-01-05 10:53:57.201455Z] Finished create-virtualenv step (success) 02:53:57 INFO - [mozharness: 2017-01-05 10:53:57.201908Z] Running install step. 02:53:57 INFO - Running pre-action listener: _resource_record_pre_action 02:53:57 INFO - Running main action method: install 02:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:57 INFO - Reading from file tmpfile_stdout 02:53:57 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:57 INFO - Reading from file tmpfile_stdout 02:53:57 INFO - Output received: 02:53:57 INFO - Usage: mozinstall [options] installer 02:53:57 INFO - Options: 02:53:57 INFO - -h, --help show this help message and exit 02:53:57 INFO - -d DEST, --destination=DEST 02:53:57 INFO - Directory to install application into. [default: 02:53:57 INFO - "/builds/slave/test"] 02:53:57 INFO - --app=APP Application being installed. [default: firefox] 02:53:57 INFO - mkdir: /builds/slave/test/build/application 02:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:54:11 INFO - Reading from file tmpfile_stdout 02:54:11 INFO - Output received: 02:54:11 INFO - /builds/slave/test/build/application/firefox/firefox 02:54:11 INFO - Running post-action listener: _resource_record_post_action 02:54:11 INFO - [mozharness: 2017-01-05 10:54:11.003525Z] Finished install step (success) 02:54:11 INFO - [mozharness: 2017-01-05 10:54:11.003770Z] Running run-tests step. 02:54:11 INFO - Running pre-action listener: _resource_record_pre_action 02:54:11 INFO - Running main action method: run_tests 02:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:54:11 INFO - Python 2.7.3 02:54:11 INFO - Return code: 0 02:54:11 INFO - grabbing minidump binary from tooltool 02:54:11 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')]} 02:54:11 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 0x1638f60>, '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 0x1639d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:54:11 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 02:54:11 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 02:54:11 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 02:54:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:54:11 INFO - Return code: 0 02:54:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:54:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:54:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:54:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:54:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 02:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 02:54:11 INFO - Using env: {'DISPLAY': ':0', 02:54:11 INFO - 'HOME': '/home/cltbld', 02:54:11 INFO - 'LANG': 'en_US.UTF-8', 02:54:11 INFO - 'LANGUAGE': 'en_US:en', 02:54:11 INFO - 'LOGNAME': 'cltbld', 02:54:11 INFO - 'MAIL': '/var/mail/cltbld', 02:54:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:54:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:11 INFO - 'MOZ_NO_REMOTE': '1', 02:54:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:11 INFO - 'NO_EM_RESTART': '1', 02:54:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:11 INFO - 'PWD': '/builds/slave/test', 02:54:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:54:11 INFO - 'SHELL': '/bin/bash', 02:54:11 INFO - 'SHLVL': '1', 02:54:11 INFO - 'TERM': 'linux', 02:54:11 INFO - 'TMOUT': '86400', 02:54:11 INFO - 'USER': 'cltbld', 02:54:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395', 02:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:11 INFO - '_': '/tools/buildbot/bin/python'} 02:54:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 02:54:11 INFO - mozversion application_buildid: 20170105010338 02:54:11 INFO - mozversion application_changeset: 36ec7bc916d72028da0677ef1d14ef4782b6a963 02:54:11 INFO - mozversion application_display_name: Firefox 02:54:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:54:11 INFO - mozversion application_name: Firefox 02:54:11 INFO - mozversion application_remotingname: firefox 02:54:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:54:11 INFO - mozversion application_vendor: Mozilla 02:54:11 INFO - mozversion application_version: 51.0 02:54:11 INFO - mozversion platform_buildid: 20170105010338 02:54:11 INFO - mozversion platform_changeset: 36ec7bc916d72028da0677ef1d14ef4782b6a963 02:54:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:54:11 INFO - mozversion platform_version: 51.0 02:54:11 INFO - using testdate: 1483613651 02:54:11 INFO - actual date: 1483613651 02:54:11 INFO - starting webserver on 'localhost:51416' 02:54:11 INFO - SUITE-START | Running 2 tests 02:54:11 INFO - TEST-START | dromaeo_css 02:54:11 INFO - operating with platform_type : linux_ 02:54:11 INFO - Initialising browser for dromaeo_css test... 02:54:11 INFO - TEST-INFO | started process 13227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyAoHl9/profile http://localhost:51416/getInfo.html) 02:54:15 INFO - PROCESS | 13227 | __metrics Screen width/height:1600/1200 02:54:15 INFO - PROCESS | 13227 | colorDepth:24 02:54:15 INFO - PROCESS | 13227 | Browser inner width/height: 1024/697 02:54:15 INFO - PROCESS | 13227 | __metrics 02:54:15 INFO - PROCESS | 13227 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:54:15 INFO - PROCESS | 13227 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:54:16 INFO - PROCESS | 13227 | console.error: PushService: 02:54:16 INFO - PROCESS | 13227 | stateChangeProcessEnqueue: Error transitioning state 02:54:16 INFO - PROCESS | 13227 | UnknownError 02:54:16 INFO - TEST-INFO | 13227: exit 0 02:54:16 INFO - Browser initialized. 02:54:16 INFO - Running cycle 1/1 for dromaeo_css test... 02:54:16 INFO - TEST-INFO | started process 13321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyAoHl9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:28 INFO - PROCESS | 13321 | RSS: Main: 143876096 02:54:28 INFO - PROCESS | 13321 | 02:55:19 INFO - PROCESS | 13321 | 1483613719427 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] 02:57:28 INFO - PROCESS | 13321 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51416/tests/dromaeo/cssquery-ext.html) 02:57:29 INFO - PROCESS | 13321 | RSS: Main: 239001600 02:57:29 INFO - PROCESS | 13321 | 03:00:31 INFO - PROCESS | 13321 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-ext.html (next: http://localhost:51416/tests/dromaeo/cssquery-jquery.html) 03:00:32 INFO - PROCESS | 13321 | RSS: Main: 233361408 03:00:32 INFO - PROCESS | 13321 | 03:03:34 INFO - PROCESS | 13321 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51416/tests/dromaeo/cssquery-mootools.html) 03:03:34 INFO - PROCESS | 13321 | RSS: Main: 177713152 03:03:34 INFO - PROCESS | 13321 | 03:06:36 INFO - PROCESS | 13321 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51416/tests/dromaeo/cssquery-prototype.html) 03:06:37 INFO - PROCESS | 13321 | RSS: Main: 217481216 03:06:37 INFO - PROCESS | 13321 | 03:09:39 INFO - PROCESS | 13321 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51416/tests/dromaeo/cssquery-yui.html) 03:09:40 INFO - PROCESS | 13321 | RSS: Main: 174223360 03:09:40 INFO - PROCESS | 13321 | 03:12:42 INFO - PROCESS | 13321 | Cycle 1(1): loaded http://localhost:51416/tests/dromaeo/cssquery-yui.html (next: http://localhost:51416/tests/dromaeo/cssquery-dojo.html) 03:12:43 INFO - PROCESS | 13321 | RSS: Main: 261218304 03:12:43 INFO - PROCESS | 13321 | 03:12:43 INFO - PROCESS | 13321 | __start_tp_report 03:12:43 INFO - PROCESS | 13321 | _x_x_mozilla_page_load 03:12:43 INFO - PROCESS | 13321 | _x_x_mozilla_page_load_details 03:12:43 INFO - PROCESS | 13321 | |i|pagename|runs| 03:12:43 INFO - PROCESS | 13321 | |0;dojo.html;3053.557234201041;3112.50199968005;3121.250899784051;3136.8902088426908;3152.8738850445984;5390.811321603745;5395.136778115492;5445.700486473243;5458.645188062778;5524.06090964536;5375.462453754622;5493.725313734317;5512.91730624041;5524.1989911462815;5552.444755524456;4984.5763110135595;5011.574016208627;5038.496150384951;5071.31537242473;5080.542751152396;4910.705357678551;5042;5088.949110508903;5097.05704444677;5100.693958362492;4898.730569818658;4913.606911447094;4958.107540642683;4982.825601103962;4996.525330093654;4997.950020499785;5016.122178618763;5031.371078615173;5095.0574143783515;5117.5394214520875;4970.552650261494;4987.850364489072;5036.294918711384;5046.19260918255;5059.215821547666;5188.22176673502;5313.681179129226;5375.22059301403;5405.783768649249;5455.345358556959;5766.855828604276;5782.074868021138;5797.594168408213;5891.234139561872;5894.705264736746;5925.140854576062;5927.466528012456;5940.01989671708;5944.464998150187;5944.613600115978;5334.946650533484;5378.865528361783;5396.379416367129;5425.430329815313;5439.48324909133;5968.16445697594;5984.880302393928;5993.340732519419;5998.670073145931;5999.520038396918;5738.540916726652;5753.223314852525;5761.827145185651;5767.740451679684;5773.769049238067;5657.43425657431;5747.770089196469;5846.269216347957;5927.436893495111;5931.08068249422;5846.269216347957;5853.765849365977;5857.736401861926;5859.1797148399255;5883.588148829541;5813.476787089182;5847;5863;5870.4716575507555;5892.587518873724;4426.535213802569;4462.062966776948;4462.955370446254;4501.774911254424;4531.27499600069;3999.6000399960353;4028.5568587455355;4049;4049.0484736086996;4073.674106071507;5594.552435805126;5597.944020559742;5601.159826026129;5602.299712535933;5605.607607467519;5669;5740.885182296331;5744.224529688522;5879.764809407661;5882.411758824169;5474.315710536183;5564.054110801174;5573.470520300565;5608.831735047955;5609.242752228479;5070.518300761421;5079.415867175248;5083.8983220335385;5084.237364395296;5128.076946149728;5766.88466230673;5887.911681324869;6037.1246169305205;6044.516438684983;6048.576599637983;5887.0580707086665;5940.257467816523;5944.256967879015;5972.462478376967;5980.940190598212;6084.148219249397;6099.4815440688035;6100.511959043177;6105.9694701526205;6106.877862442815;5577.8047768327915;5813.3605303417435;5813.447722466359;5814.476697097281;5818.359980402237;5699.971500142473;5820.563457740602;5865.824025279248;5901.468867801918;5991.820245392645;5802.5357971361345;5826.359100499027;5831.212786273799;5832;5834.124881267844;5683.516901063456;5811.157382179645;5812.9709351452975;5813.709314534341;5840.2991641003355;5522.751476183662;5570.442955704397;5650.915236271377;5670.121131224667;5705.201271821865;5834.504067154339;5841.415858414124;5845.707714614167;5849.210356601974;5874.911876321944;5428.592855535771;5699.287589051369;5712.257406537124;5712.771489140554;5716.399778023414 03:12:43 INFO - PROCESS | 13321 | |1;ext.html;588.5703436491361;608.6469847488456;618.542278713752;628.0861346740493;632.7469012395042;35244.11889702759;38174.23651526968;38227.808860955694;38306.42540361897;38335.233295334074;47396.0520789584;48888.51111488884;48888.51111488884;52255.73872130634;52302.73848630751;9293.488858112783;9383.577739001727;9392.201662858664;9448.291378146632;9450.57472413743;8658.264047555966;8856.5571721414;9297.767555811091;9399.248060155205;9399.483028433433;8973.282137429023;11005.394703291317;11256.887431125706;11267.098632109411;11676.532938682485;11241.943790281079;11302;11314.264572802824;11325.716857078556;11333.829992550078;11027.283226590245;11097.55609775608;11104.666859994213;11104.722381940435;11113.611023614134;44459.77770111161;44889.32666010012;44964.10071798546;44992.3251151233;45026.32460513095;3858.6334298241622;3908.237893610747;3977.7016723745833;3992;4269.487661480611;34910;34975;35319.64680353215;35334.293314133574;35451.64548354509;4784;4815.638827087947;4853.95189003436;4876.707397556158;4898.24077268024;365386;365805;368186;368377;369428;64575.67712161409;64978;65095;65116;65178.348216517225;40887.59112408838;41742.582574173866;41851;43600.3459948101;43954.12091758147;19198.520036999187;19355.322563710204;19384.80615193858;19385.806141938683;19410.320638777575;15340.079595224322;15458;15458.995165314218;15473.381064757508;15473.5357939262;18651.813481865007;20793.688094678593;20934;20941.47646308824;21106.894465527574;6264.21697287839;7330.973663687088;7399.223081576357;7484.363829074589;8041.839163216703;997.835357166074;1049.2602715085845;1059.86751656043;1105.2429086075904;1131.9094472442184;34150.94622334794;34429.82785086059;34579.65420345764;34641.30717385638;34940.30119397598;1125.2179735084037;1137.391495549877;1140.3386036099043;1148.7013376522164;1187.5843454790754;17050.48848534546;17977.910110449364;18015.18931648079;18022.459326220236;18042.90978545099;507145;510547;512497;519985;523850;43254.35118473225;43751.78124109359;55533.44466555364;56878;60227.99999999913;1420.2330741399735;1433.72042451723;1444.5521888214687;1460.123925644626;1468.7209430208227;32690;34889;34926.30147397089;35169.47245791264;35595.466068008485;56186;56836.43163568311;56858.431415685314;56867.715661421425;56968.715156423954;461601;462471;474198;662103;679155;31854.203644909063;31873.521897171096;31927.361452771278;32189.517157243128;32286.35427291394;52184;52200.738996304775;52203.47796521986;52205.47794522006;52352.73823630858;44099.11801764011;45318;45492.772536137105;46098.30852537282;47331;43814.12371752611;44819;45341;45759.313610296536;46006.76996614996;43181;43726.344104837815;44823.10353792971;44959.100817982806;45105.323420148066;37131.07172320713;39851.2029759409;39865.80067099762;40512;40661.59338406696;29337.85331073331;29501.704982950756;29882.551761723156;30137.246568835955;30197.09408717742 03:12:43 INFO - PROCESS | 13321 | |2;jquery.html;420.8442876135832;422.3959737575267;422.98942526436815;429.6433959813355;441.96243319317875;18793.214644608775;19733.50666233345;20261.89869050653;20435.795642043577;20605.38183854483;19063.809361906377;19843.305484308017;20419.591608167826;20468.795312046874;20636.277730279442;5871.442212989759;6140.447359737623;6144.139820425144;6148.692565371736;6150.938490615082;5714.142878568227;5929;5948.048312270038;6011.218541589587;6032.185654936593;6055.21282233309;6058.575899687024;6059.333473317932;6062.727177277011;6068.635881847081;5872.911906321408;5915;5925.88148237035;5964.135200395962;6071.848203794896;5802.7098645068;5814.5057670098095;5820.039693450575;5820.592558520905;5821.330546987066;12670.746585068338;12710.110292279544;12847.807282890764;12943.935280323538;13914.582562523141;2661.9600705989424;2943.0876428307292;3004.173852190643;3134.45147099259;3154.668759780213;10281.948590257001;10537.947310263477;10691.518881650345;10709.303895246861;10799.5680172793;1973.5855470351244;1994.6908229224348;2031.14691829432;2054.8356131509595;2064.0917996081826;81802;84889.15110848875;85760.14239857584;86525;88590.557047215;11035.72410689723;11197.104231661448;11249.71875703114;11469.54121835134;11910.880891190976;17102;17150.31398744061;17166.31334746621;17170.828291717175;17177.484675459757;8490.320774338039;8509.489430634057;8813.735587932373;8816.471011739188;8853.557322133867;8259.42184047123;8275.875861862078;8348.33213342931;8431.735239714091;8521.914780852236;4742.928856067162;4767.9259522108;4822.324874517571;4841;5311.867203319948;1949.7757757857744;2090.5400811821373;2127.3511578968564;2140.4327853118934;2159.6914156258367;919.8712180294764;981.1856159387692;1004.5981607357115;1043.968680939573;1052.826283663187;20313.390598282076;20625.381238562866;20730;20881.791182088287;20924.686129707763;1000.1398797034544;1032.200044965158;1040.245821779204;1041.0422411381546;1069.973250668724;10667.253292269466;11536.653900383002;11604.187706860439;11637.359945202927;11652.708682283012;539477;547753;549552;550852;567169;90199.54900225588;90900.54549727209;91668.54165729128;100233;100682;996.5714742660581;998.7403275148514;999.3404353126901;1011.4234886114843;1029.161233594633;17627.735583965994;18461.53846153857;18577.907110464363;18624.44126676202;18710;30428.65284818624;33294.5005824908;45048;45526.54473455356;46124.8468788283;62955.37044629495;64317.35682643301;65139.37151571249;65306.346936530026;66175.66912165408;8483.236508714246;8513.446625969293;8554.144585541644;8691.86962195555;8755.912440875765;9634.9036509634;12984.870151298745;13427.731445370842;13437.932810335886;14756.926215368854;10705.839412408975;10760.784784304427;11074.501647425725;11106.111511078932;11614.070874329864;7578.810529736801;12149.60279567861;12315.753684926072;12338.568150114703;12359.62921112368;11278;11309.264897781617;11382.54469821198;11389.202755807013;11678.065754739431;6874.621895795579;7618.69525218985;7853.568053757098;7975.72084977023;9858.654947076819;10140.898591013995;10765.3540787553;11087.279326843729;11092.168087393638;11242.156838237 03:12:43 INFO - PROCESS | 13321 | |3;mootools.html;1358.578840559426;1465.6995315960226;1520.0803513874107;1651.8348165183484;1759.3754217252874;7287.526310789802;8188.877166842494;8501.149885011495;8518.829623407535;8746.825063498727;8561.400701950866;8568.314534837215;8628.95685521573;8643.697470588531;8643.91356086439;2325.058351367699;2350.8119350452007;2353.788159065684;2354.517323948595;2363.7399886012527;2311.3066080175963;2319.060780383939;2354.75275096115;2357.8231632627535;2363.6454531820277;2284.2690339091496;2286.576983258094;2288.8855557222155;2337.228714524203;2338.567365037465;2266.229481976136;2278.054607337953;2291.6677081823127;2294.529621427612;2305.723313202418;2252.054137262354;2259;2259.0624890670515;2261.4911644879935;2262.027328248869;8092.71675491355;8451.957740211259;8608.569571521399;8636.956815215884;8643.222110010067;4921.089598424303;5136.614753893473;5143.562797162245;5148.871278218037;5159.690418574897;3160.1309639849223;3205.086550333144;3209.7111259986714;3227.88702395415;3232.628247751515;1157.9478923448464;1163.7148898519831;1172.8299396587533;1186.9053698296023;1188.6374655729999;11558.248713833575;11612.941935290353;11655.533778648844;11673.124515661275;11673.474693638722;4101.610347017028;4157.7089603727445;4246.299360605465;4267.125239325931;4374.059577190919;9229.492377919145;9254.629814807333;9259.583318750672;9259.907400925904;9270.675526356545;5026.472220416804;5045.9747701261995;5048.848534543969;5049.798008079709;5053.46938571452;4054.553999060101;4166.104287578185;4634.165850146938;4735.668503204812;4773.498782627844;3754.305453491113;3762.9247415051545;3803.8288277027045;3859.7877116758286;3885.9222815544094;1090.5092708281147;1100.6532942123206;1102.404701461218;1103.6688993301977;1107.0866535108407;852.2713080316364;965.1892410375318;1007.2747621712501;1008.9545970431349;1012.5544760305442;5793.073108302736;5870.735816888165;5910.940890591125;6008.639481631116;6014.548908831855;441.4217375238448;446.76991349455056;451.9615832654261;455.7174551777919;457.4464897474027;4037.414574886625;4214.704970652025;4215.557366476476;4253.468316460442;4258.1057977824385;10130.949345253226;10567.524461399102;10577.31247468912;10582.788344233073;10606.204534659932;10490.790184196274;10510.632127875488;10513.369197848153;10515.158787296998;10526.789464210673;7436.293552112541;7739.496932699244;7747.147813740484;7900.604969751489;7975.880361794578;5914.526837853047;5938.138969849261;6028.3971602839365;6094.603850749687;6136.447719705248;9562.378445401027;9655.324127311022;9676.177524910461;9681.66114186;9695.030496950249;9637.759056023655;9782.608695652094;9786.021397860442;9794.755131121494;9924.900750992687;7544.396448284234;7729.1884352142215;7751.92248077512;7779.57212353326;7815.179406162271;8259.256666900008;8277.04813946404;8311.6675332986;8323.209295116954;8326.25063744266;6998.930010699828;7126.037984871976;7225.674844631899;7302.525335853153;7526.360259378014;7363.447741419523;7406.8148296290865;7478.626068696434;7588.544687318778;7610.961945190239;6724.29394913527;6804.285550017177;6808.62552559614;6812.591244525146;6825.829354266183;5233.869153271199;5254.947450525446;5258.868528286824;5275.709835958905;5315.734213289397;5169.379674438941;5172.25002374646;5177.896442071213;5220.060389129993;5325.09473389517 03:12:43 INFO - PROCESS | 13321 | |4;prototype.html;317.2054004718181;321.3877563242023;326.27566801700215;327.22121351184177;334.4631865855302;5336.38631557371;5482.80810171644;5547.084731019382;5571.247881535992;5598.748056337465;5326.840194794153;5435.83692489226;5445.809396671118;5453.400125986138;5458.235846981416;4272.636825869805;4281.593248641374;4294.184105020052;4304.440422745054;4375.540568240337;4223.324268117102;4257.659387249028;4299.419578356913;4321.891952701176;4348.369486424466;4261.870604289866;4270.12462445198;4272.295071313245;4296.849610263642;4298.7205831621;4264;4265.061686428996;4267.359896015591;4268.40242366069;4269.573042695737;3655.0679576708035;3789.0865113117975;3810.428435734634;3815.4276858471453;3820.8280627371837;5344.1716533936915;5344.278522399465;5379.488948549882;5381.2197231401615;5421.83734487966;4834.274858771178;4860.465348811628;4868.196747536652;4874.65877388583;4881.951180488185;5488.69812160331;5700.857478563028;5731.885362292731;5732.541396688255;5780.1907732917425;4115.218108559364;4126.812789221717;4140.4617399737845;4146.253674338618;4196.790160491963;5975.25309336333;5977;5977.6114552553945;6017.48851347636;6106.603070800384;4181.55736270986;4274.422952901381;4295.634871035997;4295.775703924366;4300.80646370914;4283.550227226158;4287.421198138274;4299.355096735515;4299.634531064832;4305.440292761921;4893.510648935149;4899.706017638953;4910.901781964412;4930.383702037246;4947.802087916515;5567.916481252784;5719.828405147852;5785.293338465079;5786.132080187921;5811.593188476851;1388.2087210290038;1418.666613345863;1436.4756863744658;1476.859698328657;1486.2123074770388;986.5609803637312;1011.6813203840767;1026.5893642542894;1034.6275340877278;1041.286718597763;5535.972320138373;5559.166125081189;5569.387367389584;5581.6930068846605;5593.888122237532;5844.766209351578;5853.326867410217;5856.882862342814;5866.208061911672;5876.1479585459865;5438.5377242934;5580.609357345028;5603.943960560424;5646.2377579027125;5659.009673307155;3098.814071155738;3167.4773662345915;3200.3439294944483;3200.727938125239;3226.741860651189;6080.300765412034;6111.755529778759;6156.199694039746;6258.499320054476;6267.6866156691985;6079.75680972765;6113.349395663146;6120.60216085953;6156;6158.353372895871;6116.235470566179;6135.570510064253;6193.6903154842075;6199.597026193283;6213.689315534296;5749.252597162342;5986.281646202484;6012.699365031818;6040.879182416415;6042.1843051187525;5905.320888097752;5907.4683278505145;5923.259592550931;5928.458600763746;5964.522838173022;5934.528300943996;6159.907601385893;6204.162438070803;6212.099245609452;6221.129041934042;4257.552956939477;4261.552536983572;4274.358846173099;4283.400323954586;4316.978415107905;5852.531797456279;5979.222701048836;6072.423119803611;6083.935311320412;6110.541709371903;5707.942920570741;5856.970715146567;5863.413658634103;5866.5387421421565;5868.706564671664;5827.24245848037;5852.970735146297;5856.619319744203;5857.824265272048;5865.94134058671;5619.690916999604;5780.739866705924;5811.738471768866;5829.912551311819;5844.561657875762;5893.174955506147;5941.851453713692;5949.940500594938;5962.181534631979;5973.701314934323;5484.725763711878;5743.4256574342235;5787.768489260551;5829.650220986754;5839.912401314069 03:12:43 INFO - PROCESS | 13321 | |5;yui.html;771.934385577226;781.4803155901326;783.5455435847209;812.2689579378563;861.7156338408324;14652.194129322883;15335.769963450557;15453.150076745775;15542.84457155428;15548.922255388721;14676.926615366909;14833.406663733465;14904.031237969524;14933.477328293511;15049.699006019873;716.8387112899582;740.204280398571;833.7957200485889;835.1106072033296;861.5821326656567;872.3500991761147;872.9869051964225;875.0505701314082;875.2297977779577;876.3252295732283;911.2300106410073;911.4258017448998;912.4525284829116;912.7353067610385;913.6117150211134;904.8552231642906;905.0451773379083;909.8862642169729;910.576581889418;912.1289168843738;671.9832004199885;672.1497305908031;672.65694495807;673.6025744810586;673.7608149107045;14621.561353159315;14634.70730585393;14677;14684.412623495047;14684.48604298855;13825.101368411122;13964.650883727887;14026.789598156036;14186.85813141876;14481.927590362086;12221.694457638541;12262.325572093532;12480.188787728768;12505.74988500225;12737.745245095046;4013.237484877864;4029.8992525186814;4030.6775457963586;4132.504099508048;4145.17096580685;84739.57630211809;90611;91754.5412272941;91893.08106918912;93757.0624293762;11453.713657158638;11642;11658.300501969909;11707.765844683228;11950.641480755592;18313.7252941206;19264.711029334572;23287.301380958597;23294.883525582263;23350.416239594146;8491.872621910552;8542.145785421533;8727.702045756798;8789.033206347296;8854.513001784835;4755.334253204554;4899.461059283476;5053.67151135175;5164.354455693038;5290.1800220965815;3616.2044350242904;3763.4919285896053;3765.661090501868;3769.509963704701;3770.8114594270724;617.7127635649445;620.4911972182857;623.4420193926411;629.2040568680623;630.5302549600485;729.8256747912718;734.5445823589408;758.9165191828895;765.2757374836256;787.8424315136996;10034.64878729241;10135.138513226459;10510.632127875488;10543.209259305582;11048.392338421463;665.1851481934591;666.6533402630702;688.2807466197835;705.3193668110298;741.0588552538246;4733.940376699514;4940.086084074458;5070.138076527;5348;5555.805546805843;74854.25145748473;102595.48702256441;103367.48316258371;105333.47333263284;133522;91915.5404222988;92147;103000.30498017605;104864;107735;54543.45456545384;84714;84789.57605212058;92545;93512;10169.9491502542;10807.567697292021;10939;11018.50416731265;11020.118390528898;36536.26927461489;38482.422763659124;40430;52421.73789131182;57668.71165644313;77258.22741772735;79799.2020079815;80662.5966870162;81877.59061204655;82371.5881420589;13277.867221327662;13378.799318010433;13639.249841258827;13684.726305474034;13874.583762487142;15410.075395476308;15512;15531.145786981373;15632.765508517608;15727.921360393124;15048.322825472662;15077.698446030798;15504;15750;16094.758578621564;14775.482858099915;15010.924945375204;15043.398264069314;15092.320573095927;15291.770623440434;14315.928420357832;14551;14597.27013649292;14612.561623151323;15413.460528881884;11514.422838064605;11644.184907056764;11894.167408281337;12348.876511234772;12507.312097834707;11828;12007;12226.816597750863;12494.68763280889;12675.492980281055 03:12:43 INFO - PROCESS | 13321 | __end_tp_report 03:12:43 INFO - PROCESS | 13321 | __start_cc_report 03:12:43 INFO - PROCESS | 13321 | _x_x_mozilla_cycle_collect,845 03:12:43 INFO - PROCESS | 13321 | __end_cc_report 03:12:43 INFO - PROCESS | 13321 | __startTimestamp1483614763229__endTimestamp 03:12:43 INFO - PROCESS | 13321 | 03:12:43 INFO - PROCESS | 13321 | ------- Summary: start ------- 03:12:43 INFO - PROCESS | 13321 | Number of tests: 6 03:12:43 INFO - PROCESS | 13321 | 03:12:43 INFO - PROCESS | 13321 | [#0] dojo.html Cycles:165 Average:5450.75 Median:5670.12 stddev:620.46 (10.9%) stddev-sans-first:593.18 03:12:43 INFO - PROCESS | 13321 | Values: 3053.6 3112.5 3121.3 3136.9 3152.9 5390.8 5395.1 5445.7 5458.6 5524.1 5375.5 5493.7 5512.9 5524.2 5552.4 4984.6 5011.6 5038.5 5071.3 5080.5 4910.7 5042.0 5088.9 5097.1 5100.7 4898.7 4913.6 4958.1 4982.8 4996.5 4998.0 5016.1 5031.4 5095.1 5117.5 4970.6 4987.9 5036.3 5046.2 5059.2 5188.2 5313.7 5375.2 5405.8 5455.3 5766.9 5782.1 5797.6 5891.2 5894.7 5925.1 5927.5 5940.0 5944.5 5944.6 5334.9 5378.9 5396.4 5425.4 5439.5 5968.2 5984.9 5993.3 5998.7 5999.5 5738.5 5753.2 5761.8 5767.7 5773.8 5657.4 5747.8 5846.3 5927.4 5931.1 5846.3 5853.8 5857.7 5859.2 5883.6 5813.5 5847.0 5863.0 5870.5 5892.6 4426.5 4462.1 4463.0 4501.8 4531.3 3999.6 4028.6 4049.0 4049.0 4073.7 5594.6 5597.9 5601.2 5602.3 5605.6 5669.0 5740.9 5744.2 5879.8 5882.4 5474.3 5564.1 5573.5 5608.8 5609.2 5070.5 5079.4 5083.9 5084.2 5128.1 5766.9 5887.9 6037.1 6044.5 6048.6 5887.1 5940.3 5944.3 5972.5 5980.9 6084.1 6099.5 6100.5 6106.0 6106.9 5577.8 5813.4 5813.4 5814.5 5818.4 5700.0 5820.6 5865.8 5901.5 5991.8 5802.5 5826.4 5831.2 5832.0 5834.1 5683.5 5811.2 5813.0 5813.7 5840.3 5522.8 5570.4 5650.9 5670.1 5705.2 5834.5 5841.4 5845.7 5849.2 5874.9 5428.6 5699.3 5712.3 5712.8 5716.4 03:12:43 INFO - PROCESS | 13321 | 03:12:43 INFO - PROCESS | 13321 | [#1] ext.html Cycles:180 Average:64366.68 Median:40586.80 stddev:129142.55 (318.2%) stddev-sans-first:129416.05 03:12:43 INFO - PROCESS | 13321 | Values: 588.6 608.6 618.5 628.1 632.7 35244.1 38174.2 38227.8 38306.4 38335.2 47396.1 48888.5 48888.5 52255.7 52302.7 9293.5 9383.6 9392.2 9448.3 9450.6 8658.3 8856.6 9297.8 9399.2 9399.5 8973.3 11005.4 11256.9 11267.1 11676.5 11241.9 11302.0 11314.3 11325.7 11333.8 11027.3 11097.6 11104.7 11104.7 11113.6 44459.8 44889.3 44964.1 44992.3 45026.3 3858.6 3908.2 3977.7 3992.0 4269.5 34910.0 34975.0 35319.6 35334.3 35451.6 4784.0 4815.6 4854.0 4876.7 4898.2 365386.0 365805.0 368186.0 368377.0 369428.0 64575.7 64978.0 65095.0 65116.0 65178.3 40887.6 41742.6 41851.0 43600.3 43954.1 19198.5 19355.3 19384.8 19385.8 19410.3 15340.1 15458.0 15459.0 15473.4 15473.5 18651.8 20793.7 20934.0 20941.5 21106.9 6264.2 7331.0 7399.2 7484.4 8041.8 997.8 1049.3 1059.9 1105.2 1131.9 34150.9 34429.8 34579.7 34641.3 34940.3 1125.2 1137.4 1140.3 1148.7 1187.6 17050.5 17977.9 18015.2 18022.5 18042.9 507145.0 510547.0 512497.0 519985.0 523850.0 43254.4 43751.8 55533.4 56878.0 60228.0 1420.2 1433.7 1444.6 1460.1 1468.7 32690.0 34889.0 34926.3 35169.5 35595.5 56186.0 56836.4 56858.4 56867.7 56968.7 461601.0 462471.0 474198.0 662103.0 679155.0 31854.2 31873.5 31927.4 32189.5 32286.4 52184.0 52200.7 52203.5 52205.5 52352.7 44099.1 45318.0 45492.8 46098.3 47331.0 43814.1 44819.0 45341.0 45759.3 46006.8 43181.0 43726.3 44823.1 44959.1 45105.3 37131.1 39851.2 39865.8 40512.0 40661.6 29337.9 29501.7 29882.6 30137.2 30197.1 03:12:43 INFO - PROCESS | 13321 | 03:12:43 INFO - PROCESS | 13321 | [#2] jquery.html Cycles:180 Average:30981.16 Median:2802.52 stddev:90750.32 (3238.2%) stddev-sans-first:90975.89 03:12:43 INFO - PROCESS | 13321 | Values: 420.8 422.4 423.0 429.6 442.0 18793.2 19733.5 20261.9 20435.8 20605.4 19063.8 19843.3 20419.6 20468.8 20636.3 5871.4 6140.4 6144.1 6148.7 6150.9 5714.1 5929.0 5948.0 6011.2 6032.2 6055.2 6058.6 6059.3 6062.7 6068.6 5872.9 5915.0 5925.9 5964.1 6071.8 5802.7 5814.5 5820.0 5820.6 5821.3 12670.7 12710.1 12847.8 12943.9 13914.6 2662.0 2943.1 3004.2 3134.5 3154.7 10281.9 10537.9 10691.5 10709.3 10799.6 1973.6 1994.7 2031.1 2054.8 2064.1 81802.0 84889.2 85760.1 86525.0 88590.6 11035.7 11197.1 11249.7 11469.5 11910.9 17102.0 17150.3 17166.3 17170.8 17177.5 8490.3 8509.5 8813.7 8816.5 8853.6 8259.4 8275.9 8348.3 8431.7 8521.9 4742.9 4767.9 4822.3 4841.0 5311.9 1949.8 2090.5 2127.4 2140.4 2159.7 919.9 981.2 1004.6 1044.0 1052.8 20313.4 20625.4 20730.0 20881.8 20924.7 1000.1 1032.2 1040.2 1041.0 1070.0 10667.3 11536.7 11604.2 11637.4 11652.7 539477.0 547753.0 549552.0 550852.0 567169.0 90199.5 90900.5 91668.5 100233.0 100682.0 996.6 998.7 999.3 1011.4 1029.2 17627.7 18461.5 18577.9 18624.4 18710.0 30428.7 33294.5 45048.0 45526.5 46124.8 62955.4 64317.4 65139.4 65306.3 66175.7 8483.2 8513.4 8554.1 8691.9 8755.9 9634.9 12984.9 13427.7 13437.9 14756.9 10705.8 10760.8 11074.5 11106.1 11614.1 7578.8 12149.6 12315.8 12338.6 12359.6 11278.0 11309.3 11382.5 11389.2 11678.1 6874.6 7618.7 7853.6 7975.7 9858.7 10140.9 10765.4 11087.3 11092.2 11242.2 03:12:43 INFO - PROCESS | 13321 | 03:12:43 INFO - PROCESS | 13321 | [#3] mootools.html Cycles:180 Average:5590.55 Median:5047.41 stddev:3146.41 (62.3%) stddev-sans-first:3139.16 03:12:43 INFO - PROCESS | 13321 | Values: 1358.6 1465.7 1520.1 1651.8 1759.4 7287.5 8188.9 8501.1 8518.8 8746.8 8561.4 8568.3 8629.0 8643.7 8643.9 2325.1 2350.8 2353.8 2354.5 2363.7 2311.3 2319.1 2354.8 2357.8 2363.6 2284.3 2286.6 2288.9 2337.2 2338.6 2266.2 2278.1 2291.7 2294.5 2305.7 2252.1 2259.0 2259.1 2261.5 2262.0 8092.7 8452.0 8608.6 8637.0 8643.2 4921.1 5136.6 5143.6 5148.9 5159.7 3160.1 3205.1 3209.7 3227.9 3232.6 1157.9 1163.7 1172.8 1186.9 1188.6 11558.2 11612.9 11655.5 11673.1 11673.5 4101.6 4157.7 4246.3 4267.1 4374.1 9229.5 9254.6 9259.6 9259.9 9270.7 5026.5 5046.0 5048.8 5049.8 5053.5 4054.6 4166.1 4634.2 4735.7 4773.5 3754.3 3762.9 3803.8 3859.8 3885.9 1090.5 1100.7 1102.4 1103.7 1107.1 852.3 965.2 1007.3 1009.0 1012.6 5793.1 5870.7 5910.9 6008.6 6014.5 441.4 446.8 452.0 455.7 457.4 4037.4 4214.7 4215.6 4253.5 4258.1 10130.9 10567.5 10577.3 10582.8 10606.2 10490.8 10510.6 10513.4 10515.2 10526.8 7436.3 7739.5 7747.1 7900.6 7975.9 5914.5 5938.1 6028.4 6094.6 6136.4 9562.4 9655.3 9676.2 9681.7 9695.0 9637.8 9782.6 9786.0 9794.8 9924.9 7544.4 7729.2 7751.9 7779.6 7815.2 8259.3 8277.0 8311.7 8323.2 8326.3 6998.9 7126.0 7225.7 7302.5 7526.4 7363.4 7406.8 7478.6 7588.5 7611.0 6724.3 6804.3 6808.6 6812.6 6825.8 5233.9 5254.9 5258.9 5275.7 5315.7 5169.4 5172.3 5177.9 5220.1 5325.1 03:12:43 INFO - PROCESS | 13321 | 03:12:43 INFO - PROCESS | 13321 | [#4] prototype.html Cycles:180 Average:4891.10 Median:5553.13 stddev:1445.95 (26.0%) stddev-sans-first:1408.67 03:12:43 INFO - PROCESS | 13321 | Values: 317.2 321.4 326.3 327.2 334.5 5336.4 5482.8 5547.1 5571.2 5598.7 5326.8 5435.8 5445.8 5453.4 5458.2 4272.6 4281.6 4294.2 4304.4 4375.5 4223.3 4257.7 4299.4 4321.9 4348.4 4261.9 4270.1 4272.3 4296.8 4298.7 4264.0 4265.1 4267.4 4268.4 4269.6 3655.1 3789.1 3810.4 3815.4 3820.8 5344.2 5344.3 5379.5 5381.2 5421.8 4834.3 4860.5 4868.2 4874.7 4882.0 5488.7 5700.9 5731.9 5732.5 5780.2 4115.2 4126.8 4140.5 4146.3 4196.8 5975.3 5977.0 5977.6 6017.5 6106.6 4181.6 4274.4 4295.6 4295.8 4300.8 4283.6 4287.4 4299.4 4299.6 4305.4 4893.5 4899.7 4910.9 4930.4 4947.8 5567.9 5719.8 5785.3 5786.1 5811.6 1388.2 1418.7 1436.5 1476.9 1486.2 986.6 1011.7 1026.6 1034.6 1041.3 5536.0 5559.2 5569.4 5581.7 5593.9 5844.8 5853.3 5856.9 5866.2 5876.1 5438.5 5580.6 5603.9 5646.2 5659.0 3098.8 3167.5 3200.3 3200.7 3226.7 6080.3 6111.8 6156.2 6258.5 6267.7 6079.8 6113.3 6120.6 6156.0 6158.4 6116.2 6135.6 6193.7 6199.6 6213.7 5749.3 5986.3 6012.7 6040.9 6042.2 5905.3 5907.5 5923.3 5928.5 5964.5 5934.5 6159.9 6204.2 6212.1 6221.1 4257.6 4261.6 4274.4 4283.4 4317.0 5852.5 5979.2 6072.4 6083.9 6110.5 5707.9 5857.0 5863.4 5866.5 5868.7 5827.2 5853.0 5856.6 5857.8 5865.9 5619.7 5780.7 5811.7 5829.9 5844.6 5893.2 5941.9 5949.9 5962.2 5973.7 5484.7 5743.4 5787.8 5829.7 5839.9 03:12:43 INFO - PROCESS | 13321 | 03:12:43 INFO - PROCESS | 13321 | [#5] yui.html Cycles:180 Average:21112.35 Median:3767.59 stddev:30019.57 (796.8%) stddev-sans-first:30064.93 03:12:43 INFO - PROCESS | 13321 | Values: 771.9 781.5 783.5 812.3 861.7 14652.2 15335.8 15453.2 15542.8 15548.9 14676.9 14833.4 14904.0 14933.5 15049.7 716.8 740.2 833.8 835.1 861.6 872.4 873.0 875.1 875.2 876.3 911.2 911.4 912.5 912.7 913.6 904.9 905.0 909.9 910.6 912.1 672.0 672.1 672.7 673.6 673.8 14621.6 14634.7 14677.0 14684.4 14684.5 13825.1 13964.7 14026.8 14186.9 14481.9 12221.7 12262.3 12480.2 12505.7 12737.7 4013.2 4029.9 4030.7 4132.5 4145.2 84739.6 90611.0 91754.5 91893.1 93757.1 11453.7 11642.0 11658.3 11707.8 11950.6 18313.7 19264.7 23287.3 23294.9 23350.4 8491.9 8542.1 8727.7 8789.0 8854.5 4755.3 4899.5 5053.7 5164.4 5290.2 3616.2 3763.5 3765.7 3769.5 3770.8 617.7 620.5 623.4 629.2 630.5 729.8 734.5 758.9 765.3 787.8 10034.6 10135.1 10510.6 10543.2 11048.4 665.2 666.7 688.3 705.3 741.1 4733.9 4940.1 5070.1 5348.0 5555.8 74854.3 102595.5 103367.5 105333.5 133522.0 91915.5 92147.0 103000.3 104864.0 107735.0 54543.5 84714.0 84789.6 92545.0 93512.0 10169.9 10807.6 10939.0 11018.5 11020.1 36536.3 38482.4 40430.0 52421.7 57668.7 77258.2 79799.2 80662.6 81877.6 82371.6 13277.9 13378.8 13639.2 13684.7 13874.6 15410.1 15512.0 15531.1 15632.8 15727.9 15048.3 15077.7 15504.0 15750.0 16094.8 14775.5 15010.9 15043.4 15092.3 15291.8 14315.9 14551.0 14597.3 14612.6 15413.5 11514.4 11644.2 11894.2 12348.9 12507.3 11828.0 12007.0 12226.8 12494.7 12675.5 03:12:43 INFO - PROCESS | 13321 | -------- Summary: end -------- 03:12:43 INFO - PROCESS | 13321 | 03:12:43 INFO - TEST-INFO | 13321: exit 0 03:12:43 INFO - TEST-OK | dromaeo_css | took 1112648ms 03:12:43 INFO - TEST-START | kraken 03:12:43 INFO - operating with platform_type : linux_ 03:12:43 INFO - Initialising browser for kraken test... 03:12:43 INFO - TEST-INFO | started process 13623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJg2pum/profile http://localhost:51416/getInfo.html) 03:12:47 INFO - PROCESS | 13623 | __metrics Screen width/height:1600/1200 03:12:47 INFO - PROCESS | 13623 | colorDepth:24 03:12:47 INFO - PROCESS | 13623 | Browser inner width/height: 1024/697 03:12:47 INFO - PROCESS | 13623 | __metrics 03:12:48 INFO - PROCESS | 13623 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:12:48 INFO - PROCESS | 13623 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:12:48 INFO - PROCESS | 13623 | console.error: PushService: 03:12:48 INFO - PROCESS | 13623 | stateChangeProcessEnqueue: Error transitioning state 03:12:48 INFO - PROCESS | 13623 | UnknownError 03:12:49 INFO - TEST-INFO | 13623: exit 0 03:12:49 INFO - Browser initialized. 03:12:49 INFO - Running cycle 1/1 for kraken test... 03:12:49 INFO - TEST-INFO | started process 13714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJg2pum/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:13:01 INFO - PROCESS | 13714 | RSS: Main: 143343616 03:13:01 INFO - PROCESS | 13714 | 03:13:03 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51416/tests/kraken/driver.html?testName=audio-beat-detection) 03:13:04 INFO - PROCESS | 13714 | RSS: Main: 187252736 03:13:04 INFO - PROCESS | 13714 | 03:13:06 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51416/tests/kraken/driver.html?testName=audio-dft) 03:13:07 INFO - PROCESS | 13714 | RSS: Main: 174768128 03:13:07 INFO - PROCESS | 13714 | 03:13:10 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51416/tests/kraken/driver.html?testName=audio-fft) 03:13:10 INFO - PROCESS | 13714 | RSS: Main: 265584640 03:13:10 INFO - PROCESS | 13714 | 03:13:12 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51416/tests/kraken/driver.html?testName=audio-oscillator) 03:13:13 INFO - PROCESS | 13714 | RSS: Main: 172347392 03:13:13 INFO - PROCESS | 13714 | 03:13:15 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:13:16 INFO - PROCESS | 13714 | RSS: Main: 174116864 03:13:16 INFO - PROCESS | 13714 | 03:13:19 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51416/tests/kraken/driver.html?testName=imaging-darkroom) 03:13:19 INFO - PROCESS | 13714 | RSS: Main: 209932288 03:13:19 INFO - PROCESS | 13714 | 03:13:23 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51416/tests/kraken/driver.html?testName=imaging-desaturate) 03:13:23 INFO - PROCESS | 13714 | RSS: Main: 209469440 03:13:23 INFO - PROCESS | 13714 | 03:13:26 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51416/tests/kraken/driver.html?testName=json-parse-financial) 03:13:27 INFO - PROCESS | 13714 | RSS: Main: 209502208 03:13:27 INFO - PROCESS | 13714 | 03:13:28 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:13:29 INFO - PROCESS | 13714 | RSS: Main: 170844160 03:13:29 INFO - PROCESS | 13714 | 03:13:30 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:13:31 INFO - PROCESS | 13714 | RSS: Main: 177156096 03:13:31 INFO - PROCESS | 13714 | 03:13:33 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:13:34 INFO - PROCESS | 13714 | RSS: Main: 187777024 03:13:34 INFO - PROCESS | 13714 | 03:13:36 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:37 INFO - PROCESS | 13714 | RSS: Main: 196460544 03:13:37 INFO - PROCESS | 13714 | 03:13:39 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:40 INFO - PROCESS | 13714 | RSS: Main: 192577536 03:13:40 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | Cycle 1(1): loaded http://localhost:51416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51416/tests/kraken/driver.html?testName=ai-astar) 03:13:42 INFO - PROCESS | 13714 | RSS: Main: 242868224 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | __start_tp_report 03:13:42 INFO - PROCESS | 13714 | _x_x_mozilla_page_load 03:13:42 INFO - PROCESS | 13714 | _x_x_mozilla_page_load_details 03:13:42 INFO - PROCESS | 13714 | |i|pagename|runs| 03:13:42 INFO - PROCESS | 13714 | |0;ai-astar;112;114;112;112;113;113;115;112;112;113 03:13:42 INFO - PROCESS | 13714 | |1;audio-beat-detection;148;117;116;162;119;119;120;117;157;116 03:13:42 INFO - PROCESS | 13714 | |2;audio-dft;162;160;162;162;161;160;161;160;162;161 03:13:42 INFO - PROCESS | 13714 | |3;audio-fft;76;76;75;100;75;76;75;76;96;75 03:13:42 INFO - PROCESS | 13714 | |4;audio-oscillator;83;82;121;81;81;81;100;82;81;111 03:13:42 INFO - PROCESS | 13714 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;117;117;116 03:13:42 INFO - PROCESS | 13714 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;145 03:13:42 INFO - PROCESS | 13714 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;95;95 03:13:42 INFO - PROCESS | 13714 | |8;json-parse-financial;51;53;51;50;50;51;49;49;49;50 03:13:42 INFO - PROCESS | 13714 | |9;json-stringify-tinderbox;58;59;58;59;58;58;58;58;59;58 03:13:42 INFO - PROCESS | 13714 | |10;stanford-crypto-aes;73;74;74;77;81;74;74;75;74;82 03:13:42 INFO - PROCESS | 13714 | |11;stanford-crypto-ccm;134;121;130;130;121;129;119;121;161;131 03:13:42 INFO - PROCESS | 13714 | |12;stanford-crypto-pbkdf2;165;156;155;156;159;156;158;155;159;158 03:13:42 INFO - PROCESS | 13714 | |13;stanford-crypto-sha256-iterative;64;64;63;62;63;64;62;63;62;60 03:13:42 INFO - PROCESS | 13714 | __end_tp_report 03:13:42 INFO - PROCESS | 13714 | __start_cc_report 03:13:42 INFO - PROCESS | 13714 | _x_x_mozilla_cycle_collect,1592 03:13:42 INFO - PROCESS | 13714 | __end_cc_report 03:13:42 INFO - PROCESS | 13714 | __startTimestamp1483614822405__endTimestamp 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | ------- Summary: start ------- 03:13:42 INFO - PROCESS | 13714 | Number of tests: 14 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 03:13:42 INFO - PROCESS | 13714 | Values: 112.0 114.0 112.0 112.0 113.0 113.0 115.0 112.0 112.0 113.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:119.50 stddev:18.68 (15.6%) stddev-sans-first:18.52 03:13:42 INFO - PROCESS | 13714 | Values: 148.0 117.0 116.0 162.0 119.0 119.0 120.0 117.0 157.0 116.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 03:13:42 INFO - PROCESS | 13714 | Values: 162.0 160.0 162.0 162.0 161.0 160.0 161.0 160.0 162.0 161.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#3] audio-fft Cycles:10 Average:80.00 Median:76.00 stddev:9.55 (12.6%) stddev-sans-first:10.01 03:13:42 INFO - PROCESS | 13714 | Values: 76.0 76.0 75.0 100.0 75.0 76.0 75.0 76.0 96.0 75.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:81.00 stddev:14.91 (18.4%) stddev-sans-first:15.58 03:13:42 INFO - PROCESS | 13714 | Values: 83.0 82.0 121.0 81.0 81.0 81.0 100.0 82.0 81.0 111.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:13:42 INFO - PROCESS | 13714 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 03:13:42 INFO - PROCESS | 13714 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:13:42 INFO - PROCESS | 13714 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.50 stddev:1.25 (2.5%) stddev-sans-first:1.30 03:13:42 INFO - PROCESS | 13714 | Values: 51.0 53.0 51.0 50.0 50.0 51.0 49.0 49.0 49.0 50.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 03:13:42 INFO - PROCESS | 13714 | Values: 58.0 59.0 58.0 59.0 58.0 58.0 58.0 58.0 59.0 58.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:74.50 stddev:3.19 (4.3%) stddev-sans-first:3.22 03:13:42 INFO - PROCESS | 13714 | Values: 73.0 74.0 74.0 77.0 81.0 74.0 74.0 75.0 74.0 82.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:130.00 stddev:12.21 (9.4%) stddev-sans-first:12.85 03:13:42 INFO - PROCESS | 13714 | Values: 134.0 121.0 130.0 130.0 121.0 129.0 119.0 121.0 161.0 131.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.00 stddev:2.98 (1.9%) stddev-sans-first:1.62 03:13:42 INFO - PROCESS | 13714 | Values: 165.0 156.0 155.0 156.0 159.0 156.0 158.0 155.0 159.0 158.0 03:13:42 INFO - PROCESS | 13714 | 03:13:42 INFO - PROCESS | 13714 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.24 03:13:42 INFO - PROCESS | 13714 | Values: 64.0 64.0 63.0 62.0 63.0 64.0 62.0 63.0 62.0 60.0 03:13:42 INFO - PROCESS | 13714 | -------- Summary: end -------- 03:13:42 INFO - PROCESS | 13714 | 03:13:43 INFO - TEST-INFO | 13714: exit 0 03:13:43 INFO - TEST-OK | kraken | took 59350ms 03:13:43 INFO - SUITE-END | took 1172s 03:13:43 INFO - Completed test suite (00:19:32) 03:13:43 INFO - javascript benchmark 03:13:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.557234201041, 3112.50199968005, 3121.250899784051, 3136.8902088426908, 3152.8738850445984, 5390.811321603745, 5395.136778115492, 5445.700486473243, 5458.645188062778, 5524.06090964536, 5375.462453754622, 5493.725313734317, 5512.91730624041, 5524.1989911462815, 5552.444755524456, 4984.5763110135595, 5011.574016208627, 5038.496150384951, 5071.31537242473, 5080.542751152396, 4910.705357678551, 5042.0, 5088.949110508903, 5097.05704444677, 5100.693958362492, 4898.730569818658, 4913.606911447094, 4958.107540642683, 4982.825601103962, 4996.525330093654, 4997.950020499785, 5016.122178618763, 5031.371078615173, 5095.0574143783515, 5117.5394214520875, 4970.552650261494, 4987.850364489072, 5036.294918711384, 5046.19260918255, 5059.215821547666, 5188.22176673502, 5313.681179129226, 5375.22059301403, 5405.783768649249, 5455.345358556959, 5766.855828604276, 5782.074868021138, 5797.594168408213, 5891.234139561872, 5894.705264736746, 5925.140854576062, 5927.466528012456, 5940.01989671708, 5944.464998150187, 5944.613600115978, 5334.946650533484, 5378.865528361783, 5396.379416367129, 5425.430329815313, 5439.48324909133, 5968.16445697594, 5984.880302393928, 5993.340732519419, 5998.670073145931, 5999.520038396918, 5738.540916726652, 5753.223314852525, 5761.827145185651, 5767.740451679684, 5773.769049238067, 5657.43425657431, 5747.770089196469, 5846.269216347957, 5927.436893495111, 5931.08068249422, 5846.269216347957, 5853.765849365977, 5857.736401861926, 5859.1797148399255, 5883.588148829541, 5813.476787089182, 5847.0, 5863.0, 5870.4716575507555, 5892.587518873724, 4426.535213802569, 4462.062966776948, 4462.955370446254, 4501.774911254424, 4531.27499600069, 3999.6000399960353, 4028.5568587455355, 4049.0, 4049.0484736086996, 4073.674106071507, 5594.552435805126, 5597.944020559742, 5601.159826026129, 5602.299712535933, 5605.607607467519, 5669.0, 5740.885182296331, 5744.224529688522, 5879.764809407661, 5882.411758824169, 5474.315710536183, 5564.054110801174, 5573.470520300565, 5608.831735047955, 5609.242752228479, 5070.518300761421, 5079.415867175248, 5083.8983220335385, 5084.237364395296, 5128.076946149728, 5766.88466230673, 5887.911681324869, 6037.1246169305205, 6044.516438684983, 6048.576599637983, 5887.0580707086665, 5940.257467816523, 5944.256967879015, 5972.462478376967, 5980.940190598212, 6084.148219249397, 6099.4815440688035, 6100.511959043177, 6105.9694701526205, 6106.877862442815, 5577.8047768327915, 5813.3605303417435, 5813.447722466359, 5814.476697097281, 5818.359980402237, 5699.971500142473, 5820.563457740602, 5865.824025279248, 5901.468867801918, 5991.820245392645, 5802.5357971361345, 5826.359100499027, 5831.212786273799, 5832.0, 5834.124881267844, 5683.516901063456, 5811.157382179645, 5812.9709351452975, 5813.709314534341, 5840.2991641003355, 5522.751476183662, 5570.442955704397, 5650.915236271377, 5670.121131224667, 5705.201271821865, 5834.504067154339, 5841.415858414124, 5845.707714614167, 5849.210356601974, 5874.911876321944, 5428.592855535771, 5699.287589051369, 5712.257406537124, 5712.771489140554, 5716.399778023414], "value": 5408.376058390252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.5703436491361, 608.6469847488456, 618.542278713752, 628.0861346740493, 632.7469012395042, 35244.11889702759, 38174.23651526968, 38227.808860955694, 38306.42540361897, 38335.233295334074, 47396.0520789584, 48888.51111488884, 48888.51111488884, 52255.73872130634, 52302.73848630751, 9293.488858112783, 9383.577739001727, 9392.201662858664, 9448.291378146632, 9450.57472413743, 8658.264047555966, 8856.5571721414, 9297.767555811091, 9399.248060155205, 9399.483028433433, 8973.282137429023, 11005.394703291317, 11256.887431125706, 11267.098632109411, 11676.532938682485, 11241.943790281079, 11302.0, 11314.264572802824, 11325.716857078556, 11333.829992550078, 11027.283226590245, 11097.55609775608, 11104.666859994213, 11104.722381940435, 11113.611023614134, 44459.77770111161, 44889.32666010012, 44964.10071798546, 44992.3251151233, 45026.32460513095, 3858.6334298241622, 3908.237893610747, 3977.7016723745833, 3992.0, 4269.487661480611, 34910.0, 34975.0, 35319.64680353215, 35334.293314133574, 35451.64548354509, 4784.0, 4815.638827087947, 4853.95189003436, 4876.707397556158, 4898.24077268024, 365386.0, 365805.0, 368186.0, 368377.0, 369428.0, 64575.67712161409, 64978.0, 65095.0, 65116.0, 65178.348216517225, 40887.59112408838, 41742.582574173866, 41851.0, 43600.3459948101, 43954.12091758147, 19198.520036999187, 19355.322563710204, 19384.80615193858, 19385.806141938683, 19410.320638777575, 15340.079595224322, 15458.0, 15458.995165314218, 15473.381064757508, 15473.5357939262, 18651.813481865007, 20793.688094678593, 20934.0, 20941.47646308824, 21106.894465527574, 6264.21697287839, 7330.973663687088, 7399.223081576357, 7484.363829074589, 8041.839163216703, 997.835357166074, 1049.2602715085845, 1059.86751656043, 1105.2429086075904, 1131.9094472442184, 34150.94622334794, 34429.82785086059, 34579.65420345764, 34641.30717385638, 34940.30119397598, 1125.2179735084037, 1137.391495549877, 1140.3386036099043, 1148.7013376522164, 1187.5843454790754, 17050.48848534546, 17977.910110449364, 18015.18931648079, 18022.459326220236, 18042.90978545099, 507145.0, 510547.0, 512497.0, 519985.0, 523850.0, 43254.35118473225, 43751.78124109359, 55533.44466555364, 56878.0, 60227.99999999913, 1420.2330741399735, 1433.72042451723, 1444.5521888214687, 1460.123925644626, 1468.7209430208227, 32690.0, 34889.0, 34926.30147397089, 35169.47245791264, 35595.466068008485, 56186.0, 56836.43163568311, 56858.431415685314, 56867.715661421425, 56968.715156423954, 461601.0, 462471.0, 474198.0, 662103.0, 679155.0, 31854.203644909063, 31873.521897171096, 31927.361452771278, 32189.517157243128, 32286.35427291394, 52184.0, 52200.738996304775, 52203.47796521986, 52205.47794522006, 52352.73823630858, 44099.11801764011, 45318.0, 45492.772536137105, 46098.30852537282, 47331.0, 43814.12371752611, 44819.0, 45341.0, 45759.313610296536, 46006.76996614996, 43181.0, 43726.344104837815, 44823.10353792971, 44959.100817982806, 45105.323420148066, 37131.07172320713, 39851.2029759409, 39865.80067099762, 40512.0, 40661.59338406696, 29337.85331073331, 29501.704982950756, 29882.551761723156, 30137.246568835955, 30197.09408717742], "value": 21582.027770629335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.8442876135832, 422.3959737575267, 422.98942526436815, 429.6433959813355, 441.96243319317875, 18793.214644608775, 19733.50666233345, 20261.89869050653, 20435.795642043577, 20605.38183854483, 19063.809361906377, 19843.305484308017, 20419.591608167826, 20468.795312046874, 20636.277730279442, 5871.442212989759, 6140.447359737623, 6144.139820425144, 6148.692565371736, 6150.938490615082, 5714.142878568227, 5929.0, 5948.048312270038, 6011.218541589587, 6032.185654936593, 6055.21282233309, 6058.575899687024, 6059.333473317932, 6062.727177277011, 6068.635881847081, 5872.911906321408, 5915.0, 5925.88148237035, 5964.135200395962, 6071.848203794896, 5802.7098645068, 5814.5057670098095, 5820.039693450575, 5820.592558520905, 5821.330546987066, 12670.746585068338, 12710.110292279544, 12847.807282890764, 12943.935280323538, 13914.582562523141, 2661.9600705989424, 2943.0876428307292, 3004.173852190643, 3134.45147099259, 3154.668759780213, 10281.948590257001, 10537.947310263477, 10691.518881650345, 10709.303895246861, 10799.5680172793, 1973.5855470351244, 1994.6908229224348, 2031.14691829432, 2054.8356131509595, 2064.0917996081826, 81802.0, 84889.15110848875, 85760.14239857584, 86525.0, 88590.557047215, 11035.72410689723, 11197.104231661448, 11249.71875703114, 11469.54121835134, 11910.880891190976, 17102.0, 17150.31398744061, 17166.31334746621, 17170.828291717175, 17177.484675459757, 8490.320774338039, 8509.489430634057, 8813.735587932373, 8816.471011739188, 8853.557322133867, 8259.42184047123, 8275.875861862078, 8348.33213342931, 8431.735239714091, 8521.914780852236, 4742.928856067162, 4767.9259522108, 4822.324874517571, 4841.0, 5311.867203319948, 1949.7757757857744, 2090.5400811821373, 2127.3511578968564, 2140.4327853118934, 2159.6914156258367, 919.8712180294764, 981.1856159387692, 1004.5981607357115, 1043.968680939573, 1052.826283663187, 20313.390598282076, 20625.381238562866, 20730.0, 20881.791182088287, 20924.686129707763, 1000.1398797034544, 1032.200044965158, 1040.245821779204, 1041.0422411381546, 1069.973250668724, 10667.253292269466, 11536.653900383002, 11604.187706860439, 11637.359945202927, 11652.708682283012, 539477.0, 547753.0, 549552.0, 550852.0, 567169.0, 90199.54900225588, 90900.54549727209, 91668.54165729128, 100233.0, 100682.0, 996.5714742660581, 998.7403275148514, 999.3404353126901, 1011.4234886114843, 1029.161233594633, 17627.735583965994, 18461.53846153857, 18577.907110464363, 18624.44126676202, 18710.0, 30428.65284818624, 33294.5005824908, 45048.0, 45526.54473455356, 46124.8468788283, 62955.37044629495, 64317.35682643301, 65139.37151571249, 65306.346936530026, 66175.66912165408, 8483.236508714246, 8513.446625969293, 8554.144585541644, 8691.86962195555, 8755.912440875765, 9634.9036509634, 12984.870151298745, 13427.731445370842, 13437.932810335886, 14756.926215368854, 10705.839412408975, 10760.784784304427, 11074.501647425725, 11106.111511078932, 11614.070874329864, 7578.810529736801, 12149.60279567861, 12315.753684926072, 12338.568150114703, 12359.62921112368, 11278.0, 11309.264897781617, 11382.54469821198, 11389.202755807013, 11678.065754739431, 6874.621895795579, 7618.69525218985, 7853.568053757098, 7975.72084977023, 9858.654947076819, 10140.898591013995, 10765.3540787553, 11087.279326843729, 11092.168087393638, 11242.156838237], "value": 9416.725574631255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.578840559426, 1465.6995315960226, 1520.0803513874107, 1651.8348165183484, 1759.3754217252874, 7287.526310789802, 8188.877166842494, 8501.149885011495, 8518.829623407535, 8746.825063498727, 8561.400701950866, 8568.314534837215, 8628.95685521573, 8643.697470588531, 8643.91356086439, 2325.058351367699, 2350.8119350452007, 2353.788159065684, 2354.517323948595, 2363.7399886012527, 2311.3066080175963, 2319.060780383939, 2354.75275096115, 2357.8231632627535, 2363.6454531820277, 2284.2690339091496, 2286.576983258094, 2288.8855557222155, 2337.228714524203, 2338.567365037465, 2266.229481976136, 2278.054607337953, 2291.6677081823127, 2294.529621427612, 2305.723313202418, 2252.054137262354, 2259.0, 2259.0624890670515, 2261.4911644879935, 2262.027328248869, 8092.71675491355, 8451.957740211259, 8608.569571521399, 8636.956815215884, 8643.222110010067, 4921.089598424303, 5136.614753893473, 5143.562797162245, 5148.871278218037, 5159.690418574897, 3160.1309639849223, 3205.086550333144, 3209.7111259986714, 3227.88702395415, 3232.628247751515, 1157.9478923448464, 1163.7148898519831, 1172.8299396587533, 1186.9053698296023, 1188.6374655729999, 11558.248713833575, 11612.941935290353, 11655.533778648844, 11673.124515661275, 11673.474693638722, 4101.610347017028, 4157.7089603727445, 4246.299360605465, 4267.125239325931, 4374.059577190919, 9229.492377919145, 9254.629814807333, 9259.583318750672, 9259.907400925904, 9270.675526356545, 5026.472220416804, 5045.9747701261995, 5048.848534543969, 5049.798008079709, 5053.46938571452, 4054.553999060101, 4166.104287578185, 4634.165850146938, 4735.668503204812, 4773.498782627844, 3754.305453491113, 3762.9247415051545, 3803.8288277027045, 3859.7877116758286, 3885.9222815544094, 1090.5092708281147, 1100.6532942123206, 1102.404701461218, 1103.6688993301977, 1107.0866535108407, 852.2713080316364, 965.1892410375318, 1007.2747621712501, 1008.9545970431349, 1012.5544760305442, 5793.073108302736, 5870.735816888165, 5910.940890591125, 6008.639481631116, 6014.548908831855, 441.4217375238448, 446.76991349455056, 451.9615832654261, 455.7174551777919, 457.4464897474027, 4037.414574886625, 4214.704970652025, 4215.557366476476, 4253.468316460442, 4258.1057977824385, 10130.949345253226, 10567.524461399102, 10577.31247468912, 10582.788344233073, 10606.204534659932, 10490.790184196274, 10510.632127875488, 10513.369197848153, 10515.158787296998, 10526.789464210673, 7436.293552112541, 7739.496932699244, 7747.147813740484, 7900.604969751489, 7975.880361794578, 5914.526837853047, 5938.138969849261, 6028.3971602839365, 6094.603850749687, 6136.447719705248, 9562.378445401027, 9655.324127311022, 9676.177524910461, 9681.66114186, 9695.030496950249, 9637.759056023655, 9782.608695652094, 9786.021397860442, 9794.755131121494, 9924.900750992687, 7544.396448284234, 7729.1884352142215, 7751.92248077512, 7779.57212353326, 7815.179406162271, 8259.256666900008, 8277.04813946404, 8311.6675332986, 8323.209295116954, 8326.25063744266, 6998.930010699828, 7126.037984871976, 7225.674844631899, 7302.525335853153, 7526.360259378014, 7363.447741419523, 7406.8148296290865, 7478.626068696434, 7588.544687318778, 7610.961945190239, 6724.29394913527, 6804.285550017177, 6808.62552559614, 6812.591244525146, 6825.829354266183, 5233.869153271199, 5254.947450525446, 5258.868528286824, 5275.709835958905, 5315.734213289397, 5169.379674438941, 5172.25002374646, 5177.896442071213, 5220.060389129993, 5325.09473389517], "value": 4421.949326104623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2054004718181, 321.3877563242023, 326.27566801700215, 327.22121351184177, 334.4631865855302, 5336.38631557371, 5482.80810171644, 5547.084731019382, 5571.247881535992, 5598.748056337465, 5326.840194794153, 5435.83692489226, 5445.809396671118, 5453.400125986138, 5458.235846981416, 4272.636825869805, 4281.593248641374, 4294.184105020052, 4304.440422745054, 4375.540568240337, 4223.324268117102, 4257.659387249028, 4299.419578356913, 4321.891952701176, 4348.369486424466, 4261.870604289866, 4270.12462445198, 4272.295071313245, 4296.849610263642, 4298.7205831621, 4264.0, 4265.061686428996, 4267.359896015591, 4268.40242366069, 4269.573042695737, 3655.0679576708035, 3789.0865113117975, 3810.428435734634, 3815.4276858471453, 3820.8280627371837, 5344.1716533936915, 5344.278522399465, 5379.488948549882, 5381.2197231401615, 5421.83734487966, 4834.274858771178, 4860.465348811628, 4868.196747536652, 4874.65877388583, 4881.951180488185, 5488.69812160331, 5700.857478563028, 5731.885362292731, 5732.541396688255, 5780.1907732917425, 4115.218108559364, 4126.812789221717, 4140.4617399737845, 4146.253674338618, 4196.790160491963, 5975.25309336333, 5977.0, 5977.6114552553945, 6017.48851347636, 6106.603070800384, 4181.55736270986, 4274.422952901381, 4295.634871035997, 4295.775703924366, 4300.80646370914, 4283.550227226158, 4287.421198138274, 4299.355096735515, 4299.634531064832, 4305.440292761921, 4893.510648935149, 4899.706017638953, 4910.901781964412, 4930.383702037246, 4947.802087916515, 5567.916481252784, 5719.828405147852, 5785.293338465079, 5786.132080187921, 5811.593188476851, 1388.2087210290038, 1418.666613345863, 1436.4756863744658, 1476.859698328657, 1486.2123074770388, 986.5609803637312, 1011.6813203840767, 1026.5893642542894, 1034.6275340877278, 1041.286718597763, 5535.972320138373, 5559.166125081189, 5569.387367389584, 5581.6930068846605, 5593.888122237532, 5844.766209351578, 5853.326867410217, 5856.882862342814, 5866.208061911672, 5876.1479585459865, 5438.5377242934, 5580.609357345028, 5603.943960560424, 5646.2377579027125, 5659.009673307155, 3098.814071155738, 3167.4773662345915, 3200.3439294944483, 3200.727938125239, 3226.741860651189, 6080.300765412034, 6111.755529778759, 6156.199694039746, 6258.499320054476, 6267.6866156691985, 6079.75680972765, 6113.349395663146, 6120.60216085953, 6156.0, 6158.353372895871, 6116.235470566179, 6135.570510064253, 6193.6903154842075, 6199.597026193283, 6213.689315534296, 5749.252597162342, 5986.281646202484, 6012.699365031818, 6040.879182416415, 6042.1843051187525, 5905.320888097752, 5907.4683278505145, 5923.259592550931, 5928.458600763746, 5964.522838173022, 5934.528300943996, 6159.907601385893, 6204.162438070803, 6212.099245609452, 6221.129041934042, 4257.552956939477, 4261.552536983572, 4274.358846173099, 4283.400323954586, 4316.978415107905, 5852.531797456279, 5979.222701048836, 6072.423119803611, 6083.935311320412, 6110.541709371903, 5707.942920570741, 5856.970715146567, 5863.413658634103, 5866.5387421421565, 5868.706564671664, 5827.24245848037, 5852.970735146297, 5856.619319744203, 5857.824265272048, 5865.94134058671, 5619.690916999604, 5780.739866705924, 5811.738471768866, 5829.912551311819, 5844.561657875762, 5893.174955506147, 5941.851453713692, 5949.940500594938, 5962.181534631979, 5973.701314934323, 5484.725763711878, 5743.4256574342235, 5787.768489260551, 5829.650220986754, 5839.912401314069], "value": 4424.3320023825745, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.934385577226, 781.4803155901326, 783.5455435847209, 812.2689579378563, 861.7156338408324, 14652.194129322883, 15335.769963450557, 15453.150076745775, 15542.84457155428, 15548.922255388721, 14676.926615366909, 14833.406663733465, 14904.031237969524, 14933.477328293511, 15049.699006019873, 716.8387112899582, 740.204280398571, 833.7957200485889, 835.1106072033296, 861.5821326656567, 872.3500991761147, 872.9869051964225, 875.0505701314082, 875.2297977779577, 876.3252295732283, 911.2300106410073, 911.4258017448998, 912.4525284829116, 912.7353067610385, 913.6117150211134, 904.8552231642906, 905.0451773379083, 909.8862642169729, 910.576581889418, 912.1289168843738, 671.9832004199885, 672.1497305908031, 672.65694495807, 673.6025744810586, 673.7608149107045, 14621.561353159315, 14634.70730585393, 14677.0, 14684.412623495047, 14684.48604298855, 13825.101368411122, 13964.650883727887, 14026.789598156036, 14186.85813141876, 14481.927590362086, 12221.694457638541, 12262.325572093532, 12480.188787728768, 12505.74988500225, 12737.745245095046, 4013.237484877864, 4029.8992525186814, 4030.6775457963586, 4132.504099508048, 4145.17096580685, 84739.57630211809, 90611.0, 91754.5412272941, 91893.08106918912, 93757.0624293762, 11453.713657158638, 11642.0, 11658.300501969909, 11707.765844683228, 11950.641480755592, 18313.7252941206, 19264.711029334572, 23287.301380958597, 23294.883525582263, 23350.416239594146, 8491.872621910552, 8542.145785421533, 8727.702045756798, 8789.033206347296, 8854.513001784835, 4755.334253204554, 4899.461059283476, 5053.67151135175, 5164.354455693038, 5290.1800220965815, 3616.2044350242904, 3763.4919285896053, 3765.661090501868, 3769.509963704701, 3770.8114594270724, 617.7127635649445, 620.4911972182857, 623.4420193926411, 629.2040568680623, 630.5302549600485, 729.8256747912718, 734.5445823589408, 758.9165191828895, 765.2757374836256, 787.8424315136996, 10034.64878729241, 10135.138513226459, 10510.632127875488, 10543.209259305582, 11048.392338421463, 665.1851481934591, 666.6533402630702, 688.2807466197835, 705.3193668110298, 741.0588552538246, 4733.940376699514, 4940.086084074458, 5070.138076527, 5348.0, 5555.805546805843, 74854.25145748473, 102595.48702256441, 103367.48316258371, 105333.47333263284, 133522.0, 91915.5404222988, 92147.0, 103000.30498017605, 104864.0, 107735.0, 54543.45456545384, 84714.0, 84789.57605212058, 92545.0, 93512.0, 10169.9491502542, 10807.567697292021, 10939.0, 11018.50416731265, 11020.118390528898, 36536.26927461489, 38482.422763659124, 40430.0, 52421.73789131182, 57668.71165644313, 77258.22741772735, 79799.2020079815, 80662.5966870162, 81877.59061204655, 82371.5881420589, 13277.867221327662, 13378.799318010433, 13639.249841258827, 13684.726305474034, 13874.583762487142, 15410.075395476308, 15512.0, 15531.145786981373, 15632.765508517608, 15727.921360393124, 15048.322825472662, 15077.698446030798, 15504.0, 15750.0, 16094.758578621564, 14775.482858099915, 15010.924945375204, 15043.398264069314, 15092.320573095927, 15291.770623440434, 14315.928420357832, 14551.0, 14597.27013649292, 14612.561623151323, 15413.460528881884, 11514.422838064605, 11644.184907056764, 11894.167408281337, 12348.876511234772, 12507.312097834707, 11828.0, 12007.0, 12226.816597750863, 12494.68763280889, 12675.492980281055], "value": 7861.369866316789, "unit": "score"}], "name": "dromaeo_css", "value": 7436.086132409442, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 112.0, 112.0, 113.0, 113.0, 115.0, 112.0, 112.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 116.0, 162.0, 119.0, 119.0, 120.0, 117.0, 157.0, 116.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 161.0, 160.0, 161.0, 160.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 100.0, 75.0, 76.0, 75.0, 76.0, 96.0, 75.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 121.0, 81.0, 81.0, 81.0, 100.0, 82.0, 81.0, 111.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 51.0, 50.0, 50.0, 51.0, 49.0, 49.0, 49.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 77.0, 81.0, 74.0, 74.0, 75.0, 74.0, 82.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 121.0, 130.0, 130.0, 121.0, 129.0, 119.0, 121.0, 161.0, 131.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 156.0, 155.0, 156.0, 159.0, 156.0, 158.0, 155.0, 159.0, 158.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 62.0, 63.0, 64.0, 62.0, 63.0, 62.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1465.3, "alertThreshold": 2.0}]} 03:13:43 INFO - Return code: 0 03:13:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:13:43 INFO - # TBPL SUCCESS # 03:13:43 INFO - Running post-action listener: _resource_record_post_action 03:13:43 INFO - [mozharness: 2017-01-05 11:13:43.702299Z] Finished run-tests step (success) 03:13:43 INFO - Running post-run listener: _resource_record_post_run 03:13:43 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 320688128; Read time: 48; Write time: 196172 03:13:43 INFO - TinderboxPrint: CPU usage
12.9% 03:13:43 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 48 03:13:43 INFO - TinderboxPrint: I/O write bytes / time
320,688,128 / 196,172 03:13:43 INFO - TinderboxPrint: CPU idle
8,247.2 (87.1%) 03:13:43 INFO - TinderboxPrint: CPU user
1,181.0 (12.5%) 03:13:43 INFO - TinderboxPrint: Swap in / out
0 / 0 03:13:43 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 96595968; Read time: 0; Write time: 93408 03:13:43 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 224092160; Read time: 8; Write time: 102764 03:13:44 INFO - Running post-run listener: _upload_blobber_files 03:13:44 INFO - Blob upload gear active. 03:13:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:13:44 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 03:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:13:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:13:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:13:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:13:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:48 INFO - (blobuploader) - INFO - Done attempting. 03:13:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:13:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:13:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:50 INFO - (blobuploader) - INFO - Done attempting. 03:13:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:13:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:13:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:50 INFO - (blobuploader) - INFO - Done attempting. 03:13:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:50 INFO - Return code: 0 03:13:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6f41442d0c41adc0be7e3ee6651099b2b81aa52bb7b0887705c28d426f1f4396f66be7d97f60338efdd72645d0c0240f48355c4cd0c4d9e0050110ef4f71d78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a58c2bc81ee90b44d16fc2e8bbd6cd87e8e9ffba0bf9ae186719ba15dc8562706a07207e541c23af32050c040e5c4490291d2eeb884e9b49e8501e844a8beb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37500632fe940cbade6ac46af8d472ef6192de3564d6d30eb00a481e507c4da638b42a58dacd9f2c12b8b9148901d0756c9235cb9786fb89b3d4a8cf78dbc110"} 03:13:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:50 INFO - Contents: 03:13:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6f41442d0c41adc0be7e3ee6651099b2b81aa52bb7b0887705c28d426f1f4396f66be7d97f60338efdd72645d0c0240f48355c4cd0c4d9e0050110ef4f71d78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a58c2bc81ee90b44d16fc2e8bbd6cd87e8e9ffba0bf9ae186719ba15dc8562706a07207e541c23af32050c040e5c4490291d2eeb884e9b49e8501e844a8beb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37500632fe940cbade6ac46af8d472ef6192de3564d6d30eb00a481e507c4da638b42a58dacd9f2c12b8b9148901d0756c9235cb9786fb89b3d4a8cf78dbc110"} 03:13:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:50 INFO - Copying logs to upload dir... 03:13:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.031256 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-05 03:13:50.329987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 03:13:50.335627) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6f41442d0c41adc0be7e3ee6651099b2b81aa52bb7b0887705c28d426f1f4396f66be7d97f60338efdd72645d0c0240f48355c4cd0c4d9e0050110ef4f71d78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a58c2bc81ee90b44d16fc2e8bbd6cd87e8e9ffba0bf9ae186719ba15dc8562706a07207e541c23af32050c040e5c4490291d2eeb884e9b49e8501e844a8beb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37500632fe940cbade6ac46af8d472ef6192de3564d6d30eb00a481e507c4da638b42a58dacd9f2c12b8b9148901d0756c9235cb9786fb89b3d4a8cf78dbc110"} build_url:https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/fapXeNBORFWNxCAkBG1rTQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6f41442d0c41adc0be7e3ee6651099b2b81aa52bb7b0887705c28d426f1f4396f66be7d97f60338efdd72645d0c0240f48355c4cd0c4d9e0050110ef4f71d78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a58c2bc81ee90b44d16fc2e8bbd6cd87e8e9ffba0bf9ae186719ba15dc8562706a07207e541c23af32050c040e5c4490291d2eeb884e9b49e8501e844a8beb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37500632fe940cbade6ac46af8d472ef6192de3564d6d30eb00a481e507c4da638b42a58dacd9f2c12b8b9148901d0756c9235cb9786fb89b3d4a8cf78dbc110"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 03:13:50.360799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:13:50.361129) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483613598.771860-1704041395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:13:50.444014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 03:13:50.444339) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 03:13:50.444741) ========= ========= Total master_lag: 0.15 =========