builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1489164246.91 results: success (0) revision: 5b0ad641d3214345e7bb7745fdd7bde0cfc6643d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:06.912063) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:06.912503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:06.912769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:06.926857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:06.927136) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-10 08:44:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-03-10 08:44:08 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133805 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:07.074169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:07.074486) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015189 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:07.124091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 08:44:07.124409) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5b0ad641d3214345e7bb7745fdd7bde0cfc6643d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5b0ad641d3214345e7bb7745fdd7bde0cfc6643d --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=a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-10 08:44:08,209 truncating revision to first 12 chars 2017-03-10 08:44:08,209 Setting DEBUG logging. 2017-03-10 08:44:08,209 attempt 1/10 2017-03-10 08:44:08,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5b0ad641d321?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 08:44:08,900 unpacking tar archive at: mozilla-aurora-5b0ad641d321/testing/mozharness/ program finished with exit code 0 elapsedTime=1.069547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 08:44:08.206691) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:08.206987) ========= script_repo_revision: 5b0ad641d3214345e7bb7745fdd7bde0cfc6643d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:08.207374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:08.207645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 08:44:08.216664) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-10 08:44:08.217101) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:09 INFO - MultiFileLogger online at 20170310 08:44:09 in /builds/slave/test 08:44:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:44:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:09 INFO - {'append_to_log': False, 08:44:09 INFO - 'base_work_dir': '/builds/slave/test', 08:44:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:44:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:09 INFO - 'branch': 'Mozilla-Aurora', 08:44:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:09 INFO - 'config_files': ('talos/linux_config.py',), 08:44:09 INFO - 'default_actions': ('clobber', 08:44:09 INFO - 'read-buildbot-config', 08:44:09 INFO - 'download-and-extract', 08:44:09 INFO - 'populate-webroot', 08:44:09 INFO - 'create-virtualenv', 08:44:09 INFO - 'install', 08:44:09 INFO - 'run-tests'), 08:44:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:09 INFO - 'download_minidump_stackwalk': True, 08:44:09 INFO - 'download_symbols': 'ondemand', 08:44:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:09 INFO - 'gecko_profile': False, 08:44:09 INFO - 'gecko_profile_interval': 0, 08:44:09 INFO - 'installer_path': 'installer.exe', 08:44:09 INFO - 'log_level': 'info', 08:44:09 INFO - 'log_name': 'talos', 08:44:09 INFO - 'log_to_console': True, 08:44:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:09 INFO - 'opt_config_files': (), 08:44:09 INFO - 'pip_index': False, 08:44:09 INFO - 'suite': 'dromaeojs', 08:44:09 INFO - 'system_bits': '32', 08:44:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:09 INFO - 'title': 'talos-linux64-ix-064', 08:44:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:09 INFO - 'use_talos_json': True, 08:44:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:09 INFO - 'work_dir': 'build'} 08:44:09 INFO - [mozharness: 2017-03-10 16:44:09.404108Z] Running clobber step. 08:44:09 INFO - Running pre-action listener: _resource_record_pre_action 08:44:09 INFO - Running main action method: clobber 08:44:09 INFO - rmtree: /builds/slave/test/build 08:44:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:10 INFO - Running post-action listener: _resource_record_post_action 08:44:10 INFO - [mozharness: 2017-03-10 16:44:10.397438Z] Finished clobber step (success) 08:44:10 INFO - [mozharness: 2017-03-10 16:44:10.397537Z] Running read-buildbot-config step. 08:44:10 INFO - Running pre-action listener: _resource_record_pre_action 08:44:10 INFO - Running main action method: read_buildbot_config 08:44:10 INFO - Using buildbot properties: 08:44:10 INFO - { 08:44:10 INFO - "project": "", 08:44:10 INFO - "product": "firefox", 08:44:10 INFO - "who": "ffxbld@noreply.mozilla.org", 08:44:10 INFO - "installer_path": "public/build/target.tar.bz2", 08:44:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:44:10 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:44:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:44:10 INFO - "stage_platform": "linux64-pgo", 08:44:10 INFO - "basedir": "/builds/slave/test", 08:44:10 INFO - "buildnumber": 824, 08:44:10 INFO - "platform": "ubuntu64_hw", 08:44:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:44:10 INFO - "slavebuilddir": "test", 08:44:10 INFO - "taskId": "cjcxk5nWQs-9MvVb-f5g1w", 08:44:10 INFO - "branch": "mozilla-aurora", 08:44:10 INFO - "script_repo_revision": "production", 08:44:10 INFO - "revision": "5b0ad641d3214345e7bb7745fdd7bde0cfc6643d", 08:44:10 INFO - "slavename": "talos-linux64-ix-064", 08:44:10 INFO - "repo_path": "releases/mozilla-aurora" 08:44:10 INFO - } 08:44:10 INFO - Finding installer, test and symbols from parent task. 08:44:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cjcxk5nWQs-9MvVb-f5g1w'}, attempt #1 08:44:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cjcxk5nWQs-9MvVb-f5g1w'}, attempt #1 08:44:11 INFO - Task dependencies: H1MZ8SzgQaOeTmFOHNhosw 08:44:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw'}, attempt #1 08:44:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.tar.bz2 08:44:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/test_packages.json 08:44:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.crashreporter-symbols.zip 08:44:11 INFO - Running post-action listener: _resource_record_post_action 08:44:11 INFO - [mozharness: 2017-03-10 16:44:11.782636Z] Finished read-buildbot-config step (success) 08:44:11 INFO - [mozharness: 2017-03-10 16:44:11.782852Z] Running download-and-extract step. 08:44:11 INFO - Running pre-action listener: _resource_record_pre_action 08:44:11 INFO - Running main action method: download_and_extract 08:44:11 INFO - mkdir: /builds/slave/test/build/tests 08:44: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')]} 08:44:11 INFO - trying https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.test_packages.json 08:44:11 INFO - Downloading https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:44:12 INFO - Downloaded 896 bytes. 08:44:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:44:12 INFO - Using the following test package requirements: 08:44:12 INFO - {u'common': [u'target.common.tests.zip'], 08:44:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:44:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:44:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:44:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:44:12 INFO - u'mozbase': [u'target.common.tests.zip'], 08:44:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:44:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:44:12 INFO - u'web-platform': [u'target.common.tests.zip', 08:44:12 INFO - u'target.web-platform.tests.zip'], 08:44:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:44:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:44:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.common.tests.zip 08:44:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:44:12 INFO - Fetch https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.common.tests.zip into memory 08:44:13 INFO - Expected file size: 59529973 08:44:13 INFO - Obtained file size: 59529973 08:44:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:44:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.common.tests.zip 08:44:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:44:23 INFO - Fetch https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.common.tests.zip into memory 08:44:24 INFO - Expected file size: 59529973 08:44:24 INFO - Obtained file size: 59529973 08:44:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.talos.tests.zip 08:44:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:44:34 INFO - Fetch https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.talos.tests.zip into memory 08:44:35 INFO - Expected file size: 14404424 08:44:35 INFO - Obtained file size: 14404424 08:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:35 INFO - trying https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.tar.bz2 08:44:35 INFO - Downloading https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:44:37 INFO - Downloaded 66620630 bytes. 08:44:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.tar.bz2 08:44:37 INFO - mkdir: /builds/slave/test/properties 08:44:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:44:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:44:37 INFO - Contents: 08:44:37 INFO - build_url:https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.tar.bz2 08:44:37 INFO - Running post-action listener: _resource_record_post_action 08:44:37 INFO - Running post-action listener: set_extra_try_arguments 08:44:37 INFO - [mozharness: 2017-03-10 16:44:37.008007Z] Finished download-and-extract step (success) 08:44:37 INFO - [mozharness: 2017-03-10 16:44:37.008104Z] Running populate-webroot step. 08:44:37 INFO - Running pre-action listener: _resource_record_pre_action 08:44:37 INFO - Running main action method: populate_webroot 08:44:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:44:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:44:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:44:37 INFO - '--tppagecycles', 08:44:37 INFO - '7'], 08:44:37 INFO - 'tests': ['tsvgm']}}, 08:44:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:44:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:44:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:44:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:44:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['damp', 'tps']}, 08:44:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'tests': ['damp', 'tps']}, 08:44:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['dromaeo_dom']}, 08:44:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:44:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['basic_compositor_video']}, 08:44:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:44:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['tsvgx', 08:44:37 INFO - 'tsvgr_opacity', 08:44:37 INFO - 'tart', 08:44:37 INFO - 'tscrollx', 08:44:37 INFO - 'cart', 08:44:37 INFO - 'tsvg_static']}, 08:44:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:44:37 INFO - 'tsvgr_opacity', 08:44:37 INFO - 'tart', 08:44:37 INFO - 'tscrollx', 08:44:37 INFO - 'cart', 08:44:37 INFO - 'tsvg_static']}, 08:44:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['tp5o']}, 08:44:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:44:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--disable-e10s', 08:44:37 INFO - '--xperf_path', 08:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:37 INFO - 'tests': ['tp5n']}, 08:44:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--xperf_path', 08:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:37 INFO - 'tests': ['tp5n']}}, 08:44:37 INFO - 'talos.zip': {'path': '', 08:44:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:44:37 INFO - Running post-action listener: _resource_record_post_action 08:44:37 INFO - [mozharness: 2017-03-10 16:44:37.021388Z] Finished populate-webroot step (success) 08:44:37 INFO - [mozharness: 2017-03-10 16:44:37.021478Z] Running create-virtualenv step. 08:44:37 INFO - Running pre-action listener: _resource_record_pre_action 08:44:37 INFO - Running main action method: create_virtualenv 08:44:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:44:37 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 08:44:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:44:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:44:37 INFO - Using real prefix '/usr' 08:44:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:44:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:44:39 INFO - Installing pip.................done. 08:44:39 INFO - Return code: 0 08:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:44:39 INFO - Reading from file tmpfile_stdout 08:44:39 INFO - Output received: 08:44:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:44:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:44:39 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')]} 08:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:39 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')]} 08:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:39 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 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44:39 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 08:44:39 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 08:44:39 INFO - Using env: {'DISPLAY': ':0', 08:44:39 INFO - 'HOME': '/home/cltbld', 08:44:39 INFO - 'LANG': 'en_US.UTF-8', 08:44:39 INFO - 'LANGUAGE': 'en_US:en', 08:44:39 INFO - 'LOGNAME': 'cltbld', 08:44:39 INFO - 'MAIL': '/var/mail/cltbld', 08:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:39 INFO - 'MOZ_NO_REMOTE': '1', 08:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:39 INFO - 'NO_EM_RESTART': '1', 08:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:39 INFO - 'PWD': '/builds/slave/test', 08:44:39 INFO - 'SHELL': '/bin/bash', 08:44:39 INFO - 'SHLVL': '1', 08:44:39 INFO - 'TERM': 'linux', 08:44:39 INFO - 'TMOUT': '86400', 08:44:39 INFO - 'USER': 'cltbld', 08:44:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:39 INFO - '_': '/tools/buildbot/bin/python'} 08:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:39 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 08:44:39 INFO - Cleaning up... 08:44:40 INFO - Return code: 0 08:44:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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', '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 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:44: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 psutil>=3.1.1 08:44:40 INFO - Using env: {'DISPLAY': ':0', 08:44:40 INFO - 'HOME': '/home/cltbld', 08:44:40 INFO - 'LANG': 'en_US.UTF-8', 08:44:40 INFO - 'LANGUAGE': 'en_US:en', 08:44:40 INFO - 'LOGNAME': 'cltbld', 08:44:40 INFO - 'MAIL': '/var/mail/cltbld', 08:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:40 INFO - 'MOZ_NO_REMOTE': '1', 08:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:40 INFO - 'NO_EM_RESTART': '1', 08:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:40 INFO - 'PWD': '/builds/slave/test', 08:44:40 INFO - 'SHELL': '/bin/bash', 08:44:40 INFO - 'SHLVL': '1', 08:44:40 INFO - 'TERM': 'linux', 08:44:40 INFO - 'TMOUT': '86400', 08:44:40 INFO - 'USER': 'cltbld', 08:44:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:40 INFO - '_': '/tools/buildbot/bin/python'} 08:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:40 INFO - Downloading/unpacking psutil>=3.1.1 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:44:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:42 INFO - Installing collected packages: psutil 08:44:42 INFO - Running setup.py install for psutil 08:44:42 INFO - building 'psutil._psutil_linux' extension 08:44:42 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 08:44:42 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 08:44:42 INFO - building 'psutil._psutil_posix' extension 08:44:42 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 08:44:42 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 08:44:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:42 INFO - Successfully installed psutil 08:44:42 INFO - Cleaning up... 08:44:42 INFO - Return code: 0 08:44:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:44:42 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')]} 08:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:42 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')]} 08:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:42 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 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44:42 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 08:44:42 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 08:44:42 INFO - Using env: {'DISPLAY': ':0', 08:44:42 INFO - 'HOME': '/home/cltbld', 08:44:42 INFO - 'LANG': 'en_US.UTF-8', 08:44:42 INFO - 'LANGUAGE': 'en_US:en', 08:44:42 INFO - 'LOGNAME': 'cltbld', 08:44:42 INFO - 'MAIL': '/var/mail/cltbld', 08:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:42 INFO - 'MOZ_NO_REMOTE': '1', 08:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:42 INFO - 'NO_EM_RESTART': '1', 08:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:42 INFO - 'PWD': '/builds/slave/test', 08:44:42 INFO - 'SHELL': '/bin/bash', 08:44:42 INFO - 'SHLVL': '1', 08:44:42 INFO - 'TERM': 'linux', 08:44:42 INFO - 'TMOUT': '86400', 08:44:42 INFO - 'USER': 'cltbld', 08:44:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:42 INFO - '_': '/tools/buildbot/bin/python'} 08:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:44:45 INFO - Installing collected packages: mozsystemmonitor 08:44:45 INFO - Running setup.py install for mozsystemmonitor 08:44:45 INFO - Successfully installed mozsystemmonitor 08:44:45 INFO - Cleaning up... 08:44:45 INFO - Return code: 0 08:44:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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', '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 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:44: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 jsonschema==2.5.1 08:44:45 INFO - Using env: {'DISPLAY': ':0', 08:44:45 INFO - 'HOME': '/home/cltbld', 08:44:45 INFO - 'LANG': 'en_US.UTF-8', 08:44:45 INFO - 'LANGUAGE': 'en_US:en', 08:44:45 INFO - 'LOGNAME': 'cltbld', 08:44:45 INFO - 'MAIL': '/var/mail/cltbld', 08:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:45 INFO - 'MOZ_NO_REMOTE': '1', 08:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:45 INFO - 'NO_EM_RESTART': '1', 08:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:45 INFO - 'PWD': '/builds/slave/test', 08:44:45 INFO - 'SHELL': '/bin/bash', 08:44:45 INFO - 'SHLVL': '1', 08:44:45 INFO - 'TERM': 'linux', 08:44:45 INFO - 'TMOUT': '86400', 08:44:45 INFO - 'USER': 'cltbld', 08:44:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:45 INFO - '_': '/tools/buildbot/bin/python'} 08:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:47 INFO - warning: no files found matching '*.txt' 08:44:47 INFO - no previously-included directories found matching 'build' 08:44:47 INFO - no previously-included directories found matching 'dist' 08:44:47 INFO - no previously-included directories found matching '.git*' 08:44:47 INFO - Installing collected packages: jsonschema, functools32 08:44:47 INFO - Running setup.py install for functools32 08:44:47 INFO - warning: no files found matching '*.txt' 08:44:47 INFO - no previously-included directories found matching 'build' 08:44:47 INFO - no previously-included directories found matching 'dist' 08:44:47 INFO - no previously-included directories found matching '.git*' 08:44:47 INFO - Successfully installed jsonschema functools32 08:44:47 INFO - Cleaning up... 08:44:48 INFO - Return code: 0 08:44:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:44:48 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')]} 08:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:48 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')]} 08:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:48 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 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44:48 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 08:44:48 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 08:44:48 INFO - Using env: {'DISPLAY': ':0', 08:44:48 INFO - 'HOME': '/home/cltbld', 08:44:48 INFO - 'LANG': 'en_US.UTF-8', 08:44:48 INFO - 'LANGUAGE': 'en_US:en', 08:44:48 INFO - 'LOGNAME': 'cltbld', 08:44:48 INFO - 'MAIL': '/var/mail/cltbld', 08:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:48 INFO - 'MOZ_NO_REMOTE': '1', 08:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:48 INFO - 'NO_EM_RESTART': '1', 08:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:48 INFO - 'PWD': '/builds/slave/test', 08:44:48 INFO - 'SHELL': '/bin/bash', 08:44:48 INFO - 'SHLVL': '1', 08:44:48 INFO - 'TERM': 'linux', 08:44:48 INFO - 'TMOUT': '86400', 08:44:48 INFO - 'USER': 'cltbld', 08:44:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:48 INFO - '_': '/tools/buildbot/bin/python'} 08:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:44:48 INFO - Cleaning up... 08:44:48 INFO - Return code: 0 08:44:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44:48 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')]} 08:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:48 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')]} 08:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:48 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 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44:48 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 08:44:48 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 08:44:48 INFO - Using env: {'DISPLAY': ':0', 08:44:48 INFO - 'HOME': '/home/cltbld', 08:44:48 INFO - 'LANG': 'en_US.UTF-8', 08:44:48 INFO - 'LANGUAGE': 'en_US:en', 08:44:48 INFO - 'LOGNAME': 'cltbld', 08:44:48 INFO - 'MAIL': '/var/mail/cltbld', 08:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:48 INFO - 'MOZ_NO_REMOTE': '1', 08:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:48 INFO - 'NO_EM_RESTART': '1', 08:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:48 INFO - 'PWD': '/builds/slave/test', 08:44:48 INFO - 'SHELL': '/bin/bash', 08:44:48 INFO - 'SHLVL': '1', 08:44:48 INFO - 'TERM': 'linux', 08:44:48 INFO - 'TMOUT': '86400', 08:44:48 INFO - 'USER': 'cltbld', 08:44:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:48 INFO - '_': '/tools/buildbot/bin/python'} 08:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:48 INFO - Downloading/unpacking blobuploader==1.2.4 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 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 08:44:50 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 08:44:51 INFO - Downloading docopt-0.6.1.tar.gz 08:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:51 INFO - Running setup.py install for blobuploader 08:44:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:51 INFO - Running setup.py install for requests 08:44:51 INFO - Running setup.py install for docopt 08:44:51 INFO - Successfully installed blobuploader requests docopt 08:44:51 INFO - Cleaning up... 08:44:51 INFO - Return code: 0 08:44:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:51 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')]} 08:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:51 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')]} 08:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:51 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 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44:51 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 08:44:51 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 08:44:51 INFO - Using env: {'DISPLAY': ':0', 08:44:51 INFO - 'HOME': '/home/cltbld', 08:44:51 INFO - 'LANG': 'en_US.UTF-8', 08:44:51 INFO - 'LANGUAGE': 'en_US:en', 08:44:51 INFO - 'LOGNAME': 'cltbld', 08:44:51 INFO - 'MAIL': '/var/mail/cltbld', 08:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:51 INFO - 'MOZ_NO_REMOTE': '1', 08:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:51 INFO - 'NO_EM_RESTART': '1', 08:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:51 INFO - 'PWD': '/builds/slave/test', 08:44:51 INFO - 'SHELL': '/bin/bash', 08:44:51 INFO - 'SHLVL': '1', 08:44:51 INFO - 'TERM': 'linux', 08:44:51 INFO - 'TMOUT': '86400', 08:44:51 INFO - 'USER': 'cltbld', 08:44:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:51 INFO - '_': '/tools/buildbot/bin/python'} 08:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:52 INFO - Running setup.py (path:/tmp/pip-YkrIke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:52 INFO - Running setup.py (path:/tmp/pip-HeTA6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:52 INFO - Running setup.py (path:/tmp/pip-zED__i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:52 INFO - Running setup.py (path:/tmp/pip-mjoQu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:52 INFO - Running setup.py (path:/tmp/pip-BgeMy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:52 INFO - Running setup.py (path:/tmp/pip-Piplki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:52 INFO - Running setup.py (path:/tmp/pip-EfohFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:52 INFO - Running setup.py (path:/tmp/pip-WKzbMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:52 INFO - Running setup.py (path:/tmp/pip-IzQ8mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:52 INFO - Running setup.py (path:/tmp/pip-7A1hWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:52 INFO - Running setup.py (path:/tmp/pip-5YjE3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:52 INFO - Running setup.py (path:/tmp/pip-ytiNNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:52 INFO - Running setup.py (path:/tmp/pip-67E_pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:53 INFO - Running setup.py (path:/tmp/pip-MLGaKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:53 INFO - Running setup.py (path:/tmp/pip-TljcuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:53 INFO - Running setup.py (path:/tmp/pip-qp_A5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:53 INFO - Running setup.py (path:/tmp/pip-KXTcGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:53 INFO - Running setup.py install for manifestparser 08:44:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:53 INFO - Running setup.py install for mozcrash 08:44:53 INFO - Running setup.py install for mozdebug 08:44:53 INFO - Running setup.py install for mozdevice 08:44:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:44:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:53 INFO - Running setup.py install for mozfile 08:44:53 INFO - Running setup.py install for mozhttpd 08:44:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:53 INFO - Running setup.py install for mozinfo 08:44:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Running setup.py install for mozInstall 08:44:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Running setup.py install for mozleak 08:44:54 INFO - Running setup.py install for mozlog 08:44:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Running setup.py install for moznetwork 08:44:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Running setup.py install for mozprocess 08:44:54 INFO - Running setup.py install for mozprofile 08:44:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Running setup.py install for mozrunner 08:44:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:54 INFO - Running setup.py install for mozscreenshot 08:44:54 INFO - Running setup.py install for moztest 08:44:55 INFO - Running setup.py install for mozversion 08:44:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:55 INFO - Cleaning up... 08:44:55 INFO - Return code: 0 08:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:55 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 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44:55 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 08:44:55 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 08:44:55 INFO - Using env: {'DISPLAY': ':0', 08:44:55 INFO - 'HOME': '/home/cltbld', 08:44:55 INFO - 'LANG': 'en_US.UTF-8', 08:44:55 INFO - 'LANGUAGE': 'en_US:en', 08:44:55 INFO - 'LOGNAME': 'cltbld', 08:44:55 INFO - 'MAIL': '/var/mail/cltbld', 08:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:55 INFO - 'MOZ_NO_REMOTE': '1', 08:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:55 INFO - 'NO_EM_RESTART': '1', 08:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:55 INFO - 'PWD': '/builds/slave/test', 08:44:55 INFO - 'SHELL': '/bin/bash', 08:44:55 INFO - 'SHLVL': '1', 08:44:55 INFO - 'TERM': 'linux', 08:44:55 INFO - 'TMOUT': '86400', 08:44:55 INFO - 'USER': 'cltbld', 08:44:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:55 INFO - '_': '/tools/buildbot/bin/python'} 08:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:55 INFO - Running setup.py (path:/tmp/pip-bUkAly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:55 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)) 08:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:55 INFO - Running setup.py (path:/tmp/pip-xzRhLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:55 INFO - Running setup.py (path:/tmp/pip-mgijwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:55 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)) 08:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:55 INFO - Running setup.py (path:/tmp/pip-_5I03q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:55 INFO - Running setup.py (path:/tmp/pip-0_TyPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:55 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)) 08:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:55 INFO - Running setup.py (path:/tmp/pip-02eC8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:55 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)) 08:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:55 INFO - Running setup.py (path:/tmp/pip-6gXg88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:55 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)) 08:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:55 INFO - Running setup.py (path:/tmp/pip-LgXUpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:55 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)) 08:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:55 INFO - Running setup.py (path:/tmp/pip-tjDXYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:56 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)) 08:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:56 INFO - Running setup.py (path:/tmp/pip-LLWXn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:56 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)) 08:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:56 INFO - Running setup.py (path:/tmp/pip-IhZ_6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:56 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)) 08:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:56 INFO - Running setup.py (path:/tmp/pip-UYS8wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 08:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:56 INFO - Running setup.py (path:/tmp/pip-GtVqQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:56 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)) 08:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:56 INFO - Running setup.py (path:/tmp/pip-cmi7Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:56 INFO - Running setup.py (path:/tmp/pip-x6Aijq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:56 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)) 08:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:56 INFO - Running setup.py (path:/tmp/pip-uxuoh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:56 INFO - Running setup.py (path:/tmp/pip-IsdH06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:56 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)) 08:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:56 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)) 08:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:56 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 08:44:56 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 08:44:56 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 08:44:56 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 08:44:56 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 08:44:56 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 08:44:58 INFO - Downloading blessings-1.6.tar.gz 08:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:58 INFO - Installing collected packages: blessings 08:44:58 INFO - Running setup.py install for blessings 08:44:58 INFO - Successfully installed blessings 08:44:58 INFO - Cleaning up... 08:44:58 INFO - Return code: 0 08:44:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:59 INFO - Reading from file tmpfile_stdout 08:44:59 INFO - Current package versions: 08:44:59 INFO - argparse == 1.2.1 08:44:59 INFO - blessings == 1.6 08:44:59 INFO - blobuploader == 1.2.4 08:44:59 INFO - docopt == 0.6.1 08:44:59 INFO - functools32 == 3.2.3-2 08:44:59 INFO - jsonschema == 2.5.1 08:44:59 INFO - manifestparser == 1.1 08:44:59 INFO - mozInstall == 1.12 08:44:59 INFO - mozcrash == 1.0 08:44:59 INFO - mozdebug == 0.1 08:44:59 INFO - mozdevice == 0.49 08:44:59 INFO - mozfile == 1.2 08:44:59 INFO - mozhttpd == 0.7 08:44:59 INFO - mozinfo == 0.9 08:44:59 INFO - mozleak == 0.1 08:44:59 INFO - mozlog == 3.4 08:44:59 INFO - moznetwork == 0.27 08:44:59 INFO - mozprocess == 0.25 08:44:59 INFO - mozprofile == 0.28 08:44:59 INFO - mozrunner == 6.13 08:44:59 INFO - mozscreenshot == 0.1 08:44:59 INFO - mozsystemmonitor == 0.3 08:44:59 INFO - moztest == 0.8 08:44:59 INFO - mozversion == 1.4 08:44:59 INFO - psutil == 3.1.1 08:44:59 INFO - requests == 1.2.3 08:44:59 INFO - wsgiref == 0.1.2 08:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:59 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 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44:59 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 08:44:59 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 08:44:59 INFO - Using env: {'DISPLAY': ':0', 08:44:59 INFO - 'HOME': '/home/cltbld', 08:44:59 INFO - 'LANG': 'en_US.UTF-8', 08:44:59 INFO - 'LANGUAGE': 'en_US:en', 08:44:59 INFO - 'LOGNAME': 'cltbld', 08:44:59 INFO - 'MAIL': '/var/mail/cltbld', 08:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:59 INFO - 'MOZ_NO_REMOTE': '1', 08:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:59 INFO - 'NO_EM_RESTART': '1', 08:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:59 INFO - 'PWD': '/builds/slave/test', 08:44:59 INFO - 'SHELL': '/bin/bash', 08:44:59 INFO - 'SHLVL': '1', 08:44:59 INFO - 'TERM': 'linux', 08:44:59 INFO - 'TMOUT': '86400', 08:44:59 INFO - 'USER': 'cltbld', 08:44:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:59 INFO - '_': '/tools/buildbot/bin/python'} 08:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:59 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)) 08:44:59 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)) 08:44:59 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)) 08:44:59 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)) 08:44:59 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)) 08:44:59 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)) 08:44:59 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)) 08:44:59 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)) 08:44:59 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)) 08:44:59 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)) 08:44:59 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)) 08:44:59 INFO - Cleaning up... 08:44:59 INFO - Return code: 0 08:44:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', '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 08:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:44:59 INFO - Using env: {'DISPLAY': ':0', 08:44:59 INFO - 'HOME': '/home/cltbld', 08:44:59 INFO - 'LANG': 'en_US.UTF-8', 08:44:59 INFO - 'LANGUAGE': 'en_US:en', 08:44:59 INFO - 'LOGNAME': 'cltbld', 08:44:59 INFO - 'MAIL': '/var/mail/cltbld', 08:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:59 INFO - 'MOZ_NO_REMOTE': '1', 08:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:59 INFO - 'NO_EM_RESTART': '1', 08:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:59 INFO - 'PWD': '/builds/slave/test', 08:44:59 INFO - 'SHELL': '/bin/bash', 08:44:59 INFO - 'SHLVL': '1', 08:44:59 INFO - 'TERM': 'linux', 08:44:59 INFO - 'TMOUT': '86400', 08:44:59 INFO - 'USER': 'cltbld', 08:44:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:59 INFO - '_': '/tools/buildbot/bin/python'} 08:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:44:59 INFO - Cleaning up... 08:44:59 INFO - Return code: 0 08:44:59 INFO - Running post-action listener: _resource_record_post_action 08:44:59 INFO - Running post-action listener: _start_resource_monitoring 08:44:59 INFO - Starting resource monitoring. 08:44:59 INFO - [mozharness: 2017-03-10 16:44:59.598862Z] Finished create-virtualenv step (success) 08:44:59 INFO - [mozharness: 2017-03-10 16:44:59.599377Z] Running install step. 08:44:59 INFO - Running pre-action listener: _resource_record_pre_action 08:44:59 INFO - Running main action method: install 08:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:59 INFO - Reading from file tmpfile_stdout 08:44:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:59 INFO - Reading from file tmpfile_stdout 08:44:59 INFO - Output received: 08:44:59 INFO - Usage: mozinstall [options] installer 08:44:59 INFO - Options: 08:44:59 INFO - -h, --help show this help message and exit 08:44:59 INFO - -d DEST, --destination=DEST 08:44:59 INFO - Directory to install application into. [default: 08:44:59 INFO - "/builds/slave/test"] 08:44:59 INFO - --app=APP Application being installed. [default: firefox] 08:44:59 INFO - mkdir: /builds/slave/test/build/application 08:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:45:16 INFO - Reading from file tmpfile_stdout 08:45:16 INFO - Output received: 08:45:16 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:16 INFO - Running post-action listener: _resource_record_post_action 08:45:16 INFO - [mozharness: 2017-03-10 16:45:16.538806Z] Finished install step (success) 08:45:16 INFO - [mozharness: 2017-03-10 16:45:16.539080Z] Running run-tests step. 08:45:16 INFO - Running pre-action listener: _resource_record_pre_action 08:45:16 INFO - Running main action method: run_tests 08:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:16 INFO - Python 2.7.3 08:45:16 INFO - Return code: 0 08:45:16 INFO - grabbing minidump binary from tooltool 08:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642290>, '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 0x1642b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:45:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:45:16 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 08:45:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:16 INFO - Return code: 0 08:45:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:16 INFO - ENV: RUST_BACKTRACE is now 1 08:45:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 08:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 08:45:16 INFO - Using env: {'DISPLAY': ':0', 08:45:16 INFO - 'HOME': '/home/cltbld', 08:45:16 INFO - 'LANG': 'en_US.UTF-8', 08:45:16 INFO - 'LANGUAGE': 'en_US:en', 08:45:16 INFO - 'LOGNAME': 'cltbld', 08:45:16 INFO - 'MAIL': '/var/mail/cltbld', 08:45:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:16 INFO - 'MOZ_NO_REMOTE': '1', 08:45:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:16 INFO - 'NO_EM_RESTART': '1', 08:45:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:16 INFO - 'PWD': '/builds/slave/test', 08:45:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:16 INFO - 'RUST_BACKTRACE': '1', 08:45:16 INFO - 'SHELL': '/bin/bash', 08:45:16 INFO - 'SHLVL': '1', 08:45:16 INFO - 'TERM': 'linux', 08:45:16 INFO - 'TMOUT': '86400', 08:45:16 INFO - 'USER': 'cltbld', 08:45:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549', 08:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:16 INFO - '_': '/tools/buildbot/bin/python'} 08:45:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 08:45:16 INFO - mozversion application_buildid: 20170310154536 08:45:16 INFO - mozversion application_changeset: 5b0ad641d3214345e7bb7745fdd7bde0cfc6643d 08:45:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:45:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:16 INFO - mozversion application_name: Firefox 08:45:16 INFO - mozversion application_remotingname: firefox-dev 08:45:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:45:16 INFO - mozversion application_vendor: Mozilla 08:45:16 INFO - mozversion application_version: 54.0a2 08:45:16 INFO - mozversion platform_buildid: 20170310154536 08:45:16 INFO - mozversion platform_changeset: 5b0ad641d3214345e7bb7745fdd7bde0cfc6643d 08:45:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:45:16 INFO - mozversion platform_version: 54.0a2 08:45:16 INFO - using testdate: 1489164316 08:45:16 INFO - actual date: 1489164316 08:45:16 INFO - starting webserver on 'localhost:55359' 08:45:16 INFO - SUITE-START | Running 2 tests 08:45:16 INFO - TEST-START | dromaeo_css 08:45:16 INFO - operating with platform_type : linux_ 08:45:16 INFO - Initialising browser for dromaeo_css test... 08:45:16 INFO - TEST-INFO | started process 4223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2d7Ran/profile http://localhost:55359/getInfo.html) 08:45:21 INFO - PROCESS | 4223 | __metrics Screen width/height:1600/1200 08:45:21 INFO - PROCESS | 4223 | colorDepth:24 08:45:21 INFO - PROCESS | 4223 | Browser inner width/height: 1024/697 08:45:21 INFO - PROCESS | 4223 | __metrics 08:45:22 INFO - PROCESS | 4223 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:45:22 INFO - PROCESS | 4223 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:22 INFO - PROCESS | 4223 | console.error: PushService: 08:45:22 INFO - PROCESS | 4223 | stateChangeProcessEnqueue: Error transitioning state 08:45:22 INFO - PROCESS | 4223 | UnknownError 08:45:23 INFO - TEST-INFO | 4223: exit 0 08:45:23 INFO - Browser initialized. 08:45:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:23 INFO - TEST-INFO | started process 4313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2d7Ran/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:35 INFO - PROCESS | 4313 | RSS: Main: 139350016 08:45:35 INFO - PROCESS | 4313 | 08:48:36 INFO - PROCESS | 4313 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55359/tests/dromaeo/cssquery-ext.html) 08:48:38 INFO - PROCESS | 4313 | RSS: Main: 269291520 08:48:38 INFO - PROCESS | 4313 | 08:50:24 INFO - PROCESS | 4313 | ************************* 08:50:24 INFO - PROCESS | 4313 | A coding exception was thrown and uncaught in a Task. 08:50:24 INFO - PROCESS | 4313 | 08:50:24 ERROR - PROCESS | 4313 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:50:24 INFO - PROCESS | 4313 | Full stack: 08:50:24 INFO - PROCESS | 4313 | ************************* 08:51:40 INFO - PROCESS | 4313 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-ext.html (next: http://localhost:55359/tests/dromaeo/cssquery-jquery.html) 08:51:40 INFO - PROCESS | 4313 | RSS: Main: 224518144 08:51:40 INFO - PROCESS | 4313 | 08:54:42 INFO - PROCESS | 4313 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55359/tests/dromaeo/cssquery-mootools.html) 08:54:43 INFO - PROCESS | 4313 | RSS: Main: 172871680 08:54:43 INFO - PROCESS | 4313 | 08:57:45 INFO - PROCESS | 4313 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55359/tests/dromaeo/cssquery-prototype.html) 08:57:46 INFO - PROCESS | 4313 | RSS: Main: 170852352 08:57:46 INFO - PROCESS | 4313 | 09:00:48 INFO - PROCESS | 4313 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55359/tests/dromaeo/cssquery-yui.html) 09:00:49 INFO - PROCESS | 4313 | RSS: Main: 174960640 09:00:49 INFO - PROCESS | 4313 | 09:03:51 INFO - PROCESS | 4313 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-yui.html (next: http://localhost:55359/tests/dromaeo/cssquery-dojo.html) 09:03:52 INFO - PROCESS | 4313 | RSS: Main: 269201408 09:03:52 INFO - PROCESS | 4313 | 09:03:52 INFO - PROCESS | 4313 | __start_tp_report 09:03:52 INFO - PROCESS | 4313 | _x_x_mozilla_page_load 09:03:52 INFO - PROCESS | 4313 | _x_x_mozilla_page_load_details 09:03:52 INFO - PROCESS | 4313 | |i|pagename|runs| 09:03:52 INFO - PROCESS | 4313 | |0;dojo.html;3337.4660054391293;3435.0553597760613;3442.5180474733534;3456.637053109425;3470.0110468516477;5737.110747834087;5794.130880367947;5803.506701930341;5813.040848260042;5814.331351894533;5805.680687562182;5840.970795146019;5848.502877255439;5856.033754430514;5870.970645146779;5200.141976573861;5208.192730126836;5210.687358758487;5270.314859068316;5289.947100528984;5105.132127538327;5292.417834038252;5294.655847369928;5302;5304.20436934461;5140.434552199255;5167.276581278624;5179.04187725272;5259.027079990195;5276.287701160351;5256.211568264753;5282.841514754564;5284.973575132138;5286.127788914824;5286.629935904508;5089.796408143669;5123.769430375642;5249.921251181236;5252.816151434681;5260.737423018486;5538.944610553883;5577.553795696334;5584.190292407578;5641.576881733846;5697.116946873241;6155.876882462326;6188.133661287423;6188.133661287423;6194.938050619481;6198.884200843846;6165.229346331708;6193.752249909998;6202.224721909762;6202.96898515509;6203.0075187969705;5538.382149360631;5594.412586678422;5784.363719990755;5784.392638772911;5828.1549175369755;6201.348858369896;6209.720562574695;6211.9689401553605;6217.440430361289;6278.121063051177;6111.387369467926;6144.907826382608;6153.600015998945;6157.4458298753325;6164.630122192682;6236.875262494725;6247.781327653511;6248.875022499616;6251.218597675291;6258.374162583706;5899.144624029577;5942.524598032147;6205.069239614094;6206.627602343874;6207.068939658997;6019;6025.879482410415;6033.879322413527;6044;6111.51107911366;4706.176419126639;4720.362751028636;4735.550122738335;4738.810447582127;4741.549552792549;4188.8324467020975;4190.1200747843295;4218.8523401680795;4219;4239.788010599519;5932.40675932412;5945.554083443759;5962.314333851576;5977.312609049928;5991.131285963511;6126.456603435028;6135.0797380392405;6142.897836592492;6243.313235544087;6265.843353916189;5909.5863289569315;6016.939830601726;6023.819285421444;6037.879242415215;6075.969620151871;5242.790288388422;5246.134387825966;5258.684478931276;5293.100172970604;5299.49654782795;6212.689365531705;6284.842878927972;6430.131932189188;6508.707108180238;6563.737450502022;6287.654179020198;6294.653794041372;6307.211598550181;6308.211473565804;6309.432151106423;6585;6591.604503729792;6597.439217666552;6599.934000660124;6604.504662150454;5983.700814959322;6034;6130.693465326805;6151.72317245716;6183.628982261079;6142.775043102407;6150.846228844314;6308.71610777507;6310.936890631218;6320.5891617044745;5898.734556944862;6108.725107370268;6113.29697084841;6114.144019837137;6116.26604807426;5910.497607703393;5994.970025149846;6012.398760124128;6112.235970503687;6141.785037523665;6063.909041364472;6064.757409703562;6081.726322315418;6097.512199023979;6100.816975490742;5867.383924687846;5902.203202567598;5902.7343769531335;5904.3210030845285;5961.016432288624;5861.1501332307425;5865.560082993878;5868.647881127146;5869.706514674334;5878.764849405976 09:03:52 INFO - PROCESS | 4313 | |1;ext.html;760.7109298466581;818.087832067245;836.5022811427199;912.6075787411411;927.5408672707011;30780.846095769517;42838.78580607096;42920.78539607306;42982.14035719284;43009.13981720368;38555.42166867492;38757.41863872037;39072.21855562887;42241.788791056;42410.57589424105;7432.293932076444;7582.848343033136;8900.065493123242;9042.728718138467;9045.909540904606;10361.89638103617;10555.208359373039;10868.510917008714;10883.891161088366;10890.455477226147;10681.038706516412;10694.78610427791;10710.089642380408;10711;10714.196435267348;10564.313319634199;10611.204159688054;10618;10619.203559733012;10631.627893023708;10218.591256349737;10224.437655928921;10236.078752912274;10238.334508257014;10273.178145748323;42294.57705422968;42761.57238427607;42772.786136069124;42788;42798.1440371194;4057.6145266199665;4075.042365044212;4106.856260030914;4135.9172816543805;4194.727342722713;29191.708082919326;29592.8520357399;29790.25524361908;29914.850425747733;31085.844570777226;4358.8910277243;4374.868753937387;4412.271975124133;4416.933745993781;4466.553344665507;226002.99999999834;226271;226585;226971;227000;53107.46892531103;53270.200946985824;53485.1977220342;53670.46329536655;53775.46224537704;53613.46386536163;53644.73177634165;53738.731306343216;53843.19235211475;53909.46090539044;15750.68498630021;16031.19844007795;16069.357225711074;16076.276567554489;16082.356705731874;12045.879541204476;12334;14166.433342666178;14215.64460888486;14236.07465514759;12584.307863067435;12846.614601561969;13061.477540898448;13133.474661013452;13175.67060823487;5618.073017951992;5623.128415095667;5623.8875222496135;5639.661620302795;5647.124695672177;1013.9847902281472;1016.2733645443395;1017.3234798858824;1018.3126389686931;1024.472396715692;28098;28337;28418.43163136767;28606.14181574556;28667.56998645022;1091.5579190427889;1094.4965315954591;1099.7360633448075;1108.939008354532;1132.0717012050204;13999;15018;15067.397304107713;15094.54716358511;15149.318280677397;306102;307078;309010;309735;310381;54278.72860635751;54367.18449223265;54480.727596361765;54920.72539637276;54937.725311373986;1528.5414375687249;1538.9461368851812;1576.282791329942;1581.3279356273538;1585.5560443075958;26111.608325875506;27361.726382735917;27371.726282737713;27403.725962740915;27607.171784846487;41746;41754;41788.58211417847;41850.79074604608;41864.372034420114;293005.27978880604;293525;294053;294119;294318;28863.855680722303;34702.13244668904;34710.65289347175;34908;34985.65014349824;44027;44573.77713111414;44853.32720009268;45901.31148032715;46168;37854;38060.42909356306;38256.42615360828;38596.80701596474;39262.60737392589;36995.630043700294;37045.259094818495;37322.06694832651;37603.81198093992;38644.6135538641;38202.617973819906;38324.23351532898;38709.419358710205;39065.609343906195;39150.6084939147;32547.837260813543;34127;34180.31639367248;34438.48342274818;34734.47898281477;26318.21045368642;26545.33636659099;26600.8669956649;26604.201873943814;26792.19623411301 09:03:52 INFO - PROCESS | 4313 | |2;jquery.html;452.53162976319516;463.16167736397125;481.7976449891045;483.58411765881334;495.24475175357577;19978.60042799145;21601.783982160174;21706;21787.782122178774;21882.343529694095;22175.334739957787;22208.666869996963;22453;22580.88709556454;22738.31785046451;6679.432248258904;6920;7044.119485064367;7289.416846652255;7338.156112047102;7206.603636799974;7341.229170937055;7357.117145942468;7363.410927125844;7471.850562988737;7573.6213189340315;7610.771676849703;7624.466287359887;7632.198619144993;7649.847003059936;7374.115106187238;7467.327940485356;7522.849543009109;7522.887156692654;7524.172341042481;7095.077639906779;7304.5252058616015;7345.77962661121;7399.149097853762;7402.666879990359;25182.370440738945;25357;25453.236402907944;25480.490390192277;25732;3023.56158357037;3162.604674415698;3178.6821317868257;3234.83825808711;3236.01301603011;15138.621534461616;15718.528444146694;15795.131267780267;16134.273957671932;16744.66510669792;2108.8734675919495;2168.4036889855256;2215.9889200554057;2251.887405629712;2260.6382978723327;115737;119069;119703.40148299203;120055.3997230017;120881.39559302235;16024.519264422086;16186.352545898033;17250.827491724922;17606;17987.772873374746;29611;29773.553396699066;29899.551506727417;29954.55068173979;30082.398352032837;10199.694009179737;10303.845442318372;10408.791824163625;10478.685639430829;10587.947060264649;8953.59708813105;8996.50519221436;9022.771851639494;9158.725238242863;9193.356465047382;8755.824883502422;8943.418677785923;8969.910300897038;8990.55047247635;9126.771830704285;3318.6271815651444;3764.924701506009;3864.30442520349;3894.3963685628773;3939.940900886489;958.4680502321139;962.2302158273353;971.3589031239349;979.8775153105862;984.3011461862015;19600.52996025304;20582.38252852417;20892.37322880316;20935.581288374146;21038.89480552618;1064.6114168328659;1092.4100985467917;1096.446294621211;1097.5609756097465;1116.1126904111252;10568.365898046142;10652.89347106519;11375.54497820078;11439.142064345207;11456.54173833054;722630;725893;728087.7191228126;762042;808856;120495;120542;121984;124480.37759811143;124762;1366.4397596985189;1367.4803574641771;1405.6977749783846;1406.6342750884844;1407.8944079194102;17383.91308043452;17801.55496112556;18018.36935707244;18163.36428225006;18186.636267274844;54711.45288547223;54907.69676214838;54974.45025549853;55132;56307;65271;72349;72435;72525.87960672045;77512.61243693746;11775.411229438323;12451.937740311241;12621.368931553201;12667.429965651752;12878.291693956922;14234;14235.145891246559;14282.642933926734;14425.927870360581;14474.059186152866;12890.871091288967;12975.545855894998;12995.415206315549;13065.542706005624;13210.207387556777;11839.704007399883;11923.463444144862;12035;12229.510819567118;12355.196912200678;12785.232886026868;12946.870531294566;12998.155119917175;13019.674508137372;13055.608331749683;12231.449584768885;12256.203346782431;12309;12345.382730863601;12671.17637353569;12714.87285127137;12730.23618582888;12761.361931903553;12890.871091288967;13181.538646147339 09:03:52 INFO - PROCESS | 4313 | |3;mootools.html;1418.234153557078;1530.7550791873296;1540.5994441445225;1543.6449616588184;1569.45069225771;9447.669331573396;11560.075193984481;11880.881191188086;11923.76152476951;11935.104867134978;11638.185327027111;11706.122040846927;11735.7652846943;11739.882601174008;11741.119416043788;2035.898205089747;2497.1634502441702;2533.0627667762956;2537.53055684698;2539.6825396825398;2007.3977806657945;2398.8560686358787;2463.3964678653665;2463.519613675325;2471.3450935502105;2430.1858877276136;2473.4063824682125;2478.7521247875247;2485.5526005319034;2495.7629025242572;2403.3510952043025;2421.4914867877765;2424.248482970267;2426.187227278855;2428.987855060713;2303.1363238785457;2380.690510233676;2396.472775989297;2406.2540612410207;2408.3497455686866;11377.772444551145;11476.311421314747;11487.195896287263;11489.482973266224;11506.769864602746;5681.176229446748;5826.388229235954;5835.854103647443;5837.474627283523;5839.649621022752;3333.383324085052;3379.4761811919193;3564.9108772280642;3592.263585964871;3631.58368236388;1354.9322533873365;1414.2575148047254;1421.1118051217989;1433.655922578584;1458.0814087125043;17314;17330.480085597454;17387.65224695499;17389.65220695604;17394.65210695779;4925.310456536088;5054.848354549369;5066.544011038951;5137.023965446553;5137.17805151174;13072.411741471657;13146.4084116215;13168.539101131415;13174.47302107924;13178.736425271632;5913.793017244376;5926.8814623707285;5938.465538101592;5939.792107276225;5940;4652.464966528893;4771.355866957916;5460.34475862899;5531.917021244684;5571.9721401392735;4120.428210969809;4127.318992366286;4176.517336345614;4189.685773566995;4212.115455754265;996.8654231678776;1005.6832097889142;1005.9295849290626;1011.0849681038671;1015.21320976244;1055.3351388625117;1080.6541906589973;1085.3216739537788;1086.820674588684;1089.1613457637575;7048.894266586005;7169.283071692789;7302.233265507151;7310.963445182846;7406.222346653632;1103.5530610102921;1108.2408550143177;1109.8612673415823;1117;1127.0926903842485;4424.269995450779;4542.454905411306;4580.267157254823;4591;4699.483056863743;15004.474843380429;15249.466268680764;15319.387224511118;15397.076175429285;15538.766918496232;15216.239188040554;15235.466758663615;15356.308966096552;15357.539273821803;15474.922625386802;10177.389356638478;11098.2786118902;11109;11187;11191.384473854016;6634.436072933661;6906.343897329745;6918.481113916376;6956.2695916928;7015.789526314219;12790.296533690736;12861.228326300452;12897;12913.677158071123;12973;13058.673533161747;13061.08572399961;13157.53948611794;13306.534271300457;13358.131721438076;8811.515366654896;9062.093790620886;9940.254480913816;10215.387076775418;10219.029192226726;10903.781924361627;11174.441277935908;11211.943940280247;11285.266457680225;11420.657380278604;9884;9928.453935033354;9932.304738668225;10006.749831253986;10120.089191972758;9727.124558789743;9728.854067189139;9741.415515069119;9928.801423971336;10039.548220330249;8681.826363472821;8852.336074794288;8852.424592401474;8856.291496680122;8867.157620026088;6441.903371449338;6490.578112422678;6498.870022599616;6512.446442052478;6594.736210551524;6428.963247394442;6565.540412171294;6592.538522303585;6657.53397262187;6701.32986701326 09:03:52 INFO - PROCESS | 4313 | |4;prototype.html;419.90195638405567;426.71836587852016;427.3440269186799;432.10769760444657;439.5845925600309;5183.818566350169;5234.84295471136;5262.9473705262935;5288.254875890952;5295.655782374143;5166.509181627749;5198.45416231296;5228.92156617651;5249.790008399659;5250.842474725755;4211.978940105295;4235.809388577506;4356.629686476637;4361.302191649337;4390.473143222818;4303.978480107595;4332.155229730204;4351.738895666254;4366.607005369516;4373.343998400233;4353.238183317907;4368.235558777201;4381.978090109545;4410.404595379615;4430.6012458878695;4176.812043458051;4309.159713855799;4390.253656878338;4407.735535867842;4409.338599210112;4041.797910104483;4074.796260186979;4083.2445997490263;4091.9181616367805;4117.8970525736795;5138.84583462493;5142.331496905378;5153.433122356538;5164.612654050961;5186.18483530765;4971.9159558976435;5033.697978121288;5093.567046801027;5153.788859617986;5171.0692075426405;5456.836294911159;5461.262729531502;5496.230527726121;5499.50504454601;5505.917411238835;4555.339475775994;4560.179167749804;4562.676823721117;4588.082383523275;4588.220002599566;5452.263944367539;5704.3154821421695;5720.48515633595;5746.310442746855;5802.187693722924;4717.292406139038;4717.693349932243;4728.219843725747;4761.571458568746;4779.972305954237;4765.285207218875;4766.666333356701;4851.369321988119;4863.975680121577;4871.732054737024;4999.975000124976;5035.345405097314;5114.028334616411;5150.532098352027;5167.501424586828;5508.256385388001;5525.502704756511;5539.944600553943;5552;5555.611107222456;1648.5301689018572;1649.7937757780278;1659.7593348964333;1665.4171040135855;1672.2057022914018;1251.174225011488;1279.4498365702837;1279.9488020479262;1283.8138469921996;1300.5058077930325;5464;5469.960707465569;5475.890482190413;5508.421615730371;5519.613627046148;5628.915566266509;5662.669272720907;5680.744366503517;5708.429157084258;5753.88492230153;5202.03762303975;5452.509274165344;5460.726963651801;5481.75332110048;5519.365272993577;2961.748251398612;2991.7584202555695;3011.9548206776917;3015.231116065433;3028.3489049853947;5738.483536481736;5896.292444906639;5918.289805223315;5931.199288096138;5935.7625694972585;5566.805161819317;5828.861508329134;5836.7957121501395;5841.561882858802;5856.707164641836;5659.377468478464;5716.771329146871;5732.824770921951;5759.596828222068;5894.322152952293;5629.521490673339;5637.449701332166;5686.43135686428;5723.255976723;5745.368009518866;5423.3696657122055;5539.01488660209;5568.830545585311;5579.414161512983;5604.439556044363;5802.796902108406;5850.356460789225;5878.559108066826;5883.735231914488;5899;4687.601553867959;4714.5521175488275;4724.598409135125;4739.644526660583;4748.453927798348;5365.3293338332705;5653.766762129018;5674.829755107354;5680;5686.9715651421475;5504.697241651747;5551.583631227593;5554.361248456317;5573.191887176417;5601.563319955832;5304.324372920937;5417.593680473901;5554.555635549227;5558.916616250679;5585.9720701397855;5494.664767473728;5506.449355064461;5561.221428999862;5565.777368905198;5571.582131340247;5521.5306698931045;5561.663002198648;5584.631765217548;5658.660480371191;5680.034394152921;5213.869653258547;5280.894382112413;5375.650582712111;5413.56691464674;5470.53500452466 09:03:52 INFO - PROCESS | 4313 | |5;yui.html;852.9104444033372;900.3922352412122;902.5126431726868;932.4871320773573;935.8362286599844;15418.61453463664;16166.595835104128;16614.66770664589;17004.914975425138;17025.48923532296;16648.33406663732;16664.083475408846;16864.409745658875;16898.493045208634;17053;863.5682158920555;884.4781578868466;884.6903583745669;887.6981826179098;908.5865931001412;893.066745251214;897.7979954510248;900.9684661036865;902.0122965352928;903.7333986474006;967.5936106835111;968.7287559483356;968.8352979993418;970.4904924914441;970.9563069661847;966.1690945786618;966.9274804389629;967.5742673223759;967.632299726103;967.7145242153582;712.2272334517055;713.9821504462378;714.0788382985994;714.1679942866555;714.3035540348171;17158.742618860728;17357.739633905374;17393.65212695739;17596;18023.459296221004;15302.693946121015;15508.689826203412;15647.217639117998;15751.606209844731;15975.360985560563;13612.251326177056;14092.436302547989;14128.71742565143;14160.867130629627;14169.008169428143;4018.45750823638;4031.6976226782817;4052.230076285496;4056.188762247533;4134.441850350225;84752;85179;85717.57141214254;86614;89350.6597401046;12769.233845969271;12802.615921522369;12820.679483013;12821.976560056728;12910.22538647684;24128.75871241265;24162.75837241605;24336.756632433448;24398.87800560986;24706.752932470805;8618.353623478264;8658.956705216433;8775.736727898173;8791.868121978176;8794.03265640779;5031.974840125776;5110.233464980282;5155.484451554815;5249.580033597379;5276.366835979707;3787.659110680052;3887.2031233597045;3889.8055097245024;3891.4357418174773;3896.4155376693725;617.0805499805258;620.3176505843536;624.4536030972898;627.250435729299;631.5547538985005;715.7745310227261;732.9157146928064;744.0810598910341;749.9689170707447;751.4627041665235;10948.919705255976;11295.435228238719;11362.318260904372;11756.647300580997;11876.703082423008;737.3363972424861;751.6279441676296;756.7275780718937;763.9197884222187;777.9727709530139;5246.081935661244;5330.147176451749;5353.4646535346155;5390.946090539122;5444.156155795858;79862;80909;81788;82390.17609823825;84900;57914;66974;72657;73085.63457182786;76470;67084.32915670879;67641.97684551227;67657.3234267651;68154.31845681579;68568;10248.743781405525;10526.263161578921;10548.367097974146;10585.52365143555;10658.413787241776;43710.34434483549;43876.56123438852;44409.77795111004;44497.33254001128;44605.55394446014;50989.745051274505;51092.48907510877;51239.48760512496;52369.21446178234;54209;12278.324692142018;12349.75300494003;12500.124991250525;12625.116241862981;13151.079424440197;14008.789868151782;14297.64255893611;14444.711105777615;14651.926740366656;14920.552383428514;13246.20522768637;13625.182489050689;13859.168449893039;13991.370388332753;14226.288685565472;13816.861831381959;14503.709925801213;14538.636534086732;14565.708685826436;14570.635734106732;14915.207047932538;15993.600159996093;16308.755368669243;16393.754093688367;16539.338426462808;12419.93790031044;12633;13154.408051637507;13176.934115329363;13381.933090334485;12706.936465317984;13734.725305494034;13759.587212383645;13813.309334533033;14309.427622894967 09:03:52 INFO - PROCESS | 4313 | __end_tp_report 09:03:52 INFO - PROCESS | 4313 | __start_cc_report 09:03:52 INFO - PROCESS | 4313 | _x_x_mozilla_cycle_collect,1369 09:03:52 INFO - PROCESS | 4313 | __end_cc_report 09:03:52 INFO - PROCESS | 4313 | __startTimestamp1489165432023__endTimestamp 09:03:52 INFO - PROCESS | 4313 | 09:03:52 INFO - PROCESS | 4313 | ------- Summary: start ------- 09:03:52 INFO - PROCESS | 4313 | Number of tests: 6 09:03:52 INFO - PROCESS | 4313 | 09:03:52 INFO - PROCESS | 4313 | [#0] dojo.html Cycles:165 Average:5747.23 Median:5962.31 stddev:657.35 (11.0%) stddev-sans-first:631.60 09:03:52 INFO - PROCESS | 4313 | Values: 3337.5 3435.1 3442.5 3456.6 3470.0 5737.1 5794.1 5803.5 5813.0 5814.3 5805.7 5841.0 5848.5 5856.0 5871.0 5200.1 5208.2 5210.7 5270.3 5289.9 5105.1 5292.4 5294.7 5302.0 5304.2 5140.4 5167.3 5179.0 5259.0 5276.3 5256.2 5282.8 5285.0 5286.1 5286.6 5089.8 5123.8 5249.9 5252.8 5260.7 5538.9 5577.6 5584.2 5641.6 5697.1 6155.9 6188.1 6188.1 6194.9 6198.9 6165.2 6193.8 6202.2 6203.0 6203.0 5538.4 5594.4 5784.4 5784.4 5828.2 6201.3 6209.7 6212.0 6217.4 6278.1 6111.4 6144.9 6153.6 6157.4 6164.6 6236.9 6247.8 6248.9 6251.2 6258.4 5899.1 5942.5 6205.1 6206.6 6207.1 6019.0 6025.9 6033.9 6044.0 6111.5 4706.2 4720.4 4735.6 4738.8 4741.5 4188.8 4190.1 4218.9 4219.0 4239.8 5932.4 5945.6 5962.3 5977.3 5991.1 6126.5 6135.1 6142.9 6243.3 6265.8 5909.6 6016.9 6023.8 6037.9 6076.0 5242.8 5246.1 5258.7 5293.1 5299.5 6212.7 6284.8 6430.1 6508.7 6563.7 6287.7 6294.7 6307.2 6308.2 6309.4 6585.0 6591.6 6597.4 6599.9 6604.5 5983.7 6034.0 6130.7 6151.7 6183.6 6142.8 6150.8 6308.7 6310.9 6320.6 5898.7 6108.7 6113.3 6114.1 6116.3 5910.5 5995.0 6012.4 6112.2 6141.8 6063.9 6064.8 6081.7 6097.5 6100.8 5867.4 5902.2 5902.7 5904.3 5961.0 5861.2 5865.6 5868.6 5869.7 5878.8 09:03:52 INFO - PROCESS | 4313 | 09:03:52 INFO - PROCESS | 4313 | [#1] ext.html Cycles:180 Average:45051.70 Median:170733.42 stddev:72580.70 (42.5%) stddev-sans-first:72708.12 09:03:52 INFO - PROCESS | 4313 | Values: 760.7 818.1 836.5 912.6 927.5 30780.8 42838.8 42920.8 42982.1 43009.1 38555.4 38757.4 39072.2 42241.8 42410.6 7432.3 7582.8 8900.1 9042.7 9045.9 10361.9 10555.2 10868.5 10883.9 10890.5 10681.0 10694.8 10710.1 10711.0 10714.2 10564.3 10611.2 10618.0 10619.2 10631.6 10218.6 10224.4 10236.1 10238.3 10273.2 42294.6 42761.6 42772.8 42788.0 42798.1 4057.6 4075.0 4106.9 4135.9 4194.7 29191.7 29592.9 29790.3 29914.9 31085.8 4358.9 4374.9 4412.3 4416.9 4466.6 226003.0 226271.0 226585.0 226971.0 227000.0 53107.5 53270.2 53485.2 53670.5 53775.5 53613.5 53644.7 53738.7 53843.2 53909.5 15750.7 16031.2 16069.4 16076.3 16082.4 12045.9 12334.0 14166.4 14215.6 14236.1 12584.3 12846.6 13061.5 13133.5 13175.7 5618.1 5623.1 5623.9 5639.7 5647.1 1014.0 1016.3 1017.3 1018.3 1024.5 28098.0 28337.0 28418.4 28606.1 28667.6 1091.6 1094.5 1099.7 1108.9 1132.1 13999.0 15018.0 15067.4 15094.5 15149.3 306102.0 307078.0 309010.0 309735.0 310381.0 54278.7 54367.2 54480.7 54920.7 54937.7 1528.5 1538.9 1576.3 1581.3 1585.6 26111.6 27361.7 27371.7 27403.7 27607.2 41746.0 41754.0 41788.6 41850.8 41864.4 293005.3 293525.0 294053.0 294119.0 294318.0 28863.9 34702.1 34710.7 34908.0 34985.7 44027.0 44573.8 44853.3 45901.3 46168.0 37854.0 38060.4 38256.4 38596.8 39262.6 36995.6 37045.3 37322.1 37603.8 38644.6 38202.6 38324.2 38709.4 39065.6 39150.6 32547.8 34127.0 34180.3 34438.5 34734.5 26318.2 26545.3 26600.9 26604.2 26792.2 09:03:52 INFO - PROCESS | 4313 | 09:03:52 INFO - PROCESS | 4313 | [#2] jquery.html Cycles:180 Average:40786.44 Median:21835.06 stddev:123500.39 (565.6%) stddev-sans-first:123809.70 09:03:52 INFO - PROCESS | 4313 | Values: 452.5 463.2 481.8 483.6 495.2 19978.6 21601.8 21706.0 21787.8 21882.3 22175.3 22208.7 22453.0 22580.9 22738.3 6679.4 6920.0 7044.1 7289.4 7338.2 7206.6 7341.2 7357.1 7363.4 7471.9 7573.6 7610.8 7624.5 7632.2 7649.8 7374.1 7467.3 7522.8 7522.9 7524.2 7095.1 7304.5 7345.8 7399.1 7402.7 25182.4 25357.0 25453.2 25480.5 25732.0 3023.6 3162.6 3178.7 3234.8 3236.0 15138.6 15718.5 15795.1 16134.3 16744.7 2108.9 2168.4 2216.0 2251.9 2260.6 115737.0 119069.0 119703.4 120055.4 120881.4 16024.5 16186.4 17250.8 17606.0 17987.8 29611.0 29773.6 29899.6 29954.6 30082.4 10199.7 10303.8 10408.8 10478.7 10587.9 8953.6 8996.5 9022.8 9158.7 9193.4 8755.8 8943.4 8969.9 8990.6 9126.8 3318.6 3764.9 3864.3 3894.4 3939.9 958.5 962.2 971.4 979.9 984.3 19600.5 20582.4 20892.4 20935.6 21038.9 1064.6 1092.4 1096.4 1097.6 1116.1 10568.4 10652.9 11375.5 11439.1 11456.5 722630.0 725893.0 728087.7 762042.0 808856.0 120495.0 120542.0 121984.0 124480.4 124762.0 1366.4 1367.5 1405.7 1406.6 1407.9 17383.9 17801.6 18018.4 18163.4 18186.6 54711.5 54907.7 54974.5 55132.0 56307.0 65271.0 72349.0 72435.0 72525.9 77512.6 11775.4 12451.9 12621.4 12667.4 12878.3 14234.0 14235.1 14282.6 14425.9 14474.1 12890.9 12975.5 12995.4 13065.5 13210.2 11839.7 11923.5 12035.0 12229.5 12355.2 12785.2 12946.9 12998.2 13019.7 13055.6 12231.4 12256.2 12309.0 12345.4 12671.2 12714.9 12730.2 12761.4 12890.9 13181.5 09:03:52 INFO - PROCESS | 4313 | 09:03:52 INFO - PROCESS | 4313 | [#3] mootools.html Cycles:180 Average:7273.25 Median:2407.30 stddev:4684.08 (194.6%) stddev-sans-first:4676.56 09:03:52 INFO - PROCESS | 4313 | Values: 1418.2 1530.8 1540.6 1543.6 1569.5 9447.7 11560.1 11880.9 11923.8 11935.1 11638.2 11706.1 11735.8 11739.9 11741.1 2035.9 2497.2 2533.1 2537.5 2539.7 2007.4 2398.9 2463.4 2463.5 2471.3 2430.2 2473.4 2478.8 2485.6 2495.8 2403.4 2421.5 2424.2 2426.2 2429.0 2303.1 2380.7 2396.5 2406.3 2408.3 11377.8 11476.3 11487.2 11489.5 11506.8 5681.2 5826.4 5835.9 5837.5 5839.6 3333.4 3379.5 3564.9 3592.3 3631.6 1354.9 1414.3 1421.1 1433.7 1458.1 17314.0 17330.5 17387.7 17389.7 17394.7 4925.3 5054.8 5066.5 5137.0 5137.2 13072.4 13146.4 13168.5 13174.5 13178.7 5913.8 5926.9 5938.5 5939.8 5940.0 4652.5 4771.4 5460.3 5531.9 5572.0 4120.4 4127.3 4176.5 4189.7 4212.1 996.9 1005.7 1005.9 1011.1 1015.2 1055.3 1080.7 1085.3 1086.8 1089.2 7048.9 7169.3 7302.2 7311.0 7406.2 1103.6 1108.2 1109.9 1117.0 1127.1 4424.3 4542.5 4580.3 4591.0 4699.5 15004.5 15249.5 15319.4 15397.1 15538.8 15216.2 15235.5 15356.3 15357.5 15474.9 10177.4 11098.3 11109.0 11187.0 11191.4 6634.4 6906.3 6918.5 6956.3 7015.8 12790.3 12861.2 12897.0 12913.7 12973.0 13058.7 13061.1 13157.5 13306.5 13358.1 8811.5 9062.1 9940.3 10215.4 10219.0 10903.8 11174.4 11211.9 11285.3 11420.7 9884.0 9928.5 9932.3 10006.7 10120.1 9727.1 9728.9 9741.4 9928.8 10039.5 8681.8 8852.3 8852.4 8856.3 8867.2 6441.9 6490.6 6498.9 6512.4 6594.7 6429.0 6565.5 6592.5 6657.5 6701.3 09:03:52 INFO - PROCESS | 4313 | 09:03:52 INFO - PROCESS | 4313 | [#4] prototype.html Cycles:180 Average:4818.42 Median:5284.57 stddev:1283.31 (24.3%) stddev-sans-first:1243.72 09:03:52 INFO - PROCESS | 4313 | Values: 419.9 426.7 427.3 432.1 439.6 5183.8 5234.8 5262.9 5288.3 5295.7 5166.5 5198.5 5228.9 5249.8 5250.8 4212.0 4235.8 4356.6 4361.3 4390.5 4304.0 4332.2 4351.7 4366.6 4373.3 4353.2 4368.2 4382.0 4410.4 4430.6 4176.8 4309.2 4390.3 4407.7 4409.3 4041.8 4074.8 4083.2 4091.9 4117.9 5138.8 5142.3 5153.4 5164.6 5186.2 4971.9 5033.7 5093.6 5153.8 5171.1 5456.8 5461.3 5496.2 5499.5 5505.9 4555.3 4560.2 4562.7 4588.1 4588.2 5452.3 5704.3 5720.5 5746.3 5802.2 4717.3 4717.7 4728.2 4761.6 4780.0 4765.3 4766.7 4851.4 4864.0 4871.7 5000.0 5035.3 5114.0 5150.5 5167.5 5508.3 5525.5 5539.9 5552.0 5555.6 1648.5 1649.8 1659.8 1665.4 1672.2 1251.2 1279.4 1279.9 1283.8 1300.5 5464.0 5470.0 5475.9 5508.4 5519.6 5628.9 5662.7 5680.7 5708.4 5753.9 5202.0 5452.5 5460.7 5481.8 5519.4 2961.7 2991.8 3012.0 3015.2 3028.3 5738.5 5896.3 5918.3 5931.2 5935.8 5566.8 5828.9 5836.8 5841.6 5856.7 5659.4 5716.8 5732.8 5759.6 5894.3 5629.5 5637.4 5686.4 5723.3 5745.4 5423.4 5539.0 5568.8 5579.4 5604.4 5802.8 5850.4 5878.6 5883.7 5899.0 4687.6 4714.6 4724.6 4739.6 4748.5 5365.3 5653.8 5674.8 5680.0 5687.0 5504.7 5551.6 5554.4 5573.2 5601.6 5304.3 5417.6 5554.6 5558.9 5586.0 5494.7 5506.4 5561.2 5565.8 5571.6 5521.5 5561.7 5584.6 5658.7 5680.0 5213.9 5280.9 5375.7 5413.6 5470.5 09:03:52 INFO - PROCESS | 4313 | 09:03:52 INFO - PROCESS | 4313 | [#5] yui.html Cycles:180 Average:18717.56 Median:43793.45 stddev:23357.86 (53.3%) stddev-sans-first:23384.86 09:03:52 INFO - PROCESS | 4313 | Values: 852.9 900.4 902.5 932.5 935.8 15418.6 16166.6 16614.7 17004.9 17025.5 16648.3 16664.1 16864.4 16898.5 17053.0 863.6 884.5 884.7 887.7 908.6 893.1 897.8 901.0 902.0 903.7 967.6 968.7 968.8 970.5 971.0 966.2 966.9 967.6 967.6 967.7 712.2 714.0 714.1 714.2 714.3 17158.7 17357.7 17393.7 17596.0 18023.5 15302.7 15508.7 15647.2 15751.6 15975.4 13612.3 14092.4 14128.7 14160.9 14169.0 4018.5 4031.7 4052.2 4056.2 4134.4 84752.0 85179.0 85717.6 86614.0 89350.7 12769.2 12802.6 12820.7 12822.0 12910.2 24128.8 24162.8 24336.8 24398.9 24706.8 8618.4 8659.0 8775.7 8791.9 8794.0 5032.0 5110.2 5155.5 5249.6 5276.4 3787.7 3887.2 3889.8 3891.4 3896.4 617.1 620.3 624.5 627.3 631.6 715.8 732.9 744.1 750.0 751.5 10948.9 11295.4 11362.3 11756.6 11876.7 737.3 751.6 756.7 763.9 778.0 5246.1 5330.1 5353.5 5390.9 5444.2 79862.0 80909.0 81788.0 82390.2 84900.0 57914.0 66974.0 72657.0 73085.6 76470.0 67084.3 67642.0 67657.3 68154.3 68568.0 10248.7 10526.3 10548.4 10585.5 10658.4 43710.3 43876.6 44409.8 44497.3 44605.6 50989.7 51092.5 51239.5 52369.2 54209.0 12278.3 12349.8 12500.1 12625.1 13151.1 14008.8 14297.6 14444.7 14651.9 14920.6 13246.2 13625.2 13859.2 13991.4 14226.3 13816.9 14503.7 14538.6 14565.7 14570.6 14915.2 15993.6 16308.8 16393.8 16539.3 12419.9 12633.0 13154.4 13176.9 13381.9 12706.9 13734.7 13759.6 13813.3 14309.4 09:03:52 INFO - PROCESS | 4313 | -------- Summary: end -------- 09:03:52 INFO - PROCESS | 4313 | 09:03:52 INFO - TEST-INFO | 4313: exit 0 09:03:52 INFO - TEST-OK | dromaeo_css | took 1116018ms 09:03:52 INFO - TEST-START | kraken 09:03:52 INFO - operating with platform_type : linux_ 09:03:52 INFO - Initialising browser for kraken test... 09:03:52 INFO - TEST-INFO | started process 4641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsTzAyA/profile http://localhost:55359/getInfo.html) 09:03:57 INFO - PROCESS | 4641 | __metrics Screen width/height:1600/1200 09:03:57 INFO - PROCESS | 4641 | colorDepth:24 09:03:57 INFO - PROCESS | 4641 | Browser inner width/height: 1024/697 09:03:57 INFO - PROCESS | 4641 | __metrics 09:03:58 INFO - PROCESS | 4641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:03:58 INFO - PROCESS | 4641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:03:58 INFO - PROCESS | 4641 | console.error: PushService: 09:03:58 INFO - PROCESS | 4641 | stateChangeProcessEnqueue: Error transitioning state 09:03:58 INFO - PROCESS | 4641 | UnknownError 09:03:59 INFO - TEST-INFO | 4641: exit 0 09:03:59 INFO - Browser initialized. 09:03:59 INFO - Running cycle 1/1 for kraken test... 09:03:59 INFO - TEST-INFO | started process 4734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsTzAyA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:10 INFO - PROCESS | 4734 | RSS: Main: 139255808 09:04:10 INFO - PROCESS | 4734 | 09:04:13 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55359/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:14 INFO - PROCESS | 4734 | RSS: Main: 182476800 09:04:14 INFO - PROCESS | 4734 | 09:04:16 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55359/tests/kraken/driver.html?testName=audio-dft) 09:04:17 INFO - PROCESS | 4734 | RSS: Main: 173268992 09:04:17 INFO - PROCESS | 4734 | 09:04:20 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55359/tests/kraken/driver.html?testName=audio-fft) 09:04:20 INFO - PROCESS | 4734 | RSS: Main: 265142272 09:04:20 INFO - PROCESS | 4734 | 09:04:22 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55359/tests/kraken/driver.html?testName=audio-oscillator) 09:04:23 INFO - PROCESS | 4734 | RSS: Main: 172228608 09:04:23 INFO - PROCESS | 4734 | 09:04:25 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:04:26 INFO - PROCESS | 4734 | RSS: Main: 174161920 09:04:26 INFO - PROCESS | 4734 | 09:04:29 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55359/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:29 INFO - PROCESS | 4734 | RSS: Main: 212500480 09:04:29 INFO - PROCESS | 4734 | 09:04:33 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55359/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:33 INFO - PROCESS | 4734 | RSS: Main: 205692928 09:04:33 INFO - PROCESS | 4734 | 09:04:36 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55359/tests/kraken/driver.html?testName=json-parse-financial) 09:04:37 INFO - PROCESS | 4734 | RSS: Main: 207609856 09:04:37 INFO - PROCESS | 4734 | 09:04:38 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:39 INFO - PROCESS | 4734 | RSS: Main: 170876928 09:04:39 INFO - PROCESS | 4734 | 09:04:41 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:41 INFO - PROCESS | 4734 | RSS: Main: 178679808 09:04:41 INFO - PROCESS | 4734 | 09:04:43 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:44 INFO - PROCESS | 4734 | RSS: Main: 183533568 09:04:44 INFO - PROCESS | 4734 | 09:04:47 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:47 INFO - PROCESS | 4734 | RSS: Main: 179601408 09:04:47 INFO - PROCESS | 4734 | 09:04:50 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:50 INFO - PROCESS | 4734 | RSS: Main: 183255040 09:04:50 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55359/tests/kraken/driver.html?testName=ai-astar) 09:04:52 INFO - PROCESS | 4734 | RSS: Main: 236793856 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | __start_tp_report 09:04:52 INFO - PROCESS | 4734 | _x_x_mozilla_page_load 09:04:52 INFO - PROCESS | 4734 | _x_x_mozilla_page_load_details 09:04:52 INFO - PROCESS | 4734 | |i|pagename|runs| 09:04:52 INFO - PROCESS | 4734 | |0;ai-astar;103;113;113;113;113;115;115;113;114;111 09:04:52 INFO - PROCESS | 4734 | |1;audio-beat-detection;146;117;117;156;117;116;116;122;147;121 09:04:52 INFO - PROCESS | 4734 | |2;audio-dft;162;160;160;162;161;162;161;160;161;161 09:04:52 INFO - PROCESS | 4734 | |3;audio-fft;76;74;77;116;76;76;76;75;101;74 09:04:52 INFO - PROCESS | 4734 | |4;audio-oscillator;82;81;105;82;82;82;94;80;82;98 09:04:52 INFO - PROCESS | 4734 | |5;imaging-gaussian-blur;113;113;113;115;114;114;114;113;113;113 09:04:52 INFO - PROCESS | 4734 | |6;imaging-darkroom;147;147;147;146;147;148;148;147;147;147 09:04:52 INFO - PROCESS | 4734 | |7;imaging-desaturate;93;93;94;94;94;94;95;94;94;94 09:04:52 INFO - PROCESS | 4734 | |8;json-parse-financial;56;55;56;56;55;57;58;54;55;54 09:04:52 INFO - PROCESS | 4734 | |9;json-stringify-tinderbox;53;52;53;53;53;52;53;54;53;54 09:04:52 INFO - PROCESS | 4734 | |10;stanford-crypto-aes;84;84;84;76;75;81;84;80;80;95 09:04:52 INFO - PROCESS | 4734 | |11;stanford-crypto-ccm;125;120;130;128;121;124;118;121;130;124 09:04:52 INFO - PROCESS | 4734 | |12;stanford-crypto-pbkdf2;161;162;162;157;162;159;155;159;160;160 09:04:52 INFO - PROCESS | 4734 | |13;stanford-crypto-sha256-iterative;60;60;60;60;59;60;59;60;59;58 09:04:52 INFO - PROCESS | 4734 | __end_tp_report 09:04:52 INFO - PROCESS | 4734 | __start_cc_report 09:04:52 INFO - PROCESS | 4734 | _x_x_mozilla_cycle_collect,1636 09:04:52 INFO - PROCESS | 4734 | __end_cc_report 09:04:52 INFO - PROCESS | 4734 | __startTimestamp1489165492802__endTimestamp 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | ------- Summary: start ------- 09:04:52 INFO - PROCESS | 4734 | Number of tests: 14 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.47 (3.1%) stddev-sans-first:1.22 09:04:52 INFO - PROCESS | 4734 | Values: 103.0 113.0 113.0 113.0 113.0 115.0 115.0 113.0 114.0 111.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:121.50 stddev:15.64 (12.9%) stddev-sans-first:15.09 09:04:52 INFO - PROCESS | 4734 | Values: 146.0 117.0 117.0 156.0 117.0 116.0 116.0 122.0 147.0 121.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 09:04:52 INFO - PROCESS | 4734 | Values: 162.0 160.0 160.0 162.0 161.0 162.0 161.0 160.0 161.0 161.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:14.39 (18.9%) stddev-sans-first:15.09 09:04:52 INFO - PROCESS | 4734 | Values: 76.0 74.0 77.0 116.0 76.0 76.0 76.0 75.0 101.0 74.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:82.00 stddev:8.84 (10.8%) stddev-sans-first:9.21 09:04:52 INFO - PROCESS | 4734 | Values: 82.0 81.0 105.0 82.0 82.0 82.0 94.0 80.0 82.0 98.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 09:04:52 INFO - PROCESS | 4734 | Values: 113.0 113.0 113.0 115.0 114.0 114.0 114.0 113.0 113.0 113.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:04:52 INFO - PROCESS | 4734 | Values: 147.0 147.0 147.0 146.0 147.0 148.0 148.0 147.0 147.0 147.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 09:04:52 INFO - PROCESS | 4734 | Values: 93.0 93.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.33 09:04:52 INFO - PROCESS | 4734 | Values: 56.0 55.0 56.0 56.0 55.0 57.0 58.0 54.0 55.0 54.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 09:04:52 INFO - PROCESS | 4734 | Values: 53.0 52.0 53.0 53.0 53.0 52.0 53.0 54.0 53.0 54.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:84.00 stddev:5.56 (6.6%) stddev-sans-first:5.86 09:04:52 INFO - PROCESS | 4734 | Values: 84.0 84.0 84.0 76.0 75.0 81.0 84.0 80.0 80.0 95.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.50 stddev:4.20 (3.4%) stddev-sans-first:4.44 09:04:52 INFO - PROCESS | 4734 | Values: 125.0 120.0 130.0 128.0 121.0 124.0 118.0 121.0 130.0 124.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.50 stddev:2.31 (1.4%) stddev-sans-first:2.40 09:04:52 INFO - PROCESS | 4734 | Values: 161.0 162.0 162.0 157.0 162.0 159.0 155.0 159.0 160.0 160.0 09:04:52 INFO - PROCESS | 4734 | 09:04:52 INFO - PROCESS | 4734 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:60.00 stddev:0.71 (1.2%) stddev-sans-first:0.73 09:04:52 INFO - PROCESS | 4734 | Values: 60.0 60.0 60.0 60.0 59.0 60.0 59.0 60.0 59.0 58.0 09:04:52 INFO - PROCESS | 4734 | -------- Summary: end -------- 09:04:52 INFO - PROCESS | 4734 | 09:04:53 INFO - TEST-INFO | 4734: exit 0 09:04:53 INFO - TEST-OK | kraken | took 61016ms 09:04:53 INFO - SUITE-END | took 1177s 09:04:53 INFO - Completed test suite (00:19:37) 09:04:53 INFO - javascript benchmark 09:04:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7912.025930314779, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.4660054391293, 3435.0553597760613, 3442.5180474733534, 3456.637053109425, 3470.0110468516477, 5737.110747834087, 5794.130880367947, 5803.506701930341, 5813.040848260042, 5814.331351894533, 5805.680687562182, 5840.970795146019, 5848.502877255439, 5856.033754430514, 5870.970645146779, 5200.141976573861, 5208.192730126836, 5210.687358758487, 5270.314859068316, 5289.947100528984, 5105.132127538327, 5292.417834038252, 5294.655847369928, 5302.0, 5304.20436934461, 5140.434552199255, 5167.276581278624, 5179.04187725272, 5259.027079990195, 5276.287701160351, 5256.211568264753, 5282.841514754564, 5284.973575132138, 5286.127788914824, 5286.629935904508, 5089.796408143669, 5123.769430375642, 5249.921251181236, 5252.816151434681, 5260.737423018486, 5538.944610553883, 5577.553795696334, 5584.190292407578, 5641.576881733846, 5697.116946873241, 6155.876882462326, 6188.133661287423, 6188.133661287423, 6194.938050619481, 6198.884200843846, 6165.229346331708, 6193.752249909998, 6202.224721909762, 6202.96898515509, 6203.0075187969705, 5538.382149360631, 5594.412586678422, 5784.363719990755, 5784.392638772911, 5828.1549175369755, 6201.348858369896, 6209.720562574695, 6211.9689401553605, 6217.440430361289, 6278.121063051177, 6111.387369467926, 6144.907826382608, 6153.600015998945, 6157.4458298753325, 6164.630122192682, 6236.875262494725, 6247.781327653511, 6248.875022499616, 6251.218597675291, 6258.374162583706, 5899.144624029577, 5942.524598032147, 6205.069239614094, 6206.627602343874, 6207.068939658997, 6019.0, 6025.879482410415, 6033.879322413527, 6044.0, 6111.51107911366, 4706.176419126639, 4720.362751028636, 4735.550122738335, 4738.810447582127, 4741.549552792549, 4188.8324467020975, 4190.1200747843295, 4218.8523401680795, 4219.0, 4239.788010599519, 5932.40675932412, 5945.554083443759, 5962.314333851576, 5977.312609049928, 5991.131285963511, 6126.456603435028, 6135.0797380392405, 6142.897836592492, 6243.313235544087, 6265.843353916189, 5909.5863289569315, 6016.939830601726, 6023.819285421444, 6037.879242415215, 6075.969620151871, 5242.790288388422, 5246.134387825966, 5258.684478931276, 5293.100172970604, 5299.49654782795, 6212.689365531705, 6284.842878927972, 6430.131932189188, 6508.707108180238, 6563.737450502022, 6287.654179020198, 6294.653794041372, 6307.211598550181, 6308.211473565804, 6309.432151106423, 6585.0, 6591.604503729792, 6597.439217666552, 6599.934000660124, 6604.504662150454, 5983.700814959322, 6034.0, 6130.693465326805, 6151.72317245716, 6183.628982261079, 6142.775043102407, 6150.846228844314, 6308.71610777507, 6310.936890631218, 6320.5891617044745, 5898.734556944862, 6108.725107370268, 6113.29697084841, 6114.144019837137, 6116.26604807426, 5910.497607703393, 5994.970025149846, 6012.398760124128, 6112.235970503687, 6141.785037523665, 6063.909041364472, 6064.757409703562, 6081.726322315418, 6097.512199023979, 6100.816975490742, 5867.383924687846, 5902.203202567598, 5902.7343769531335, 5904.3210030845285, 5961.016432288624, 5861.1501332307425, 5865.560082993878, 5868.647881127146, 5869.706514674334, 5878.764849405976], "value": 5703.340499365384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.7109298466581, 818.087832067245, 836.5022811427199, 912.6075787411411, 927.5408672707011, 30780.846095769517, 42838.78580607096, 42920.78539607306, 42982.14035719284, 43009.13981720368, 38555.42166867492, 38757.41863872037, 39072.21855562887, 42241.788791056, 42410.57589424105, 7432.293932076444, 7582.848343033136, 8900.065493123242, 9042.728718138467, 9045.909540904606, 10361.89638103617, 10555.208359373039, 10868.510917008714, 10883.891161088366, 10890.455477226147, 10681.038706516412, 10694.78610427791, 10710.089642380408, 10711.0, 10714.196435267348, 10564.313319634199, 10611.204159688054, 10618.0, 10619.203559733012, 10631.627893023708, 10218.591256349737, 10224.437655928921, 10236.078752912274, 10238.334508257014, 10273.178145748323, 42294.57705422968, 42761.57238427607, 42772.786136069124, 42788.0, 42798.1440371194, 4057.6145266199665, 4075.042365044212, 4106.856260030914, 4135.9172816543805, 4194.727342722713, 29191.708082919326, 29592.8520357399, 29790.25524361908, 29914.850425747733, 31085.844570777226, 4358.8910277243, 4374.868753937387, 4412.271975124133, 4416.933745993781, 4466.553344665507, 226002.99999999834, 226271.0, 226585.0, 226971.0, 227000.0, 53107.46892531103, 53270.200946985824, 53485.1977220342, 53670.46329536655, 53775.46224537704, 53613.46386536163, 53644.73177634165, 53738.731306343216, 53843.19235211475, 53909.46090539044, 15750.68498630021, 16031.19844007795, 16069.357225711074, 16076.276567554489, 16082.356705731874, 12045.879541204476, 12334.0, 14166.433342666178, 14215.64460888486, 14236.07465514759, 12584.307863067435, 12846.614601561969, 13061.477540898448, 13133.474661013452, 13175.67060823487, 5618.073017951992, 5623.128415095667, 5623.8875222496135, 5639.661620302795, 5647.124695672177, 1013.9847902281472, 1016.2733645443395, 1017.3234798858824, 1018.3126389686931, 1024.472396715692, 28098.0, 28337.0, 28418.43163136767, 28606.14181574556, 28667.56998645022, 1091.5579190427889, 1094.4965315954591, 1099.7360633448075, 1108.939008354532, 1132.0717012050204, 13999.0, 15018.0, 15067.397304107713, 15094.54716358511, 15149.318280677397, 306102.0, 307078.0, 309010.0, 309735.0, 310381.0, 54278.72860635751, 54367.18449223265, 54480.727596361765, 54920.72539637276, 54937.725311373986, 1528.5414375687249, 1538.9461368851812, 1576.282791329942, 1581.3279356273538, 1585.5560443075958, 26111.608325875506, 27361.726382735917, 27371.726282737713, 27403.725962740915, 27607.171784846487, 41746.0, 41754.0, 41788.58211417847, 41850.79074604608, 41864.372034420114, 293005.27978880604, 293525.0, 294053.0, 294119.0, 294318.0, 28863.855680722303, 34702.13244668904, 34710.65289347175, 34908.0, 34985.65014349824, 44027.0, 44573.77713111414, 44853.32720009268, 45901.31148032715, 46168.0, 37854.0, 38060.42909356306, 38256.42615360828, 38596.80701596474, 39262.60737392589, 36995.630043700294, 37045.259094818495, 37322.06694832651, 37603.81198093992, 38644.6135538641, 38202.617973819906, 38324.23351532898, 38709.419358710205, 39065.609343906195, 39150.6084939147, 32547.837260813543, 34127.0, 34180.31639367248, 34438.48342274818, 34734.47898281477, 26318.21045368642, 26545.33636659099, 26600.8669956649, 26604.201873943814, 26792.19623411301], "value": 19005.105309681607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.53162976319516, 463.16167736397125, 481.7976449891045, 483.58411765881334, 495.24475175357577, 19978.60042799145, 21601.783982160174, 21706.0, 21787.782122178774, 21882.343529694095, 22175.334739957787, 22208.666869996963, 22453.0, 22580.88709556454, 22738.31785046451, 6679.432248258904, 6920.0, 7044.119485064367, 7289.416846652255, 7338.156112047102, 7206.603636799974, 7341.229170937055, 7357.117145942468, 7363.410927125844, 7471.850562988737, 7573.6213189340315, 7610.771676849703, 7624.466287359887, 7632.198619144993, 7649.847003059936, 7374.115106187238, 7467.327940485356, 7522.849543009109, 7522.887156692654, 7524.172341042481, 7095.077639906779, 7304.5252058616015, 7345.77962661121, 7399.149097853762, 7402.666879990359, 25182.370440738945, 25357.0, 25453.236402907944, 25480.490390192277, 25732.0, 3023.56158357037, 3162.604674415698, 3178.6821317868257, 3234.83825808711, 3236.01301603011, 15138.621534461616, 15718.528444146694, 15795.131267780267, 16134.273957671932, 16744.66510669792, 2108.8734675919495, 2168.4036889855256, 2215.9889200554057, 2251.887405629712, 2260.6382978723327, 115737.0, 119069.0, 119703.40148299203, 120055.3997230017, 120881.39559302235, 16024.519264422086, 16186.352545898033, 17250.827491724922, 17606.0, 17987.772873374746, 29611.0, 29773.553396699066, 29899.551506727417, 29954.55068173979, 30082.398352032837, 10199.694009179737, 10303.845442318372, 10408.791824163625, 10478.685639430829, 10587.947060264649, 8953.59708813105, 8996.50519221436, 9022.771851639494, 9158.725238242863, 9193.356465047382, 8755.824883502422, 8943.418677785923, 8969.910300897038, 8990.55047247635, 9126.771830704285, 3318.6271815651444, 3764.924701506009, 3864.30442520349, 3894.3963685628773, 3939.940900886489, 958.4680502321139, 962.2302158273353, 971.3589031239349, 979.8775153105862, 984.3011461862015, 19600.52996025304, 20582.38252852417, 20892.37322880316, 20935.581288374146, 21038.89480552618, 1064.6114168328659, 1092.4100985467917, 1096.446294621211, 1097.5609756097465, 1116.1126904111252, 10568.365898046142, 10652.89347106519, 11375.54497820078, 11439.142064345207, 11456.54173833054, 722630.0, 725893.0, 728087.7191228126, 762042.0, 808856.0, 120495.0, 120542.0, 121984.0, 124480.37759811143, 124762.0, 1366.4397596985189, 1367.4803574641771, 1405.6977749783846, 1406.6342750884844, 1407.8944079194102, 17383.91308043452, 17801.55496112556, 18018.36935707244, 18163.36428225006, 18186.636267274844, 54711.45288547223, 54907.69676214838, 54974.45025549853, 55132.0, 56307.0, 65271.0, 72349.0, 72435.0, 72525.87960672045, 77512.61243693746, 11775.411229438323, 12451.937740311241, 12621.368931553201, 12667.429965651752, 12878.291693956922, 14234.0, 14235.145891246559, 14282.642933926734, 14425.927870360581, 14474.059186152866, 12890.871091288967, 12975.545855894998, 12995.415206315549, 13065.542706005624, 13210.207387556777, 11839.704007399883, 11923.463444144862, 12035.0, 12229.510819567118, 12355.196912200678, 12785.232886026868, 12946.870531294566, 12998.155119917175, 13019.674508137372, 13055.608331749683, 12231.449584768885, 12256.203346782431, 12309.0, 12345.382730863601, 12671.17637353569, 12714.87285127137, 12730.23618582888, 12761.361931903553, 12890.871091288967, 13181.538646147339], "value": 11760.23461442186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.234153557078, 1530.7550791873296, 1540.5994441445225, 1543.6449616588184, 1569.45069225771, 9447.669331573396, 11560.075193984481, 11880.881191188086, 11923.76152476951, 11935.104867134978, 11638.185327027111, 11706.122040846927, 11735.7652846943, 11739.882601174008, 11741.119416043788, 2035.898205089747, 2497.1634502441702, 2533.0627667762956, 2537.53055684698, 2539.6825396825398, 2007.3977806657945, 2398.8560686358787, 2463.3964678653665, 2463.519613675325, 2471.3450935502105, 2430.1858877276136, 2473.4063824682125, 2478.7521247875247, 2485.5526005319034, 2495.7629025242572, 2403.3510952043025, 2421.4914867877765, 2424.248482970267, 2426.187227278855, 2428.987855060713, 2303.1363238785457, 2380.690510233676, 2396.472775989297, 2406.2540612410207, 2408.3497455686866, 11377.772444551145, 11476.311421314747, 11487.195896287263, 11489.482973266224, 11506.769864602746, 5681.176229446748, 5826.388229235954, 5835.854103647443, 5837.474627283523, 5839.649621022752, 3333.383324085052, 3379.4761811919193, 3564.9108772280642, 3592.263585964871, 3631.58368236388, 1354.9322533873365, 1414.2575148047254, 1421.1118051217989, 1433.655922578584, 1458.0814087125043, 17314.0, 17330.480085597454, 17387.65224695499, 17389.65220695604, 17394.65210695779, 4925.310456536088, 5054.848354549369, 5066.544011038951, 5137.023965446553, 5137.17805151174, 13072.411741471657, 13146.4084116215, 13168.539101131415, 13174.47302107924, 13178.736425271632, 5913.793017244376, 5926.8814623707285, 5938.465538101592, 5939.792107276225, 5940.0, 4652.464966528893, 4771.355866957916, 5460.34475862899, 5531.917021244684, 5571.9721401392735, 4120.428210969809, 4127.318992366286, 4176.517336345614, 4189.685773566995, 4212.115455754265, 996.8654231678776, 1005.6832097889142, 1005.9295849290626, 1011.0849681038671, 1015.21320976244, 1055.3351388625117, 1080.6541906589973, 1085.3216739537788, 1086.820674588684, 1089.1613457637575, 7048.894266586005, 7169.283071692789, 7302.233265507151, 7310.963445182846, 7406.222346653632, 1103.5530610102921, 1108.2408550143177, 1109.8612673415823, 1117.0, 1127.0926903842485, 4424.269995450779, 4542.454905411306, 4580.267157254823, 4591.0, 4699.483056863743, 15004.474843380429, 15249.466268680764, 15319.387224511118, 15397.076175429285, 15538.766918496232, 15216.239188040554, 15235.466758663615, 15356.308966096552, 15357.539273821803, 15474.922625386802, 10177.389356638478, 11098.2786118902, 11109.0, 11187.0, 11191.384473854016, 6634.436072933661, 6906.343897329745, 6918.481113916376, 6956.2695916928, 7015.789526314219, 12790.296533690736, 12861.228326300452, 12897.0, 12913.677158071123, 12973.0, 13058.673533161747, 13061.08572399961, 13157.53948611794, 13306.534271300457, 13358.131721438076, 8811.515366654896, 9062.093790620886, 9940.254480913816, 10215.387076775418, 10219.029192226726, 10903.781924361627, 11174.441277935908, 11211.943940280247, 11285.266457680225, 11420.657380278604, 9884.0, 9928.453935033354, 9932.304738668225, 10006.749831253986, 10120.089191972758, 9727.124558789743, 9728.854067189139, 9741.415515069119, 9928.801423971336, 10039.548220330249, 8681.826363472821, 8852.336074794288, 8852.424592401474, 8856.291496680122, 8867.157620026088, 6441.903371449338, 6490.578112422678, 6498.870022599616, 6512.446442052478, 6594.736210551524, 6428.963247394442, 6565.540412171294, 6592.538522303585, 6657.53397262187, 6701.32986701326], "value": 5478.86382992737, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.90195638405567, 426.71836587852016, 427.3440269186799, 432.10769760444657, 439.5845925600309, 5183.818566350169, 5234.84295471136, 5262.9473705262935, 5288.254875890952, 5295.655782374143, 5166.509181627749, 5198.45416231296, 5228.92156617651, 5249.790008399659, 5250.842474725755, 4211.978940105295, 4235.809388577506, 4356.629686476637, 4361.302191649337, 4390.473143222818, 4303.978480107595, 4332.155229730204, 4351.738895666254, 4366.607005369516, 4373.343998400233, 4353.238183317907, 4368.235558777201, 4381.978090109545, 4410.404595379615, 4430.6012458878695, 4176.812043458051, 4309.159713855799, 4390.253656878338, 4407.735535867842, 4409.338599210112, 4041.797910104483, 4074.796260186979, 4083.2445997490263, 4091.9181616367805, 4117.8970525736795, 5138.84583462493, 5142.331496905378, 5153.433122356538, 5164.612654050961, 5186.18483530765, 4971.9159558976435, 5033.697978121288, 5093.567046801027, 5153.788859617986, 5171.0692075426405, 5456.836294911159, 5461.262729531502, 5496.230527726121, 5499.50504454601, 5505.917411238835, 4555.339475775994, 4560.179167749804, 4562.676823721117, 4588.082383523275, 4588.220002599566, 5452.263944367539, 5704.3154821421695, 5720.48515633595, 5746.310442746855, 5802.187693722924, 4717.292406139038, 4717.693349932243, 4728.219843725747, 4761.571458568746, 4779.972305954237, 4765.285207218875, 4766.666333356701, 4851.369321988119, 4863.975680121577, 4871.732054737024, 4999.975000124976, 5035.345405097314, 5114.028334616411, 5150.532098352027, 5167.501424586828, 5508.256385388001, 5525.502704756511, 5539.944600553943, 5552.0, 5555.611107222456, 1648.5301689018572, 1649.7937757780278, 1659.7593348964333, 1665.4171040135855, 1672.2057022914018, 1251.174225011488, 1279.4498365702837, 1279.9488020479262, 1283.8138469921996, 1300.5058077930325, 5464.0, 5469.960707465569, 5475.890482190413, 5508.421615730371, 5519.613627046148, 5628.915566266509, 5662.669272720907, 5680.744366503517, 5708.429157084258, 5753.88492230153, 5202.03762303975, 5452.509274165344, 5460.726963651801, 5481.75332110048, 5519.365272993577, 2961.748251398612, 2991.7584202555695, 3011.9548206776917, 3015.231116065433, 3028.3489049853947, 5738.483536481736, 5896.292444906639, 5918.289805223315, 5931.199288096138, 5935.7625694972585, 5566.805161819317, 5828.861508329134, 5836.7957121501395, 5841.561882858802, 5856.707164641836, 5659.377468478464, 5716.771329146871, 5732.824770921951, 5759.596828222068, 5894.322152952293, 5629.521490673339, 5637.449701332166, 5686.43135686428, 5723.255976723, 5745.368009518866, 5423.3696657122055, 5539.01488660209, 5568.830545585311, 5579.414161512983, 5604.439556044363, 5802.796902108406, 5850.356460789225, 5878.559108066826, 5883.735231914488, 5899.0, 4687.601553867959, 4714.5521175488275, 4724.598409135125, 4739.644526660583, 4748.453927798348, 5365.3293338332705, 5653.766762129018, 5674.829755107354, 5680.0, 5686.9715651421475, 5504.697241651747, 5551.583631227593, 5554.361248456317, 5573.191887176417, 5601.563319955832, 5304.324372920937, 5417.593680473901, 5554.555635549227, 5558.916616250679, 5585.9720701397855, 5494.664767473728, 5506.449355064461, 5561.221428999862, 5565.777368905198, 5571.582131340247, 5521.5306698931045, 5561.663002198648, 5584.631765217548, 5658.660480371191, 5680.034394152921, 5213.869653258547, 5280.894382112413, 5375.650582712111, 5413.56691464674, 5470.53500452466], "value": 4448.415470469366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.9104444033372, 900.3922352412122, 902.5126431726868, 932.4871320773573, 935.8362286599844, 15418.61453463664, 16166.595835104128, 16614.66770664589, 17004.914975425138, 17025.48923532296, 16648.33406663732, 16664.083475408846, 16864.409745658875, 16898.493045208634, 17053.0, 863.5682158920555, 884.4781578868466, 884.6903583745669, 887.6981826179098, 908.5865931001412, 893.066745251214, 897.7979954510248, 900.9684661036865, 902.0122965352928, 903.7333986474006, 967.5936106835111, 968.7287559483356, 968.8352979993418, 970.4904924914441, 970.9563069661847, 966.1690945786618, 966.9274804389629, 967.5742673223759, 967.632299726103, 967.7145242153582, 712.2272334517055, 713.9821504462378, 714.0788382985994, 714.1679942866555, 714.3035540348171, 17158.742618860728, 17357.739633905374, 17393.65212695739, 17596.0, 18023.459296221004, 15302.693946121015, 15508.689826203412, 15647.217639117998, 15751.606209844731, 15975.360985560563, 13612.251326177056, 14092.436302547989, 14128.71742565143, 14160.867130629627, 14169.008169428143, 4018.45750823638, 4031.6976226782817, 4052.230076285496, 4056.188762247533, 4134.441850350225, 84752.0, 85179.0, 85717.57141214254, 86614.0, 89350.6597401046, 12769.233845969271, 12802.615921522369, 12820.679483013, 12821.976560056728, 12910.22538647684, 24128.75871241265, 24162.75837241605, 24336.756632433448, 24398.87800560986, 24706.752932470805, 8618.353623478264, 8658.956705216433, 8775.736727898173, 8791.868121978176, 8794.03265640779, 5031.974840125776, 5110.233464980282, 5155.484451554815, 5249.580033597379, 5276.366835979707, 3787.659110680052, 3887.2031233597045, 3889.8055097245024, 3891.4357418174773, 3896.4155376693725, 617.0805499805258, 620.3176505843536, 624.4536030972898, 627.250435729299, 631.5547538985005, 715.7745310227261, 732.9157146928064, 744.0810598910341, 749.9689170707447, 751.4627041665235, 10948.919705255976, 11295.435228238719, 11362.318260904372, 11756.647300580997, 11876.703082423008, 737.3363972424861, 751.6279441676296, 756.7275780718937, 763.9197884222187, 777.9727709530139, 5246.081935661244, 5330.147176451749, 5353.4646535346155, 5390.946090539122, 5444.156155795858, 79862.0, 80909.0, 81788.0, 82390.17609823825, 84900.0, 57914.0, 66974.0, 72657.0, 73085.63457182786, 76470.0, 67084.32915670879, 67641.97684551227, 67657.3234267651, 68154.31845681579, 68568.0, 10248.743781405525, 10526.263161578921, 10548.367097974146, 10585.52365143555, 10658.413787241776, 43710.34434483549, 43876.56123438852, 44409.77795111004, 44497.33254001128, 44605.55394446014, 50989.745051274505, 51092.48907510877, 51239.48760512496, 52369.21446178234, 54209.0, 12278.324692142018, 12349.75300494003, 12500.124991250525, 12625.116241862981, 13151.079424440197, 14008.789868151782, 14297.64255893611, 14444.711105777615, 14651.926740366656, 14920.552383428514, 13246.20522768637, 13625.182489050689, 13859.168449893039, 13991.370388332753, 14226.288685565472, 13816.861831381959, 14503.709925801213, 14538.636534086732, 14565.708685826436, 14570.635734106732, 14915.207047932538, 15993.600159996093, 16308.755368669243, 16393.754093688367, 16539.338426462808, 12419.93790031044, 12633.0, 13154.408051637507, 13176.934115329363, 13381.933090334485, 12706.936465317984, 13734.725305494034, 13759.587212383645, 13813.309334533033, 14309.427622894967], "value": 7895.439641531217, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 113.0, 113.0, 115.0, 115.0, 113.0, 114.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 117.0, 156.0, 117.0, 116.0, 116.0, 122.0, 147.0, 121.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 116.0, 76.0, 76.0, 76.0, 75.0, 101.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 105.0, 82.0, 82.0, 82.0, 94.0, 80.0, 82.0, 98.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 56.0, 55.0, 57.0, 58.0, 54.0, 55.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 53.0, 52.0, 53.0, 54.0, 53.0, 54.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 76.0, 75.0, 81.0, 84.0, 80.0, 80.0, 95.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 120.0, 130.0, 128.0, 121.0, 124.0, 118.0, 121.0, 130.0, 124.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 157.0, 162.0, 159.0, 155.0, 159.0, 160.0, 160.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 58.0], "value": 59.5, "unit": "score"}]}]} 09:04:54 INFO - Return code: 0 09:04:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:04:54 ERROR - # TBPL SUCCESS # 09:04:54 INFO - Running post-action listener: _resource_record_post_action 09:04:54 INFO - [mozharness: 2017-03-10 17:04:54.133871Z] Finished run-tests step (success) 09:04:54 INFO - Running post-run listener: _resource_record_post_run 09:04:54 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363286528; Read time: 16; Write time: 330164 09:04:54 INFO - TinderboxPrint: CPU usage
13.2% 09:04:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:04:54 INFO - TinderboxPrint: I/O write bytes / time
363,286,528 / 330,164 09:04:54 INFO - TinderboxPrint: CPU idle
8,275.5 (86.8%) 09:04:54 INFO - TinderboxPrint: CPU user
1,204.3 (12.6%) 09:04:54 INFO - TinderboxPrint: Swap in / out
0 / 0 09:04:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110579712; Read time: 0; Write time: 138128 09:04:54 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252706816; Read time: 16; Write time: 192036 09:04:54 INFO - Running post-run listener: _upload_blobber_files 09:04:54 INFO - Blob upload gear active. 09:04:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:54 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 09:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:04:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:04:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:04:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:56 INFO - (blobuploader) - INFO - Done attempting. 09:04:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:04:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:57 INFO - (blobuploader) - INFO - Done attempting. 09:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:00 INFO - (blobuploader) - INFO - Done attempting. 09:05:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:05:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:05:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:01 INFO - (blobuploader) - INFO - Done attempting. 09:05:01 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:01 INFO - Return code: 0 09:05:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085d315ea835e3b31a5ec13921d3ed353099120a1a640456cd07ea1ca9ef8c9c4736b04915c02d6cc22a3cc4b81a51bce0ff92779f94e4f65473a0f668c5f02e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad3846e7c5e31c009b3bec6c50fa0a4b048529b6b68a59101e2f46de52b19cee43b8175fdcc92f771bc96bd18f5ba010a90313efc3dd78857a1dff4b64c2c6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5548e00b5f78b0448c9a2bef0cf850f31a71e77f66d974cf22765288a4aa3dbab166645ee851289a7452b0d892e34dbd9201eb6ffcbbf5a30a39faddd49ca33b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd98ca7ae850d091809a187d5c6c6178f19b3a6fe70db35a399ea646736892dffe8e0574b7c9647729439988f30193ea6892bfe8e2fccde3ef700f98eb6194e1"} 09:05:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:01 INFO - Contents: 09:05:01 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085d315ea835e3b31a5ec13921d3ed353099120a1a640456cd07ea1ca9ef8c9c4736b04915c02d6cc22a3cc4b81a51bce0ff92779f94e4f65473a0f668c5f02e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad3846e7c5e31c009b3bec6c50fa0a4b048529b6b68a59101e2f46de52b19cee43b8175fdcc92f771bc96bd18f5ba010a90313efc3dd78857a1dff4b64c2c6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5548e00b5f78b0448c9a2bef0cf850f31a71e77f66d974cf22765288a4aa3dbab166645ee851289a7452b0d892e34dbd9201eb6ffcbbf5a30a39faddd49ca33b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd98ca7ae850d091809a187d5c6c6178f19b3a6fe70db35a399ea646736892dffe8e0574b7c9647729439988f30193ea6892bfe8e2fccde3ef700f98eb6194e1"} 09:05:01 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:01 INFO - Copying logs to upload dir... 09:05:01 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.088072 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-10 09:05:00.298731) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 09:05:00.301865) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085d315ea835e3b31a5ec13921d3ed353099120a1a640456cd07ea1ca9ef8c9c4736b04915c02d6cc22a3cc4b81a51bce0ff92779f94e4f65473a0f668c5f02e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad3846e7c5e31c009b3bec6c50fa0a4b048529b6b68a59101e2f46de52b19cee43b8175fdcc92f771bc96bd18f5ba010a90313efc3dd78857a1dff4b64c2c6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5548e00b5f78b0448c9a2bef0cf850f31a71e77f66d974cf22765288a4aa3dbab166645ee851289a7452b0d892e34dbd9201eb6ffcbbf5a30a39faddd49ca33b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd98ca7ae850d091809a187d5c6c6178f19b3a6fe70db35a399ea646736892dffe8e0574b7c9647729439988f30193ea6892bfe8e2fccde3ef700f98eb6194e1"} build_url:https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/H1MZ8SzgQaOeTmFOHNhosw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085d315ea835e3b31a5ec13921d3ed353099120a1a640456cd07ea1ca9ef8c9c4736b04915c02d6cc22a3cc4b81a51bce0ff92779f94e4f65473a0f668c5f02e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad3846e7c5e31c009b3bec6c50fa0a4b048529b6b68a59101e2f46de52b19cee43b8175fdcc92f771bc96bd18f5ba010a90313efc3dd78857a1dff4b64c2c6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5548e00b5f78b0448c9a2bef0cf850f31a71e77f66d974cf22765288a4aa3dbab166645ee851289a7452b0d892e34dbd9201eb6ffcbbf5a30a39faddd49ca33b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd98ca7ae850d091809a187d5c6c6178f19b3a6fe70db35a399ea646736892dffe8e0574b7c9647729439988f30193ea6892bfe8e2fccde3ef700f98eb6194e1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 09:05:00.326886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:05:00.327210) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1489164247.48067-1405946549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:05:00.411353) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 09:05:00.411855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 09:05:00.412314) ========= ========= Total master_lag: 0.15 =========