builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-070 starttime: 1490889258.45 results: success (0) revision: 3364cc17988c013c36f2a8123315db2855393011 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:18.448992) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:18.449758) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:18.450280) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:18.469656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:18.470364) ========= 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=2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-30 08:54:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.0M=0s 2017-03-30 08:54:19 (89.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.327253 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:18.816837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:18.817399) ========= 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=2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018026 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:18.867449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 08:54:18.867838) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3364cc17988c013c36f2a8123315db2855393011 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 3364cc17988c013c36f2a8123315db2855393011 --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=2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-30 08:54:19,212 truncating revision to first 12 chars 2017-03-30 08:54:19,212 Setting DEBUG logging. 2017-03-30 08:54:19,212 attempt 1/10 2017-03-30 08:54:19,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3364cc17988c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 08:54:20,493 unpacking tar archive at: mozilla-central-3364cc17988c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.661861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 08:54:20.546307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:20.546624) ========= script_repo_revision: 3364cc17988c013c36f2a8123315db2855393011 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:20.547000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:20.547295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 08:54:20.558281) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-03-30 08:54:20.558662) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:54:20 INFO - MultiFileLogger online at 20170330 08:54:20 in /builds/slave/test 08:54:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:54:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:54:20 INFO - {'append_to_log': False, 08:54:20 INFO - 'base_work_dir': '/builds/slave/test', 08:54:20 INFO - 'blob_upload_branch': 'Firefox', 08:54:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:54:20 INFO - 'branch': 'Firefox', 08:54:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:54:20 INFO - 'config_files': ('talos/linux_config.py',), 08:54:20 INFO - 'default_actions': ('clobber', 08:54:20 INFO - 'read-buildbot-config', 08:54:20 INFO - 'download-and-extract', 08:54:20 INFO - 'populate-webroot', 08:54:20 INFO - 'create-virtualenv', 08:54:20 INFO - 'install', 08:54:20 INFO - 'run-tests'), 08:54:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:54:20 INFO - 'download_minidump_stackwalk': True, 08:54:20 INFO - 'download_symbols': 'ondemand', 08:54:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:54:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:54:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:54:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:54:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:54:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:54:20 INFO - 'gecko_profile': False, 08:54:20 INFO - 'gecko_profile_interval': 0, 08:54:20 INFO - 'installer_path': 'installer.exe', 08:54:20 INFO - 'log_level': 'info', 08:54:20 INFO - 'log_name': 'talos', 08:54:20 INFO - 'log_to_console': True, 08:54:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:54:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:54:20 INFO - 'opt_config_files': (), 08:54:20 INFO - 'pip_index': False, 08:54:20 INFO - 'suite': 'dromaeojs', 08:54:20 INFO - 'system_bits': '32', 08:54:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:54:21 INFO - 'title': 'talos-linux64-ix-070', 08:54:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:54:21 INFO - 'use_talos_json': True, 08:54:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:54:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:54:21 INFO - 'work_dir': 'build'} 08:54:21 INFO - [mozharness: 2017-03-30 15:54:21.001236Z] Running clobber step. 08:54:21 INFO - Running pre-action listener: _resource_record_pre_action 08:54:21 INFO - Running main action method: clobber 08:54:21 INFO - rmtree: /builds/slave/test/build 08:54:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:54:21 INFO - Running post-action listener: _resource_record_post_action 08:54:21 INFO - [mozharness: 2017-03-30 15:54:21.953993Z] Finished clobber step (success) 08:54:21 INFO - [mozharness: 2017-03-30 15:54:21.954093Z] Running read-buildbot-config step. 08:54:21 INFO - Running pre-action listener: _resource_record_pre_action 08:54:21 INFO - Running main action method: read_buildbot_config 08:54:21 INFO - Using buildbot properties: 08:54:21 INFO - { 08:54:21 INFO - "project": "", 08:54:21 INFO - "product": "firefox", 08:54:21 INFO - "who": "ffxbld@noreply.mozilla.org", 08:54:21 INFO - "installer_path": "public/build/target.tar.bz2", 08:54:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:54:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:54:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 08:54:21 INFO - "stage_platform": "linux64-pgo", 08:54:21 INFO - "basedir": "/builds/slave/test", 08:54:21 INFO - "buildnumber": 100, 08:54:21 INFO - "platform": "ubuntu64_hw", 08:54:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:54:21 INFO - "slavebuilddir": "test", 08:54:21 INFO - "taskId": "XtdFedH3S62F-Lv777AYEQ", 08:54:21 INFO - "branch": "mozilla-central", 08:54:21 INFO - "script_repo_revision": "production", 08:54:21 INFO - "revision": "3364cc17988c013c36f2a8123315db2855393011", 08:54:21 INFO - "slavename": "talos-linux64-ix-070", 08:54:21 INFO - "repo_path": "mozilla-central" 08:54:21 INFO - } 08:54:21 INFO - Finding installer, test and symbols from parent task. 08:54:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtdFedH3S62F-Lv777AYEQ'}, attempt #1 08:54:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtdFedH3S62F-Lv777AYEQ'}, attempt #1 08:54:22 INFO - Task dependencies: WgH8lurJR5CFvoQqZS9iMQ 08:54:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ'}, attempt #1 08:54:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.tar.bz2 08:54:23 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/test_packages.json 08:54:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.crashreporter-symbols.zip 08:54:23 INFO - Running post-action listener: _resource_record_post_action 08:54:23 INFO - [mozharness: 2017-03-30 15:54:23.335796Z] Finished read-buildbot-config step (success) 08:54:23 INFO - [mozharness: 2017-03-30 15:54:23.336011Z] Running download-and-extract step. 08:54:23 INFO - Running pre-action listener: _resource_record_pre_action 08:54:23 INFO - Running main action method: download_and_extract 08:54:23 INFO - mkdir: /builds/slave/test/build/tests 08:54:23 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:54:23 INFO - trying https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.test_packages.json 08:54:23 INFO - Downloading https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:54:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:54:24 INFO - Downloaded 986 bytes. 08:54:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:54:24 INFO - Using the following test package requirements: 08:54:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:54:24 INFO - u'common': [u'target.common.tests.zip'], 08:54:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:54:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:54:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:54:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:54:24 INFO - u'mozbase': [u'target.common.tests.zip'], 08:54:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:54:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:54:24 INFO - u'web-platform': [u'target.common.tests.zip', 08:54:24 INFO - u'target.web-platform.tests.zip'], 08:54:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:54:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:54:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.common.tests.zip 08:54:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:54:24 INFO - Fetch https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.common.tests.zip into memory 08:54:26 INFO - Expected file size: 60347393 08:54:26 INFO - Obtained file size: 60347393 08:54:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:54:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.common.tests.zip 08:54:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:54:36 INFO - Fetch https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.common.tests.zip into memory 08:54:37 INFO - Expected file size: 60347393 08:54:37 INFO - Obtained file size: 60347393 08:54:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.talos.tests.zip 08:54:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:54:48 INFO - Fetch https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.talos.tests.zip into memory 08:54:49 INFO - Expected file size: 14404152 08:54:49 INFO - Obtained file size: 14404152 08:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:49 INFO - trying https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.tar.bz2 08:54:49 INFO - Downloading https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:54:51 INFO - Downloaded 68062743 bytes. 08:54:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.tar.bz2 08:54:51 INFO - mkdir: /builds/slave/test/properties 08:54:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:54:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:54:51 INFO - Contents: 08:54:51 INFO - build_url:https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.tar.bz2 08:54:51 INFO - Running post-action listener: _resource_record_post_action 08:54:51 INFO - Running post-action listener: set_extra_try_arguments 08:54:51 INFO - [mozharness: 2017-03-30 15:54:51.934761Z] Finished download-and-extract step (success) 08:54:51 INFO - [mozharness: 2017-03-30 15:54:51.934897Z] Running populate-webroot step. 08:54:51 INFO - Running pre-action listener: _resource_record_pre_action 08:54:51 INFO - Running main action method: populate_webroot 08:54:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:54:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:54:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:54:51 INFO - '--tppagecycles', 08:54:51 INFO - '7'], 08:54:51 INFO - 'tests': ['tsvgm']}}, 08:54:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:54:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:54:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:54:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:54:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:54:51 INFO - 'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:54:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:54:51 INFO - 'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['damp', 'tps']}, 08:54:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:54:51 INFO - 'tests': ['damp', 'tps']}, 08:54:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['dromaeo_dom']}, 08:54:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:54:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['basic_compositor_video']}, 08:54:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:54:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['a11yr', 08:54:51 INFO - 'ts_paint', 08:54:51 INFO - 'tpaint', 08:54:51 INFO - 'sessionrestore', 08:54:51 INFO - 'sessionrestore_no_auto_restore', 08:54:51 INFO - 'tabpaint']}, 08:54:51 INFO - 'other-e10s': {'tests': ['a11yr', 08:54:51 INFO - 'ts_paint', 08:54:51 INFO - 'tpaint', 08:54:51 INFO - 'sessionrestore', 08:54:51 INFO - 'sessionrestore_no_auto_restore', 08:54:51 INFO - 'tabpaint']}, 08:54:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:54:51 INFO - 'ts_paint', 08:54:51 INFO - 'tpaint', 08:54:51 INFO - 'sessionrestore', 08:54:51 INFO - 'sessionrestore_no_auto_restore', 08:54:51 INFO - 'tabpaint']}, 08:54:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:54:51 INFO - 'ts_paint', 08:54:51 INFO - 'tpaint', 08:54:51 INFO - 'sessionrestore', 08:54:51 INFO - 'sessionrestore_no_auto_restore', 08:54:51 INFO - 'tabpaint']}, 08:54:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['a11yr', 08:54:51 INFO - 'ts_paint', 08:54:51 INFO - 'tpaint', 08:54:51 INFO - 'sessionrestore', 08:54:51 INFO - 'sessionrestore_no_auto_restore', 08:54:51 INFO - 'tabpaint']}, 08:54:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['a11yr', 08:54:51 INFO - 'ts_paint', 08:54:51 INFO - 'tpaint', 08:54:51 INFO - 'sessionrestore', 08:54:51 INFO - 'sessionrestore_no_auto_restore', 08:54:51 INFO - 'tabpaint']}, 08:54:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['tsvgx', 08:54:51 INFO - 'tsvgr_opacity', 08:54:51 INFO - 'tart', 08:54:51 INFO - 'tscrollx', 08:54:51 INFO - 'cart', 08:54:51 INFO - 'tsvg_static']}, 08:54:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:54:51 INFO - 'tsvgr_opacity', 08:54:51 INFO - 'tart', 08:54:51 INFO - 'tscrollx', 08:54:51 INFO - 'cart', 08:54:51 INFO - 'tsvg_static']}, 08:54:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:54:51 INFO - 'talos_options': ['--disable-e10s'], 08:54:51 INFO - 'tests': ['tp5o']}, 08:54:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:54:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:54:51 INFO - 'talos_options': ['--disable-e10s', 08:54:51 INFO - '--xperf_path', 08:54:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:51 INFO - 'tests': ['tp5n']}, 08:54:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:54:51 INFO - 'talos_options': ['--xperf_path', 08:54:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:51 INFO - 'tests': ['tp5n']}}, 08:54:51 INFO - 'talos.zip': {'path': '', 08:54:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:54:51 INFO - Running post-action listener: _resource_record_post_action 08:54:51 INFO - [mozharness: 2017-03-30 15:54:51.949359Z] Finished populate-webroot step (success) 08:54:51 INFO - [mozharness: 2017-03-30 15:54:51.949449Z] Running create-virtualenv step. 08:54:51 INFO - Running pre-action listener: _resource_record_pre_action 08:54:51 INFO - Running main action method: create_virtualenv 08:54:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:54:51 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:54:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:54:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:54:52 INFO - Using real prefix '/usr' 08:54:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:54:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:54 INFO - Installing pip.................done. 08:54:54 INFO - Return code: 0 08:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:54:54 INFO - Reading from file tmpfile_stdout 08:54:54 INFO - Output received: 08:54:54 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:54:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:54:54 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:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:54 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:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:54 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:54:54 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:54:54 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:54:54 INFO - Using env: {'DISPLAY': ':0', 08:54:54 INFO - 'HOME': '/home/cltbld', 08:54:54 INFO - 'LANG': 'en_US.UTF-8', 08:54:54 INFO - 'LANGUAGE': 'en_US:en', 08:54:54 INFO - 'LOGNAME': 'cltbld', 08:54:54 INFO - 'MAIL': '/var/mail/cltbld', 08:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:54 INFO - 'MOZ_NO_REMOTE': '1', 08:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:54 INFO - 'NO_EM_RESTART': '1', 08:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:54 INFO - 'PWD': '/builds/slave/test', 08:54:54 INFO - 'SHELL': '/bin/bash', 08:54:54 INFO - 'SHLVL': '1', 08:54:54 INFO - 'TERM': 'linux', 08:54:54 INFO - 'TMOUT': '86400', 08:54:54 INFO - 'USER': 'cltbld', 08:54:54 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:54 INFO - '_': '/tools/buildbot/bin/python'} 08:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:54 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:54:54 INFO - Cleaning up... 08:54:54 INFO - Return code: 0 08:54:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:54:54 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:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:54 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:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:54 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:54:54 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:54:54 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:54:54 INFO - Using env: {'DISPLAY': ':0', 08:54:54 INFO - 'HOME': '/home/cltbld', 08:54:54 INFO - 'LANG': 'en_US.UTF-8', 08:54:54 INFO - 'LANGUAGE': 'en_US:en', 08:54:54 INFO - 'LOGNAME': 'cltbld', 08:54:54 INFO - 'MAIL': '/var/mail/cltbld', 08:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:54 INFO - 'MOZ_NO_REMOTE': '1', 08:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:54 INFO - 'NO_EM_RESTART': '1', 08:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:54 INFO - 'PWD': '/builds/slave/test', 08:54:54 INFO - 'SHELL': '/bin/bash', 08:54:54 INFO - 'SHLVL': '1', 08:54:54 INFO - 'TERM': 'linux', 08:54:54 INFO - 'TMOUT': '86400', 08:54:54 INFO - 'USER': 'cltbld', 08:54:54 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:54 INFO - '_': '/tools/buildbot/bin/python'} 08:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:55 INFO - Downloading/unpacking psutil>=3.1.1 08:54:55 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:54:55 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:54:55 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:54:55 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:54:55 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:54:55 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:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:57 INFO - Installing collected packages: psutil 08:54:57 INFO - Running setup.py install for psutil 08:54:57 INFO - building 'psutil._psutil_linux' extension 08:54:57 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:54:57 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:54:57 INFO - building 'psutil._psutil_posix' extension 08:54:57 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:54:57 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:54:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:57 INFO - Successfully installed psutil 08:54:57 INFO - Cleaning up... 08:54:57 INFO - Return code: 0 08:54:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:54:57 INFO - Using env: {'DISPLAY': ':0', 08:54:57 INFO - 'HOME': '/home/cltbld', 08:54:57 INFO - 'LANG': 'en_US.UTF-8', 08:54:57 INFO - 'LANGUAGE': 'en_US:en', 08:54:57 INFO - 'LOGNAME': 'cltbld', 08:54:57 INFO - 'MAIL': '/var/mail/cltbld', 08:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:57 INFO - 'MOZ_NO_REMOTE': '1', 08:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:57 INFO - 'NO_EM_RESTART': '1', 08:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:57 INFO - 'PWD': '/builds/slave/test', 08:54:57 INFO - 'SHELL': '/bin/bash', 08:54:57 INFO - 'SHLVL': '1', 08:54:57 INFO - 'TERM': 'linux', 08:54:57 INFO - 'TMOUT': '86400', 08:54:57 INFO - 'USER': 'cltbld', 08:54:57 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:57 INFO - '_': '/tools/buildbot/bin/python'} 08:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:54:58 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:54:58 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:54:58 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:54:58 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:54:58 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:54:58 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:55:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:55:00 INFO - Installing collected packages: mozsystemmonitor 08:55:00 INFO - Running setup.py install for mozsystemmonitor 08:55:00 INFO - Successfully installed mozsystemmonitor 08:55:00 INFO - Cleaning up... 08:55:00 INFO - Return code: 0 08:55:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:55:00 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:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:00 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:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:00 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:55:00 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:55:00 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:55:00 INFO - Using env: {'DISPLAY': ':0', 08:55:00 INFO - 'HOME': '/home/cltbld', 08:55:00 INFO - 'LANG': 'en_US.UTF-8', 08:55:00 INFO - 'LANGUAGE': 'en_US:en', 08:55:00 INFO - 'LOGNAME': 'cltbld', 08:55:00 INFO - 'MAIL': '/var/mail/cltbld', 08:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:00 INFO - 'MOZ_NO_REMOTE': '1', 08:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:00 INFO - 'NO_EM_RESTART': '1', 08:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:00 INFO - 'PWD': '/builds/slave/test', 08:55:00 INFO - 'SHELL': '/bin/bash', 08:55:00 INFO - 'SHLVL': '1', 08:55:00 INFO - 'TERM': 'linux', 08:55:00 INFO - 'TMOUT': '86400', 08:55:00 INFO - 'USER': 'cltbld', 08:55:00 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:00 INFO - '_': '/tools/buildbot/bin/python'} 08:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:00 INFO - Downloading/unpacking jsonschema==2.5.1 08:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:55:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:55:02 INFO - warning: no files found matching '*.txt' 08:55:02 INFO - no previously-included directories found matching 'build' 08:55:02 INFO - no previously-included directories found matching 'dist' 08:55:02 INFO - no previously-included directories found matching '.git*' 08:55:02 INFO - Installing collected packages: jsonschema, functools32 08:55:02 INFO - Running setup.py install for functools32 08:55:03 INFO - warning: no files found matching '*.txt' 08:55:03 INFO - no previously-included directories found matching 'build' 08:55:03 INFO - no previously-included directories found matching 'dist' 08:55:03 INFO - no previously-included directories found matching '.git*' 08:55:03 INFO - Successfully installed jsonschema functools32 08:55:03 INFO - Cleaning up... 08:55:03 INFO - Return code: 0 08:55:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:55:03 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:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:03 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:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:03 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:55:03 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:55:03 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:55:03 INFO - Using env: {'DISPLAY': ':0', 08:55:03 INFO - 'HOME': '/home/cltbld', 08:55:03 INFO - 'LANG': 'en_US.UTF-8', 08:55:03 INFO - 'LANGUAGE': 'en_US:en', 08:55:03 INFO - 'LOGNAME': 'cltbld', 08:55:03 INFO - 'MAIL': '/var/mail/cltbld', 08:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:03 INFO - 'MOZ_NO_REMOTE': '1', 08:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:03 INFO - 'NO_EM_RESTART': '1', 08:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:03 INFO - 'PWD': '/builds/slave/test', 08:55:03 INFO - 'SHELL': '/bin/bash', 08:55:03 INFO - 'SHLVL': '1', 08:55:03 INFO - 'TERM': 'linux', 08:55:03 INFO - 'TMOUT': '86400', 08:55:03 INFO - 'USER': 'cltbld', 08:55:03 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:03 INFO - '_': '/tools/buildbot/bin/python'} 08:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:55:03 INFO - Cleaning up... 08:55:03 INFO - Return code: 0 08:55:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:55:03 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:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:03 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:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:03 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:55:03 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:55:03 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:55:03 INFO - Using env: {'DISPLAY': ':0', 08:55:03 INFO - 'HOME': '/home/cltbld', 08:55:03 INFO - 'LANG': 'en_US.UTF-8', 08:55:03 INFO - 'LANGUAGE': 'en_US:en', 08:55:03 INFO - 'LOGNAME': 'cltbld', 08:55:03 INFO - 'MAIL': '/var/mail/cltbld', 08:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:03 INFO - 'MOZ_NO_REMOTE': '1', 08:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:03 INFO - 'NO_EM_RESTART': '1', 08:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:03 INFO - 'PWD': '/builds/slave/test', 08:55:03 INFO - 'SHELL': '/bin/bash', 08:55:03 INFO - 'SHLVL': '1', 08:55:03 INFO - 'TERM': 'linux', 08:55:03 INFO - 'TMOUT': '86400', 08:55:03 INFO - 'USER': 'cltbld', 08:55:03 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:03 INFO - '_': '/tools/buildbot/bin/python'} 08:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:55:03 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:55:03 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:55:03 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:55:03 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:55:03 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:55:03 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:55:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:55:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:55:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:55:06 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:55:06 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:55:06 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:55:06 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:55:06 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:55:06 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:55:06 INFO - Downloading docopt-0.6.1.tar.gz 08:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:55:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:55:06 INFO - Running setup.py install for blobuploader 08:55:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:55:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:55:06 INFO - Running setup.py install for requests 08:55:06 INFO - Running setup.py install for docopt 08:55:06 INFO - Successfully installed blobuploader requests docopt 08:55:06 INFO - Cleaning up... 08:55:07 INFO - Return code: 0 08:55:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:07 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:55:07 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:55:07 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:55:07 INFO - Using env: {'DISPLAY': ':0', 08:55:07 INFO - 'HOME': '/home/cltbld', 08:55:07 INFO - 'LANG': 'en_US.UTF-8', 08:55:07 INFO - 'LANGUAGE': 'en_US:en', 08:55:07 INFO - 'LOGNAME': 'cltbld', 08:55:07 INFO - 'MAIL': '/var/mail/cltbld', 08:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:07 INFO - 'MOZ_NO_REMOTE': '1', 08:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:07 INFO - 'NO_EM_RESTART': '1', 08:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:07 INFO - 'PWD': '/builds/slave/test', 08:55:07 INFO - 'SHELL': '/bin/bash', 08:55:07 INFO - 'SHLVL': '1', 08:55:07 INFO - 'TERM': 'linux', 08:55:07 INFO - 'TMOUT': '86400', 08:55:07 INFO - 'USER': 'cltbld', 08:55:07 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:07 INFO - '_': '/tools/buildbot/bin/python'} 08:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:07 INFO - Running setup.py (path:/tmp/pip-OAB2uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:07 INFO - Running setup.py (path:/tmp/pip-lhbPGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:07 INFO - Running setup.py (path:/tmp/pip-aggyZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:07 INFO - Running setup.py (path:/tmp/pip-HgbeDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:07 INFO - Running setup.py (path:/tmp/pip-oooa1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:07 INFO - Running setup.py (path:/tmp/pip-bgYodm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:07 INFO - Running setup.py (path:/tmp/pip-q5JFOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:07 INFO - Running setup.py (path:/tmp/pip-lJjTkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:07 INFO - Running setup.py (path:/tmp/pip-clyJJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:07 INFO - Running setup.py (path:/tmp/pip-AZ4NYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:07 INFO - Running setup.py (path:/tmp/pip-h0bvVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:08 INFO - Running setup.py (path:/tmp/pip-Wf9QuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:08 INFO - Running setup.py (path:/tmp/pip-wjqAFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:08 INFO - Running setup.py (path:/tmp/pip-1m3Tbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:08 INFO - Running setup.py (path:/tmp/pip-ax4z9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:08 INFO - Running setup.py (path:/tmp/pip-GTggSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:08 INFO - Running setup.py (path:/tmp/pip-hEhDas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:55:08 INFO - Running setup.py install for manifestparser 08:55:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Running setup.py install for mozcrash 08:55:08 INFO - Running setup.py install for mozdebug 08:55:08 INFO - Running setup.py install for mozdevice 08:55:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Running setup.py install for mozfile 08:55:08 INFO - Running setup.py install for mozhttpd 08:55:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for mozinfo 08:55:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for mozInstall 08:55:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for mozleak 08:55:09 INFO - Running setup.py install for mozlog 08:55:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for moznetwork 08:55:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for mozprocess 08:55:09 INFO - Running setup.py install for mozprofile 08:55:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for mozrunner 08:55:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for mozscreenshot 08:55:10 INFO - Running setup.py install for moztest 08:55:10 INFO - Running setup.py install for mozversion 08:55:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:55:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:55:10 INFO - Cleaning up... 08:55:10 INFO - Return code: 0 08:55:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:10 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:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:10 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:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:10 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:55:10 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:55:10 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:55:10 INFO - Using env: {'DISPLAY': ':0', 08:55:10 INFO - 'HOME': '/home/cltbld', 08:55:10 INFO - 'LANG': 'en_US.UTF-8', 08:55:10 INFO - 'LANGUAGE': 'en_US:en', 08:55:10 INFO - 'LOGNAME': 'cltbld', 08:55:10 INFO - 'MAIL': '/var/mail/cltbld', 08:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:10 INFO - 'MOZ_NO_REMOTE': '1', 08:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:10 INFO - 'NO_EM_RESTART': '1', 08:55:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:10 INFO - 'PWD': '/builds/slave/test', 08:55:10 INFO - 'SHELL': '/bin/bash', 08:55:10 INFO - 'SHLVL': '1', 08:55:10 INFO - 'TERM': 'linux', 08:55:10 INFO - 'TMOUT': '86400', 08:55:10 INFO - 'USER': 'cltbld', 08:55:10 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:10 INFO - '_': '/tools/buildbot/bin/python'} 08:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:10 INFO - Running setup.py (path:/tmp/pip-gqaJ9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:10 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:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:10 INFO - Running setup.py (path:/tmp/pip-ATg09S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:10 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:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:10 INFO - Running setup.py (path:/tmp/pip-K2V2v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:10 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:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:10 INFO - Running setup.py (path:/tmp/pip-p9C8pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:10 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:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:10 INFO - Running setup.py (path:/tmp/pip-s4njIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:10 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:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:10 INFO - Running setup.py (path:/tmp/pip-K3cJC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:10 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:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:10 INFO - Running setup.py (path:/tmp/pip-GRRLTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:11 INFO - Running setup.py (path:/tmp/pip-OZrjOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:11 INFO - Running setup.py (path:/tmp/pip-3_10Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:11 INFO - Running setup.py (path:/tmp/pip-gCTryg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:11 INFO - Running setup.py (path:/tmp/pip-5Jn_R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:11 INFO - Running setup.py (path:/tmp/pip-dIzIHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:11 INFO - Running setup.py (path:/tmp/pip-TDmccx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:11 INFO - Running setup.py (path:/tmp/pip-8Zastn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:11 INFO - Running setup.py (path:/tmp/pip-qyR4Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:11 INFO - Running setup.py (path:/tmp/pip-ikDhwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:11 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:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:11 INFO - Running setup.py (path:/tmp/pip-Dx7RoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:11 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:55:11 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:55:11 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:55:11 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:55:11 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:55:11 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:55:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:55:11 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:55:11 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:55:11 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:55:11 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:55:11 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:55:11 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:55:13 INFO - Downloading blessings-1.6.tar.gz 08:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:55:13 INFO - Installing collected packages: blessings 08:55:13 INFO - Running setup.py install for blessings 08:55:14 INFO - Successfully installed blessings 08:55:14 INFO - Cleaning up... 08:55:14 INFO - Return code: 0 08:55:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:55:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:14 INFO - Reading from file tmpfile_stdout 08:55:14 INFO - Current package versions: 08:55:14 INFO - argparse == 1.2.1 08:55:14 INFO - blessings == 1.6 08:55:14 INFO - blobuploader == 1.2.4 08:55:14 INFO - docopt == 0.6.1 08:55:14 INFO - functools32 == 3.2.3-2 08:55:14 INFO - jsonschema == 2.5.1 08:55:14 INFO - manifestparser == 1.1 08:55:14 INFO - mozInstall == 1.12 08:55:14 INFO - mozcrash == 1.0 08:55:14 INFO - mozdebug == 0.1 08:55:14 INFO - mozdevice == 0.49 08:55:14 INFO - mozfile == 1.2 08:55:14 INFO - mozhttpd == 0.7 08:55:14 INFO - mozinfo == 0.9 08:55:14 INFO - mozleak == 0.1 08:55:14 INFO - mozlog == 3.4 08:55:14 INFO - moznetwork == 0.27 08:55:14 INFO - mozprocess == 0.25 08:55:14 INFO - mozprofile == 0.28 08:55:14 INFO - mozrunner == 6.13 08:55:14 INFO - mozscreenshot == 0.1 08:55:14 INFO - mozsystemmonitor == 0.3 08:55:14 INFO - moztest == 0.8 08:55:14 INFO - mozversion == 1.4 08:55:14 INFO - psutil == 3.1.1 08:55:14 INFO - requests == 1.2.3 08:55:14 INFO - wsgiref == 0.1.2 08:55:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:14 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:55:14 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:55:14 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:55:14 INFO - Using env: {'DISPLAY': ':0', 08:55:14 INFO - 'HOME': '/home/cltbld', 08:55:14 INFO - 'LANG': 'en_US.UTF-8', 08:55:14 INFO - 'LANGUAGE': 'en_US:en', 08:55:14 INFO - 'LOGNAME': 'cltbld', 08:55:14 INFO - 'MAIL': '/var/mail/cltbld', 08:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:14 INFO - 'MOZ_NO_REMOTE': '1', 08:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:14 INFO - 'NO_EM_RESTART': '1', 08:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:14 INFO - 'PWD': '/builds/slave/test', 08:55:14 INFO - 'SHELL': '/bin/bash', 08:55:14 INFO - 'SHLVL': '1', 08:55:14 INFO - 'TERM': 'linux', 08:55:14 INFO - 'TMOUT': '86400', 08:55:14 INFO - 'USER': 'cltbld', 08:55:14 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:14 INFO - '_': '/tools/buildbot/bin/python'} 08:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 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:55:14 INFO - Cleaning up... 08:55:14 INFO - Return code: 0 08:55:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2478a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d9310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, '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': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', '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:55:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:55:14 INFO - Using env: {'DISPLAY': ':0', 08:55:14 INFO - 'HOME': '/home/cltbld', 08:55:14 INFO - 'LANG': 'en_US.UTF-8', 08:55:14 INFO - 'LANGUAGE': 'en_US:en', 08:55:14 INFO - 'LOGNAME': 'cltbld', 08:55:14 INFO - 'MAIL': '/var/mail/cltbld', 08:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:14 INFO - 'MOZ_NO_REMOTE': '1', 08:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:14 INFO - 'NO_EM_RESTART': '1', 08:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:14 INFO - 'PWD': '/builds/slave/test', 08:55:14 INFO - 'SHELL': '/bin/bash', 08:55:14 INFO - 'SHLVL': '1', 08:55:14 INFO - 'TERM': 'linux', 08:55:14 INFO - 'TMOUT': '86400', 08:55:14 INFO - 'USER': 'cltbld', 08:55:14 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:14 INFO - '_': '/tools/buildbot/bin/python'} 08:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:55:14 INFO - Cleaning up... 08:55:14 INFO - Return code: 0 08:55:14 INFO - Running post-action listener: _resource_record_post_action 08:55:14 INFO - Running post-action listener: _start_resource_monitoring 08:55:14 INFO - Starting resource monitoring. 08:55:14 INFO - [mozharness: 2017-03-30 15:55:14.791853Z] Finished create-virtualenv step (success) 08:55:14 INFO - [mozharness: 2017-03-30 15:55:14.792359Z] Running install step. 08:55:14 INFO - Running pre-action listener: _resource_record_pre_action 08:55:14 INFO - Running main action method: install 08:55:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:14 INFO - Reading from file tmpfile_stdout 08:55:15 INFO - Detecting whether we're running mozinstall >=1.0... 08:55:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:55:15 INFO - Reading from file tmpfile_stdout 08:55:15 INFO - Output received: 08:55:15 INFO - Usage: mozinstall [options] installer 08:55:15 INFO - Options: 08:55:15 INFO - -h, --help show this help message and exit 08:55:15 INFO - -d DEST, --destination=DEST 08:55:15 INFO - Directory to install application into. [default: 08:55:15 INFO - "/builds/slave/test"] 08:55:15 INFO - --app=APP Application being installed. [default: firefox] 08:55:15 INFO - mkdir: /builds/slave/test/build/application 08:55:15 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:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:55:32 INFO - Reading from file tmpfile_stdout 08:55:32 INFO - Output received: 08:55:32 INFO - /builds/slave/test/build/application/firefox/firefox 08:55:32 INFO - Running post-action listener: _resource_record_post_action 08:55:32 INFO - [mozharness: 2017-03-30 15:55:32.041411Z] Finished install step (success) 08:55:32 INFO - [mozharness: 2017-03-30 15:55:32.041686Z] Running run-tests step. 08:55:32 INFO - Running pre-action listener: _resource_record_pre_action 08:55:32 INFO - Running main action method: run_tests 08:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:55:32 INFO - Python 2.7.3 08:55:32 INFO - Return code: 0 08:55:32 INFO - grabbing minidump binary from tooltool 08:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:32 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 0x26d6400>, '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 0x26d73b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d7840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:55:32 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:55:32 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:55:32 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:55:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:55:32 INFO - Return code: 0 08:55:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:55:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:55:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:55:32 INFO - ENV: RUST_BACKTRACE is now 1 08:55:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:55:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --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:55:32 INFO - Using env: {'DISPLAY': ':0', 08:55:32 INFO - 'HOME': '/home/cltbld', 08:55:32 INFO - 'LANG': 'en_US.UTF-8', 08:55:32 INFO - 'LANGUAGE': 'en_US:en', 08:55:32 INFO - 'LOGNAME': 'cltbld', 08:55:32 INFO - 'MAIL': '/var/mail/cltbld', 08:55:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:55:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:32 INFO - 'MOZ_NO_REMOTE': '1', 08:55:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:32 INFO - 'NO_EM_RESTART': '1', 08:55:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:32 INFO - 'PWD': '/builds/slave/test', 08:55:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:55:32 INFO - 'RUST_BACKTRACE': '1', 08:55:32 INFO - 'SHELL': '/bin/bash', 08:55:32 INFO - 'SHLVL': '1', 08:55:32 INFO - 'TERM': 'linux', 08:55:32 INFO - 'TMOUT': '86400', 08:55:32 INFO - 'USER': 'cltbld', 08:55:32 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343', 08:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:32 INFO - '_': '/tools/buildbot/bin/python'} 08:55:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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:55:32 INFO - mozversion application_buildid: 20170330145930 08:55:32 INFO - mozversion application_changeset: 3364cc17988c013c36f2a8123315db2855393011 08:55:32 INFO - mozversion application_display_name: Nightly 08:55:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:55:32 INFO - mozversion application_name: Firefox 08:55:32 INFO - mozversion application_remotingname: firefox 08:55:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:55:32 INFO - mozversion application_vendor: Mozilla 08:55:32 INFO - mozversion application_version: 55.0a1 08:55:32 INFO - mozversion platform_buildid: 20170330145930 08:55:32 INFO - mozversion platform_changeset: 3364cc17988c013c36f2a8123315db2855393011 08:55:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:55:32 INFO - mozversion platform_version: 55.0a1 08:55:32 INFO - using testdate: 1490889332 08:55:32 INFO - actual date: 1490889332 08:55:32 INFO - starting webserver on 'localhost:57218' 08:55:32 INFO - SUITE-START | Running 2 tests 08:55:32 INFO - TEST-START | dromaeo_css 08:55:32 INFO - operating with platform_type : linux_ 08:55:32 INFO - Initialising browser for dromaeo_css test... 08:55:32 INFO - TEST-INFO | started process 3977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Y5fP3/profile http://localhost:57218/getInfo.html) 08:55:36 INFO - PID 3977 | __metrics Screen width/height:1600/1200 08:55:36 INFO - PID 3977 | colorDepth:24 08:55:36 INFO - PID 3977 | Browser inner width/height: 1024/697 08:55:36 INFO - PID 3977 | __metrics 08:55:37 ERROR - PID 3977 | 1490889337045 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:55:37 INFO - PID 3977 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:55:37 INFO - PID 3977 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:38 INFO - TEST-INFO | 3977: exit 0 08:55:38 INFO - Browser initialized. 08:55:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:55:38 INFO - TEST-INFO | started process 4068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Y5fP3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:49 INFO - PID 4068 | RSS: Main: 144670720 08:55:49 INFO - PID 4068 | 08:58:52 INFO - PID 4068 | Cycle 1(1): loaded http://localhost:57218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57218/tests/dromaeo/cssquery-ext.html) 08:58:54 INFO - PID 4068 | RSS: Main: 306774016 08:58:54 INFO - PID 4068 | 09:00:39 INFO - PID 4068 | ************************* 09:00:39 INFO - PID 4068 | A coding exception was thrown and uncaught in a Task. 09:00:39 INFO - PID 4068 | 09:00:39 ERROR - PID 4068 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:00:39 INFO - PID 4068 | Full stack: 09:00:39 INFO - PID 4068 | ************************* 09:00:39 INFO - PID 4068 | ************************* 09:00:39 INFO - PID 4068 | A coding exception was thrown and uncaught in a Task. 09:00:39 INFO - PID 4068 | 09:00:39 ERROR - PID 4068 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:00:39 INFO - PID 4068 | Full stack: 09:00:39 INFO - PID 4068 | ************************* 09:00:39 INFO - PID 4068 | ************************* 09:00:39 INFO - PID 4068 | A coding exception was thrown and uncaught in a Task. 09:00:39 INFO - PID 4068 | 09:00:39 ERROR - PID 4068 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:00:39 INFO - PID 4068 | Full stack: 09:00:39 INFO - PID 4068 | ************************* 09:00:39 INFO - PID 4068 | ************************* 09:00:39 INFO - PID 4068 | A coding exception was thrown and uncaught in a Task. 09:00:39 INFO - PID 4068 | 09:00:39 ERROR - PID 4068 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:00:39 INFO - PID 4068 | Full stack: 09:00:39 INFO - PID 4068 | ************************* 09:01:56 INFO - PID 4068 | Cycle 1(1): loaded http://localhost:57218/tests/dromaeo/cssquery-ext.html (next: http://localhost:57218/tests/dromaeo/cssquery-jquery.html) 09:01:57 INFO - PID 4068 | RSS: Main: 242331648 09:01:57 INFO - PID 4068 | 09:04:59 INFO - PID 4068 | Cycle 1(1): loaded http://localhost:57218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57218/tests/dromaeo/cssquery-mootools.html) 09:04:59 INFO - PID 4068 | RSS: Main: 178454528 09:04:59 INFO - PID 4068 | 09:08:01 INFO - PID 4068 | Cycle 1(1): loaded http://localhost:57218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57218/tests/dromaeo/cssquery-prototype.html) 09:08:02 INFO - PID 4068 | RSS: Main: 179884032 09:08:02 INFO - PID 4068 | 09:11:05 INFO - PID 4068 | Cycle 1(1): loaded http://localhost:57218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57218/tests/dromaeo/cssquery-yui.html) 09:11:05 INFO - PID 4068 | RSS: Main: 186953728 09:11:05 INFO - PID 4068 | 09:14:08 INFO - PID 4068 | Cycle 1(1): loaded http://localhost:57218/tests/dromaeo/cssquery-yui.html (next: http://localhost:57218/tests/dromaeo/cssquery-dojo.html) 09:14:08 INFO - PID 4068 | RSS: Main: 272306176 09:14:08 INFO - PID 4068 | 09:14:08 INFO - PID 4068 | __start_tp_report 09:14:08 INFO - PID 4068 | _x_x_mozilla_page_load 09:14:08 INFO - PID 4068 | _x_x_mozilla_page_load_details 09:14:08 INFO - PID 4068 | |i|pagename|runs| 09:14:08 INFO - PID 4068 | |0;dojo.html;3370.0900756795663;3386.1703882548763;3405.1487128217955;3412.385770561298;3433.742469314802;5678.6024978251535;5766.0486019806785;5886.558508111887;5914.704264786759;5945.16767652529;5864.941350586493;5879.323877754059;5892.3518412974645;5941.28704555454;5971.343152253248;4931.630127740415;5082.593392528607;5104.310918026074;5203.869903252421;5274.841754747364;5262.973720124558;5314.229436731672;5319.228711836781;5323.547498462635;5356.625036247464;5033.874153146164;5097.980403919194;5106.310648062501;5215.322008138917;5246.134387826004;5255.553277971377;5275.261463395128;5303.893922121536;5336.332958380202;5347.59893008022;5192.091384007784;5244.239585260154;5253.133233016548;5267.914783731448;5310.893782124336;5646.435356464321;5743.856403589902;5866.589338746289;5871.060630299132;5880.059190529495;6147.600405973598;6271.529635277372;6340.968295158541;6346.777862774827;6347.87304253917;6419.711112999879;6425.678716064178;6431.871362572769;6436.324185960453;6445.291017988017;5869.559783016291;5953.642781433085;5969.104634304846;5970.522358211333;5975.701214939236;6159.692015399212;6259;6393.392627700361;6470.352964703586;6507.9023814642815;6007.639541627516;6057.394260573908;6070.453659170607;6173.41352571505;6203.131561581382;6239.75040998355;6336.619802811846;6359.109724638554;6359.650219237987;6359.9364006360265;6312.084747711556;6314.210723659543;6316.05259211122;6320.936790632127;6357;6139.416755408229;6144.938550614526;6229.53278504114;6344.175257216532;6359.236891573041;4796.9760151199025;4840.249761286936;4840.709557426566;4842.661013729005;4854.80580776765;4293.119910418357;4309.719868208556;4310.245707001262;4343.739375637472;4345.283028300295;5720.799772008043;5799.536037117021;5994.430529099728;5995.280566332068;5996.2504686914135;6120.873812997669;6276.780312689125;6349.079383489368;6355.586886852339;6394.328595497405;5934.940650593525;5964.433378829004;5983.252093488314;5998.820035398945;6034.366391528914;5416.295881535454;5419.430959749248;5422.078246698071;5426.538744206787;5426.972865135728;6298.086777417248;6359.046143078575;6408.775692850728;6426.132472116298;6428.228612566522;6157.138000679819;6169.907451388143;6177.6911154443;6177.752889884534;6203.16257305276;6649.567778094409;6673.132492775908;6706.497012724163;6709;6709.630970296681;6257.812265632038;6262.2172228471445;6263.718132683949;6263.718132684131;6266.060090986389;6095.024796032613;6367.745290188526;6368.840778980562;6369.948958421994;6371.458426033653;6061.636301821728;6145.631262124287;6146.938530614637;6170.5372097092;6185.103160041679;6141.201643786279;6148.938510614837;6152.907706384318;6156.78451254204;6159.322474527708;6144.262688477412;6149;6161.815145545641;6164.4143806338325;6175.2589689237575;5926.822195334147;5987.760489580368;6156.507479401547;6198.597091189058;6228.314885362697;6054.0918862169265;6073.180120683828;6075.908861366995;6076.088586712029;6081.483073938588 09:14:08 INFO - PID 4068 | |1;ext.html;655.2071992888605;737.030804492093;754.6717178027559;1120.5741818109118;1139.2708666453477;31326.53010204846;38914;39848.60151398489;39858.202835943266;39886.80056599713;42087.15825683492;42659.78670106645;42694.57305426945;42734.14531709364;42734.7863260684;6208.937910620881;6404.615723056631;8354.582270886447;8531.57342132894;8537.95731021344;8148.307393871499;8374.706885259016;8374.706885259016;8374.874376884321;8380.036295825998;8450.87323690145;8534.445261058043;8543.231109200171;8551.572421378938;8551.743447696548;8438.957805210965;8491.363147763912;8506.489610623321;8507.617157227878;8516.06323304436;8107.108218096005;8115.8782618260775;8141.796455088611;8155.184481551857;8165.591720414015;41419.37870931938;41625;41642.167156657;41720.79139604313;41863.581364186575;2964.762818974477;2981.522956326999;2984.447877142714;2999.1902186409548;3019.9849000755075;28375.71624283772;28517.572236416472;28533.57199642007;28957.71042289571;29323.70676293231;3512.3502152101687;3545.627709090534;3617.9095522611883;3620.8732694355836;3637.7271704621994;205515;205738.99999999852;205780;206723;206742;47675.52324476711;47797;47830.5216947833;47911.28133078007;47952;50364.748176259614;50705;50748.74625626848;50755.74622126939;50925.490745092815;14480.058796178215;14583.270836458347;14606.12363258208;14608.34262458192;14621.195834229007;9827.557759900821;9966.80066398668;10779.67660970172;11475.254108483088;11494.195406321478;14845.109293442429;15029.248537573078;15085.54743357701;15151.621209469851;15286.464973725866;5749.511291540266;5824.854378640568;5913.970430147821;5936.643801371932;6019.428154325332;1024.2983556263835;1038.8078205532001;1045.163868904873;1068.7808999155154;1077.2782235901964;25062.624060639104;25396.873015634803;25669.48661026769;25709;25969.22092337233;1137.2948771761396;1145.1297014269048;1155.1394211312627;1158.1487606609135;1158.1776938373848;12793.488260469478;13279.402426890812;13616.251106189255;16809;17643.382481613084;344013;344968;346043;346429;347619;60152.39847601556;60653.205285233395;60657.69671151616;60705;60875.39124608786;1373.4986729843536;1425.8788003019858;1431.6277767780452;1444.032498226191;1446.9421223151166;28318.292042699097;29602.851985739933;29802.403951921275;30478.542821858133;30600.39896608813;54055.459445405046;55134;55185.724071380995;55297.723511383796;55300.44699552953;336732;339528;340451;341356;342097;36493.27013459769;36611;36904.26191476209;37062.62937370592;37099;43826.561734382245;44547.76796204355;45883.770581146884;46016.7699161502;46172.769136155446;31748.841255793574;33293.83353083219;33502.83248583742;34026.489602656475;34750.304993900485;31923.68076319207;32846.835765821015;33220;33719.325613487104;34258.65741342555;38558.80720596379;38649.42025869558;38926.80536597412;39209.803950980066;39616.60383396244;30285;30455;31222;31395;32727.509087364186;24731.258062258163;25858.870705647103;25920.8703956479;26146.607800882623;26437 09:14:08 INFO - PID 4068 | |2;jquery.html;357.8622230441279;403.1312521516133;405.5478141871812;418.2930846868791;418.4831732809979;14394.280285985698;16201.75697364539;21506;21827.799471029106;22249;22205.888970555166;22471.66292505614;22551.09795608178;22636.773632263674;22769.658455123186;5883.176355310271;6039.7282122304605;6146.231721034871;6155.045967874987;6157.815265542041;3595.26297109092;3761.9059523511855;5935.169076329317;6033.668148251866;6146.938530614703;6149.046897730859;6178.320384757673;6178.443940045395;6179.629222246657;6182.103594978726;5945.910811337833;6030.577859549833;6073.4533891949495;6076.483498902554;6174;5404.216388623667;5406.459354064601;5419.83740487786;5422.078246698071;5463.043967305705;24657.137000204908;25040.49919001628;25394;25641.487170256678;25655.253778050934;1960.9607807843763;1961.7155512450615;1963.2539634938776;1994.840412766975;2012.5471768852037;15631.452899148475;16080.356785728556;16478.2584783685;16500.669986600322;16674.249658765384;1772.6986412309939;1842.1249906294536;1859.0890463672838;1878.7745470543487;1900.7243949627366;99772.50113749458;100734.49632751863;101516;101765.49117254441;104137.47931260371;11343.659690209306;11365.31808091517;11542.884571154182;11696.298222106701;11928.403579820973;15657.651352297247;15731.528054158394;15747.842521574867;15757.212139392985;15897.443589474313;8080.959595202104;8253.504789712517;8257.133001034925;8445.408821382443;8470.068292487822;7630.923690763132;7741.612919354123;7897.842043159219;7914.762557123296;7916.762497125095;7352.485326027234;7537.283958023979;7592.620368981528;7593.848123037508;7706.306432420997;2115.492281852375;2131.989340053321;2181.8363622728357;2188.9233876814556;2246;990.8662330585423;1006.1799633298838;1012.9493525323852;1027.3219675014454;1047.8585390972273;19644.410667679993;19746.40760777179;19800.306989255594;20012.89993550023;20354.694679579523;1043.7860238651058;1044.8014877173314;1048.2871647279771;1053.6891616973012;1059.7456610413444;10149.289549731595;10906.400147991779;10917.727056823644;10996.450177491093;11105.666829995112;617189;622356;622434;638934;646778;105191;105218;106434;106652;109114;1158.8841115888345;1185.9229150105216;1210.963671089851;1218.500414829933;1221.3832014832453;16063.704678188116;16705.83294167043;16976.745348820026;17022.2339994703;17162.313507459563;47857.52142478531;48647.62171404449;48873.26690099722;49956.50043499664;50345.74827125987;63471.6826415865;63962.68018659877;64417.67791161014;65695.67152164399;65752;9006.448034389641;9006.819863602823;9072.455652660861;9252.259819214582;9293.070692930653;14003.719925601226;14170.645733856736;14356.353964071433;14641.41434342657;15183.772243416137;12491.812622810483;12610.747785044432;12654.114212005072;12739.490420383081;12937.611871643865;11681.824772628588;11689.649310520697;11945;11983.76032479363;12395.380230988594;12096.455659495168;12126.878731212575;12629.87370126287;12963.351832408152;13092.476300947856;9038.819223615623;9086.863697044682;9105.590248438704;9298.302627302844;9303.627854886;12217.389130543259;12393.070519710878;12824.615261542169;13006.154599950973;13061.412236449192 09:14:08 INFO - PID 4068 | |3;mootools.html;1282.7562763075018;1347.555306748773;1348.5077946549507;1368.3637108744435;1374.8418931822844;10553.997370249823;11081.445927703613;11082.16883733719;11085.334879907192;11096.389698566576;10784.46077696116;10803.189760767935;10927.453627318622;10927.562897484091;10933.289336193142;2339.251439539348;2365.8698771567642;2380.3573035280465;2384.7496012918655;2389.940251493709;1958.6670266054734;2256.8194544436487;2338.5089131282452;2391;2394.4732158925094;2024.2004408258729;2275.9317220483413;2359.5988681924027;2362.5865473542062;2368.0882860098814;2282.760310167425;2342.437814924423;2351.8118550516;2355.8115350771895;2359.905603775847;1910.8184722451344;1973.6348775476583;2220.9000594973104;2287.9885600571893;2298.528801595669;11066.778664426747;11113.555457781678;11132.944335278271;11134.665960021212;11153.553857845758;5912.438318359749;6183.258009038899;6186.443220110166;6187.752489900398;6193.907091393633;3683.9079023024638;3754.9061273468383;3821.9044523886846;3835.2137811748526;3870.825812838401;1308.5812539987207;1312.4553310376182;1326.7147563273943;1358.4090920449637;1364.1474078700812;15064.623384415478;15118.09291442517;16028.679426411523;16441.095739734308;16458.341666333334;4913;5023.095842748267;5096.770645320896;5147.047796157723;5150.8969820604125;12216.144869859203;12220.388980550937;12240.326782026896;12256.142070055188;12345.814812777815;6055.091736239599;6064.575479716465;6071.848203794852;6086.421789929949;6109.358517355702;5557.527610153102;5652.321721393377;5660.575456840671;5735.77056917727;5754.338251101093;4083.7549747015273;4098.174977593485;4129.29801933672;4130.958690413117;4171.749695018248;1121.955121795119;1131.7114135895458;1146.48408216303;1154.1343992005995;1156.1329003247565;819.5779173725537;820.5897051474263;837.3371295252715;856.5075081827974;857.498363457372;6004.219451471281;6117.082437634391;6138.294096178907;6173.135760993465;6405.35946405365;568.3833041150398;571.4428432278495;577.8670905691714;587.529976019183;596.4155127974609;3960.2277555876904;4175.603317684815;4350.347447882779;4370.650347972155;4415.62467190286;14157.787633185511;14643.707125857423;14652.267386630625;14668;14687;14052.437902483785;14462.710745785236;14533.128012319296;14731.33708983077;14741.00996365477;10418.385150301716;10623.150147987988;10628.46857657114;10654.840177397346;10670.466476676134;6320.462760665395;6536.627308265128;6647.667616619053;6787.592744435349;6815.284395138439;12819.230846149261;12862.163959342613;12933.03002274852;12952.158109722837;13093.399315188399;13085.607431777062;13149.671258218621;13184.143030702973;13212.471501140231;13302.40139193758;9281.628734850801;9448.48033358172;9451.291153163404;9459.38513996588;9625.374350667184;10343.793124137324;10391.168706503311;10457.16342692598;10464;10542.789144217226;8716.825663486821;8796.252318552995;8818.823623527365;8936.955315223382;8987.101289870961;8559.186877246651;8618.78453038679;8661.263792577702;8706.956465217634;8786.384953053224;7906.446548741533;7952.443328966917;8004.679812807422;8103.068147162916;8107.594620269081;5929.673867937305;5950.5239580834295;6055.2430946131735;6251.124842521959;6279.2464904209955;6062.636241825505;6105.389461053859;6112.877742445037;6243.687815609293;6366.904496432465 09:14:08 INFO - PID 4068 | |4;prototype.html;397.7812203288192;401.11554023378454;401.44600451377096;401.74890693316695;401.76295985368637;5917.757270973096;5920.4671579557835;5960.64236145831;5998.820035398945;5999.790007349744;5651.191618682024;5808.2449281593335;5815.73829177687;5830.4169583041785;5855.268091488564;4577.336286238502;4586.578160770172;4588.8298483886565;4591.071749865065;4606.56237657422;4611.515790841963;4612.677112602119;4615.723056616614;4620.1221767864;4626.352310676508;4278.422412974255;4453.888652783674;4454.777261136946;4458.1306645204195;4607;4451.198784218839;4452.354408610766;4464.709793863421;4466;4473.060657261979;3920.294347017564;3925.528936527635;3942.6057394260633;3948.368261078214;3948.506436695413;5445.673259604437;5656.858578535528;5691.971540142315;5701.857453563694;5704.1443783432405;5178.40448348441;5179.352580927384;5183.403908550527;5185.325907632021;5200.29795977542;6130.448259656608;6145.692715364214;6151.907721384183;6155.938440615581;6201.286852011986;4417.757023363713;4566.45202575693;4593.931091033637;4601.332806743037;4633.536646335339;6165.229346331708;6361.173047503795;6460.192475940507;6567.376099270562;6578.440832529241;4347.500037495728;4540.228161212602;4545.931811022837;4561.863144105682;4562.361269422284;4613.308003799457;4786.688865223749;4799.5601319603975;4800.639952003614;4811.4707382187935;5350.224217488442;5353.57171426285;5375.704336261543;5376.731163441812;5380.973095134499;5987.317799553243;6196.504279657616;6258.311585725566;6283.08895210192;6288.213973253343;1664.991675041617;1664.991675041617;1665.76679264903;1668.449411694138;1668.8581470575136;1117.5082963496036;1172.2263306217856;1181.9822702659467;1183.8401815754935;1185.1230089733535;6009.729562169713;6016.879662406727;6021.157038014681;6023.2772067351325;6023.728932198062;6291;6341.651209183447;6372.776952806629;6375.5017570870805;6395.936040639627;5742.54059675225;5910.734016969161;5913.704314784243;5914.9112763308585;5956.55325850563;3310.7682462227895;3339.699427051577;3365.360581489509;3393.8642454302044;3394.7114495267683;6439.903401448982;6737.831554211184;6751.831204219934;6753.3246675332075;6756.797296081126;6565.376289252514;6567.179102612174;6577.934220657828;6588.571742836701;6592.637404942679;6447.3552644735155;6662.900621397415;6687.063811066358;6720.126383570105;6735.494837887178;6360.395762402564;6362.409397650587;6362.427381535684;6378.170837791057;6393.808185754435;6167.378863982879;6294.779682711083;6322.683865806784;6345.302016778059;6361.586496877688;6702.798916032527;6735.6295403753265;6746.392824645805;6749.797506074826;6765.526413151032;4474.865754027384;4476.955230447654;4480.731156130642;4490.169318676056;4491.169133710274;6323.620582765049;6370.745170193326;6440.710168042543;6444.774432895014;6453.225612926291;6174.919389106799;6179.969100154651;6186.566940314135;6220.937790622036;6223.128761973237;6043.153958445909;6177.752889884354;6185.824318995317;6208.596441231305;6232.844178895564;6157.938420615916;6183.103449999635;6194.721237544231;6194.907076393768;6207.317195108625;6168.907466387918;6216.880961426987;6262.123302737529;6273.902067138324;6275.811725648238;5856.648601083949;6005.759769609167;6012.1582978382185;6032.939670603413;6047.969760151171 09:14:08 INFO - PID 4068 | |5;yui.html;765.544501021892;781.2812212764256;784.1061190243124;787.6888628991545;801.8997625296835;16367.918160409195;16651.417200397987;16676.499705008868;16713.916430417863;16724.498265052054;15874.444394446196;15967.201639918016;15998.120103394309;16046.1174635395;16052.43816466424;931.8136372725448;956.3879117364858;984.4339504784778;989.4557993103764;995.437577768562;982.6266018912803;983.6409710455667;983.7786498037956;984.2421335571605;986.9259805514579;1034.3276870034463;1038.185024755567;1038.6883934819562;1039.132324509036;1039.1478987230473;1027.7327894747382;1029;1032.3702541449709;1032.664384075175;1035.7410647338165;752.2289653105556;757.7802437293178;757.8029712274848;758.0940775772954;759.3204082346269;16414.589635259093;16443.58891027734;16608.418705345375;16850.915745421316;17068.2319295632;15065.171415572138;15066.623334416618;15079.773803392958;15342.539723808304;15562.922185389114;12333.444994975158;12423.31671758053;12663.366831658472;12663.366831658472;12784.360781960957;2880.74073333401;2935.8825646974096;3020.1845501714633;3039.7112274333904;3045.5888455058507;85128;85637.57181214116;86694;87398.12601873964;88125.55937220337;11016.504257308441;11092.500837462172;11384.943075284737;11636.12729045325;12053.457594408274;24055.759442405702;24986.250412487654;25019.249422517354;25173.496530069297;25416.618750718753;8244.014079262884;8246.257836794717;8324.958375208085;8406.327493800482;8619.61211745473;3991.840326386912;4025.134596061861;4139.834406623701;4159.563245859202;4200.201961627281;3598.1184609770776;3630.5098811660614;3633.981830090833;3638.8544458221904;3662.1027848176836;840.6133178737726;842.1241908415302;854.0818619983543;864.2653744317406;868.301017680773;616.7687117331001;624.9218847644045;630.895902176145;632.6552029144127;633.1168020611221;10248.64129755455;10977.012068913837;11051.889481105247;11060.778784424427;11255.66233013011;618.4588485075559;644.577801539992;648.0861984601689;653.31075715121;653.7744478155029;4348.565143485626;4692.700576717384;5317.230177473524;5554.972225138848;5726.828195154152;72700.63942646558;73664;79151.60424197957;83266;83352.16647833565;62382.37617623856;62786.372136278966;63097;63178.68410658009;64354.6782266095;60035.69982150061;60424.697876510334;61399.386006139364;61633.44575297215;62331;11391.829122563335;11658.300501969909;11670.94164529172;11744.647660570197;11758.470868811095;31376.68623313829;32657.020289391356;33092.1726956828;33157.83947561824;33650.32699346048;53277.200841986625;53825.19262210991;53858;54337;55457;13405.91460889435;13534.526291579747;13569.1858488491;13605.79591306151;14020.088694234842;15406.845931540542;15425.460108896135;15548.766768498255;15551.688966220838;15873.761893571836;13661.726765464833;13705.862941370458;13922.791158132839;14122.43510259578;14583.197924114276;14480.710385792436;14527.491537796126;14974.700505990037;15154.772678409612;15342.846571534143;13761.17432954026;13858.930705346409;13860.722785544434;14066.156030638194;14084.577462676136;10085.486218389708;10213.642522511676;10448.582056717647;10520.15838732915;10995.615153469591;10868.239223254297;11410.535329347042;11475;11935.343556104497;12391.318477483825 09:14:08 INFO - PID 4068 | __end_tp_report 09:14:08 INFO - PID 4068 | __start_cc_report 09:14:08 INFO - PID 4068 | _x_x_mozilla_cycle_collect,1720 09:14:08 INFO - PID 4068 | __end_cc_report 09:14:08 INFO - PID 4068 | __startTimestamp1490890448725__endTimestamp 09:14:08 INFO - PID 4068 | 09:14:08 INFO - PID 4068 | ------- Summary: start ------- 09:14:08 INFO - PID 4068 | Number of tests: 6 09:14:08 INFO - PID 4068 | 09:14:08 INFO - PID 4068 | [#0] dojo.html Cycles:165 Average:5828.08 Median:6073.18 stddev:681.25 (11.2%) stddev-sans-first:655.48 09:14:08 INFO - PID 4068 | Values: 3370.1 3386.2 3405.1 3412.4 3433.7 5678.6 5766.0 5886.6 5914.7 5945.2 5864.9 5879.3 5892.4 5941.3 5971.3 4931.6 5082.6 5104.3 5203.9 5274.8 5263.0 5314.2 5319.2 5323.5 5356.6 5033.9 5098.0 5106.3 5215.3 5246.1 5255.6 5275.3 5303.9 5336.3 5347.6 5192.1 5244.2 5253.1 5267.9 5310.9 5646.4 5743.9 5866.6 5871.1 5880.1 6147.6 6271.5 6341.0 6346.8 6347.9 6419.7 6425.7 6431.9 6436.3 6445.3 5869.6 5953.6 5969.1 5970.5 5975.7 6159.7 6259.0 6393.4 6470.4 6507.9 6007.6 6057.4 6070.5 6173.4 6203.1 6239.8 6336.6 6359.1 6359.7 6359.9 6312.1 6314.2 6316.1 6320.9 6357.0 6139.4 6144.9 6229.5 6344.2 6359.2 4797.0 4840.2 4840.7 4842.7 4854.8 4293.1 4309.7 4310.2 4343.7 4345.3 5720.8 5799.5 5994.4 5995.3 5996.3 6120.9 6276.8 6349.1 6355.6 6394.3 5934.9 5964.4 5983.3 5998.8 6034.4 5416.3 5419.4 5422.1 5426.5 5427.0 6298.1 6359.0 6408.8 6426.1 6428.2 6157.1 6169.9 6177.7 6177.8 6203.2 6649.6 6673.1 6706.5 6709.0 6709.6 6257.8 6262.2 6263.7 6263.7 6266.1 6095.0 6367.7 6368.8 6369.9 6371.5 6061.6 6145.6 6146.9 6170.5 6185.1 6141.2 6148.9 6152.9 6156.8 6159.3 6144.3 6149.0 6161.8 6164.4 6175.3 5926.8 5987.8 6156.5 6198.6 6228.3 6054.1 6073.2 6075.9 6076.1 6081.5 09:14:08 INFO - PID 4068 | 09:14:08 INFO - PID 4068 | [#1] ext.html Cycles:180 Average:46400.65 Median:175565.68 stddev:79993.44 (45.6%) stddev-sans-first:80144.10 09:14:08 INFO - PID 4068 | Values: 655.2 737.0 754.7 1120.6 1139.3 31326.5 38914.0 39848.6 39858.2 39886.8 42087.2 42659.8 42694.6 42734.1 42734.8 6208.9 6404.6 8354.6 8531.6 8538.0 8148.3 8374.7 8374.7 8374.9 8380.0 8450.9 8534.4 8543.2 8551.6 8551.7 8439.0 8491.4 8506.5 8507.6 8516.1 8107.1 8115.9 8141.8 8155.2 8165.6 41419.4 41625.0 41642.2 41720.8 41863.6 2964.8 2981.5 2984.4 2999.2 3020.0 28375.7 28517.6 28533.6 28957.7 29323.7 3512.4 3545.6 3617.9 3620.9 3637.7 205515.0 205739.0 205780.0 206723.0 206742.0 47675.5 47797.0 47830.5 47911.3 47952.0 50364.7 50705.0 50748.7 50755.7 50925.5 14480.1 14583.3 14606.1 14608.3 14621.2 9827.6 9966.8 10779.7 11475.3 11494.2 14845.1 15029.2 15085.5 15151.6 15286.5 5749.5 5824.9 5914.0 5936.6 6019.4 1024.3 1038.8 1045.2 1068.8 1077.3 25062.6 25396.9 25669.5 25709.0 25969.2 1137.3 1145.1 1155.1 1158.1 1158.2 12793.5 13279.4 13616.3 16809.0 17643.4 344013.0 344968.0 346043.0 346429.0 347619.0 60152.4 60653.2 60657.7 60705.0 60875.4 1373.5 1425.9 1431.6 1444.0 1446.9 28318.3 29602.9 29802.4 30478.5 30600.4 54055.5 55134.0 55185.7 55297.7 55300.4 336732.0 339528.0 340451.0 341356.0 342097.0 36493.3 36611.0 36904.3 37062.6 37099.0 43826.6 44547.8 45883.8 46016.8 46172.8 31748.8 33293.8 33502.8 34026.5 34750.3 31923.7 32846.8 33220.0 33719.3 34258.7 38558.8 38649.4 38926.8 39209.8 39616.6 30285.0 30455.0 31222.0 31395.0 32727.5 24731.3 25858.9 25920.9 26146.6 26437.0 09:14:08 INFO - PID 4068 | 09:14:08 INFO - PID 4068 | [#2] jquery.html Cycles:180 Average:34845.80 Median:2123.74 stddev:103748.69 (4885.2%) stddev-sans-first:104007.42 09:14:08 INFO - PID 4068 | Values: 357.9 403.1 405.5 418.3 418.5 14394.3 16201.8 21506.0 21827.8 22249.0 22205.9 22471.7 22551.1 22636.8 22769.7 5883.2 6039.7 6146.2 6155.0 6157.8 3595.3 3761.9 5935.2 6033.7 6146.9 6149.0 6178.3 6178.4 6179.6 6182.1 5945.9 6030.6 6073.5 6076.5 6174.0 5404.2 5406.5 5419.8 5422.1 5463.0 24657.1 25040.5 25394.0 25641.5 25655.3 1961.0 1961.7 1963.3 1994.8 2012.5 15631.5 16080.4 16478.3 16500.7 16674.2 1772.7 1842.1 1859.1 1878.8 1900.7 99772.5 100734.5 101516.0 101765.5 104137.5 11343.7 11365.3 11542.9 11696.3 11928.4 15657.7 15731.5 15747.8 15757.2 15897.4 8081.0 8253.5 8257.1 8445.4 8470.1 7630.9 7741.6 7897.8 7914.8 7916.8 7352.5 7537.3 7592.6 7593.8 7706.3 2115.5 2132.0 2181.8 2188.9 2246.0 990.9 1006.2 1012.9 1027.3 1047.9 19644.4 19746.4 19800.3 20012.9 20354.7 1043.8 1044.8 1048.3 1053.7 1059.7 10149.3 10906.4 10917.7 10996.5 11105.7 617189.0 622356.0 622434.0 638934.0 646778.0 105191.0 105218.0 106434.0 106652.0 109114.0 1158.9 1185.9 1211.0 1218.5 1221.4 16063.7 16705.8 16976.7 17022.2 17162.3 47857.5 48647.6 48873.3 49956.5 50345.7 63471.7 63962.7 64417.7 65695.7 65752.0 9006.4 9006.8 9072.5 9252.3 9293.1 14003.7 14170.6 14356.4 14641.4 15183.8 12491.8 12610.7 12654.1 12739.5 12937.6 11681.8 11689.6 11945.0 11983.8 12395.4 12096.5 12126.9 12629.9 12963.4 13092.5 9038.8 9086.9 9105.6 9298.3 9303.6 12217.4 12393.1 12824.6 13006.2 13061.4 09:14:08 INFO - PID 4068 | 09:14:08 INFO - PID 4068 | [#3] mootools.html Cycles:180 Average:6918.79 Median:2382.55 stddev:4432.78 (186.1%) stddev-sans-first:4424.98 09:14:08 INFO - PID 4068 | Values: 1282.8 1347.6 1348.5 1368.4 1374.8 10554.0 11081.4 11082.2 11085.3 11096.4 10784.5 10803.2 10927.5 10927.6 10933.3 2339.3 2365.9 2380.4 2384.7 2389.9 1958.7 2256.8 2338.5 2391.0 2394.5 2024.2 2275.9 2359.6 2362.6 2368.1 2282.8 2342.4 2351.8 2355.8 2359.9 1910.8 1973.6 2220.9 2288.0 2298.5 11066.8 11113.6 11132.9 11134.7 11153.6 5912.4 6183.3 6186.4 6187.8 6193.9 3683.9 3754.9 3821.9 3835.2 3870.8 1308.6 1312.5 1326.7 1358.4 1364.1 15064.6 15118.1 16028.7 16441.1 16458.3 4913.0 5023.1 5096.8 5147.0 5150.9 12216.1 12220.4 12240.3 12256.1 12345.8 6055.1 6064.6 6071.8 6086.4 6109.4 5557.5 5652.3 5660.6 5735.8 5754.3 4083.8 4098.2 4129.3 4131.0 4171.7 1122.0 1131.7 1146.5 1154.1 1156.1 819.6 820.6 837.3 856.5 857.5 6004.2 6117.1 6138.3 6173.1 6405.4 568.4 571.4 577.9 587.5 596.4 3960.2 4175.6 4350.3 4370.7 4415.6 14157.8 14643.7 14652.3 14668.0 14687.0 14052.4 14462.7 14533.1 14731.3 14741.0 10418.4 10623.2 10628.5 10654.8 10670.5 6320.5 6536.6 6647.7 6787.6 6815.3 12819.2 12862.2 12933.0 12952.2 13093.4 13085.6 13149.7 13184.1 13212.5 13302.4 9281.6 9448.5 9451.3 9459.4 9625.4 10343.8 10391.2 10457.2 10464.0 10542.8 8716.8 8796.3 8818.8 8937.0 8987.1 8559.2 8618.8 8661.3 8707.0 8786.4 7906.4 7952.4 8004.7 8103.1 8107.6 5929.7 5950.5 6055.2 6251.1 6279.2 6062.6 6105.4 6112.9 6243.7 6366.9 09:14:08 INFO - PID 4068 | 09:14:08 INFO - PID 4068 | [#4] prototype.html Cycles:180 Average:5235.64 Median:5919.11 stddev:1536.71 (26.0%) stddev-sans-first:1497.51 09:14:08 INFO - PID 4068 | Values: 397.8 401.1 401.4 401.7 401.8 5917.8 5920.5 5960.6 5998.8 5999.8 5651.2 5808.2 5815.7 5830.4 5855.3 4577.3 4586.6 4588.8 4591.1 4606.6 4611.5 4612.7 4615.7 4620.1 4626.4 4278.4 4453.9 4454.8 4458.1 4607.0 4451.2 4452.4 4464.7 4466.0 4473.1 3920.3 3925.5 3942.6 3948.4 3948.5 5445.7 5656.9 5692.0 5701.9 5704.1 5178.4 5179.4 5183.4 5185.3 5200.3 6130.4 6145.7 6151.9 6155.9 6201.3 4417.8 4566.5 4593.9 4601.3 4633.5 6165.2 6361.2 6460.2 6567.4 6578.4 4347.5 4540.2 4545.9 4561.9 4562.4 4613.3 4786.7 4799.6 4800.6 4811.5 5350.2 5353.6 5375.7 5376.7 5381.0 5987.3 6196.5 6258.3 6283.1 6288.2 1665.0 1665.0 1665.8 1668.4 1668.9 1117.5 1172.2 1182.0 1183.8 1185.1 6009.7 6016.9 6021.2 6023.3 6023.7 6291.0 6341.7 6372.8 6375.5 6395.9 5742.5 5910.7 5913.7 5914.9 5956.6 3310.8 3339.7 3365.4 3393.9 3394.7 6439.9 6737.8 6751.8 6753.3 6756.8 6565.4 6567.2 6577.9 6588.6 6592.6 6447.4 6662.9 6687.1 6720.1 6735.5 6360.4 6362.4 6362.4 6378.2 6393.8 6167.4 6294.8 6322.7 6345.3 6361.6 6702.8 6735.6 6746.4 6749.8 6765.5 4474.9 4477.0 4480.7 4490.2 4491.2 6323.6 6370.7 6440.7 6444.8 6453.2 6174.9 6180.0 6186.6 6220.9 6223.1 6043.2 6177.8 6185.8 6208.6 6232.8 6157.9 6183.1 6194.7 6194.9 6207.3 6168.9 6216.9 6262.1 6273.9 6275.8 5856.6 6005.8 6012.2 6032.9 6048.0 09:14:08 INFO - PID 4068 | 09:14:08 INFO - PID 4068 | [#5] yui.html Cycles:180 Average:17730.34 Median:2908.31 stddev:22253.70 (765.2%) stddev-sans-first:22279.66 09:14:08 INFO - PID 4068 | Values: 765.5 781.3 784.1 787.7 801.9 16367.9 16651.4 16676.5 16713.9 16724.5 15874.4 15967.2 15998.1 16046.1 16052.4 931.8 956.4 984.4 989.5 995.4 982.6 983.6 983.8 984.2 986.9 1034.3 1038.2 1038.7 1039.1 1039.1 1027.7 1029.0 1032.4 1032.7 1035.7 752.2 757.8 757.8 758.1 759.3 16414.6 16443.6 16608.4 16850.9 17068.2 15065.2 15066.6 15079.8 15342.5 15562.9 12333.4 12423.3 12663.4 12663.4 12784.4 2880.7 2935.9 3020.2 3039.7 3045.6 85128.0 85637.6 86694.0 87398.1 88125.6 11016.5 11092.5 11384.9 11636.1 12053.5 24055.8 24986.3 25019.2 25173.5 25416.6 8244.0 8246.3 8325.0 8406.3 8619.6 3991.8 4025.1 4139.8 4159.6 4200.2 3598.1 3630.5 3634.0 3638.9 3662.1 840.6 842.1 854.1 864.3 868.3 616.8 624.9 630.9 632.7 633.1 10248.6 10977.0 11051.9 11060.8 11255.7 618.5 644.6 648.1 653.3 653.8 4348.6 4692.7 5317.2 5555.0 5726.8 72700.6 73664.0 79151.6 83266.0 83352.2 62382.4 62786.4 63097.0 63178.7 64354.7 60035.7 60424.7 61399.4 61633.4 62331.0 11391.8 11658.3 11670.9 11744.6 11758.5 31376.7 32657.0 33092.2 33157.8 33650.3 53277.2 53825.2 53858.0 54337.0 55457.0 13405.9 13534.5 13569.2 13605.8 14020.1 15406.8 15425.5 15548.8 15551.7 15873.8 13661.7 13705.9 13922.8 14122.4 14583.2 14480.7 14527.5 14974.7 15154.8 15342.8 13761.2 13858.9 13860.7 14066.2 14084.6 10085.5 10213.6 10448.6 10520.2 10995.6 10868.2 11410.5 11475.0 11935.3 12391.3 09:14:08 INFO - PID 4068 | -------- Summary: end -------- 09:14:08 INFO - PID 4068 | 09:14:09 INFO - TEST-INFO | 4068: exit 0 09:14:09 INFO - TEST-OK | dromaeo_css | took 1117233ms 09:14:09 INFO - TEST-START | kraken 09:14:09 INFO - operating with platform_type : linux_ 09:14:09 INFO - Initialising browser for kraken test... 09:14:09 INFO - TEST-INFO | started process 4391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE_sIFl/profile http://localhost:57218/getInfo.html) 09:14:13 INFO - PID 4391 | __metrics Screen width/height:1600/1200 09:14:13 INFO - PID 4391 | colorDepth:24 09:14:13 INFO - PID 4391 | Browser inner width/height: 1024/697 09:14:13 INFO - PID 4391 | __metrics 09:14:14 ERROR - PID 4391 | 1490890454309 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 09:14:14 INFO - PID 4391 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:14:14 INFO - PID 4391 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:15 INFO - TEST-INFO | 4391: exit 0 09:14:15 INFO - Browser initialized. 09:14:15 INFO - Running cycle 1/1 for kraken test... 09:14:15 INFO - TEST-INFO | started process 4483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE_sIFl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:27 INFO - PID 4483 | RSS: Main: 144687104 09:14:27 INFO - PID 4483 | 09:14:29 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57218/tests/kraken/driver.html?testName=audio-beat-detection) 09:14:30 INFO - PID 4483 | RSS: Main: 200830976 09:14:30 INFO - PID 4483 | 09:14:33 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57218/tests/kraken/driver.html?testName=audio-dft) 09:14:33 INFO - PID 4483 | RSS: Main: 182722560 09:14:33 INFO - PID 4483 | 09:14:36 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57218/tests/kraken/driver.html?testName=audio-fft) 09:14:37 INFO - PID 4483 | RSS: Main: 262500352 09:14:37 INFO - PID 4483 | 09:14:39 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57218/tests/kraken/driver.html?testName=audio-oscillator) 09:14:40 INFO - PID 4483 | RSS: Main: 173039616 09:14:40 INFO - PID 4483 | 09:14:42 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:14:42 INFO - PID 4483 | RSS: Main: 177287168 09:14:42 INFO - PID 4483 | 09:14:46 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57218/tests/kraken/driver.html?testName=imaging-darkroom) 09:14:46 INFO - PID 4483 | RSS: Main: 216272896 09:14:46 INFO - PID 4483 | 09:14:50 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57218/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:50 INFO - PID 4483 | RSS: Main: 211001344 09:14:50 INFO - PID 4483 | 09:14:53 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57218/tests/kraken/driver.html?testName=json-parse-financial) 09:14:54 INFO - PID 4483 | RSS: Main: 214335488 09:14:54 INFO - PID 4483 | 09:14:55 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:56 INFO - PID 4483 | RSS: Main: 176889856 09:14:56 INFO - PID 4483 | 09:14:58 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57218/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:58 INFO - PID 4483 | RSS: Main: 182353920 09:14:58 INFO - PID 4483 | 09:15:00 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:15:01 INFO - PID 4483 | RSS: Main: 193503232 09:15:01 INFO - PID 4483 | 09:15:04 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:15:04 INFO - PID 4483 | RSS: Main: 202215424 09:15:04 INFO - PID 4483 | 09:15:07 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:15:08 INFO - PID 4483 | RSS: Main: 198422528 09:15:08 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | Cycle 1(1): loaded http://localhost:57218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57218/tests/kraken/driver.html?testName=ai-astar) 09:15:10 INFO - PID 4483 | RSS: Main: 267669504 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | __start_tp_report 09:15:10 INFO - PID 4483 | _x_x_mozilla_page_load 09:15:10 INFO - PID 4483 | _x_x_mozilla_page_load_details 09:15:10 INFO - PID 4483 | |i|pagename|runs| 09:15:10 INFO - PID 4483 | |0;ai-astar;100;109;111;110;109;108;109;108;108;110 09:15:10 INFO - PID 4483 | |1;audio-beat-detection;149;118;118;157;118;118;119;120;146;118 09:15:10 INFO - PID 4483 | |2;audio-dft;163;165;163;164;165;164;164;163;163;166 09:15:10 INFO - PID 4483 | |3;audio-fft;74;76;75;106;77;74;77;74;89;76 09:15:10 INFO - PID 4483 | |4;audio-oscillator;84;85;117;85;85;84;97;84;84;107 09:15:10 INFO - PID 4483 | |5;imaging-gaussian-blur;114;113;113;113;114;113;114;114;114;115 09:15:10 INFO - PID 4483 | |6;imaging-darkroom;148;149;148;149;149;149;148;149;148;148 09:15:10 INFO - PID 4483 | |7;imaging-desaturate;95;95;94;95;94;94;95;95;94;94 09:15:10 INFO - PID 4483 | |8;json-parse-financial;58;57;57;56;58;59;58;58;58;58 09:15:10 INFO - PID 4483 | |9;json-stringify-tinderbox;54;54;54;55;54;54;55;54;55;55 09:15:10 INFO - PID 4483 | |10;stanford-crypto-aes;82;81;80;80;93;82;81;81;82;82 09:15:10 INFO - PID 4483 | |11;stanford-crypto-ccm;127;135;130;128;147;128;127;135;182;128 09:15:10 INFO - PID 4483 | |12;stanford-crypto-pbkdf2;184;181;183;177;182;185;186;187;184;186 09:15:10 INFO - PID 4483 | |13;stanford-crypto-sha256-iterative;68;65;65;65;69;66;67;65;64;64 09:15:10 INFO - PID 4483 | __end_tp_report 09:15:10 INFO - PID 4483 | __start_cc_report 09:15:10 INFO - PID 4483 | _x_x_mozilla_cycle_collect,1723 09:15:10 INFO - PID 4483 | __end_cc_report 09:15:10 INFO - PID 4483 | __startTimestamp1490890510515__endTimestamp 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | ------- Summary: start ------- 09:15:10 INFO - PID 4483 | Number of tests: 14 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:3.05 (2.8%) stddev-sans-first:1.05 09:15:10 INFO - PID 4483 | Values: 100.0 109.0 111.0 110.0 109.0 108.0 109.0 108.0 108.0 110.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:119.50 stddev:15.81 (13.2%) stddev-sans-first:14.86 09:15:10 INFO - PID 4483 | Values: 149.0 118.0 118.0 157.0 118.0 118.0 119.0 120.0 146.0 118.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:1.05 (0.6%) stddev-sans-first:1.05 09:15:10 INFO - PID 4483 | Values: 163.0 165.0 163.0 164.0 165.0 164.0 164.0 163.0 163.0 166.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#3] audio-fft Cycles:10 Average:79.80 Median:76.00 stddev:10.22 (13.4%) stddev-sans-first:10.62 09:15:10 INFO - PID 4483 | Values: 74.0 76.0 75.0 106.0 77.0 74.0 77.0 74.0 89.0 76.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:84.50 stddev:11.89 (14.1%) stddev-sans-first:12.32 09:15:10 INFO - PID 4483 | Values: 84.0 85.0 117.0 85.0 85.0 84.0 97.0 84.0 84.0 107.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:15:10 INFO - PID 4483 | Values: 114.0 113.0 113.0 113.0 114.0 113.0 114.0 114.0 114.0 115.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:15:10 INFO - PID 4483 | Values: 148.0 149.0 148.0 149.0 149.0 149.0 148.0 149.0 148.0 148.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:15:10 INFO - PID 4483 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 09:15:10 INFO - PID 4483 | Values: 58.0 57.0 57.0 56.0 58.0 59.0 58.0 58.0 58.0 58.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 09:15:10 INFO - PID 4483 | Values: 54.0 54.0 54.0 55.0 54.0 54.0 55.0 54.0 55.0 55.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:3.81 (4.6%) stddev-sans-first:4.03 09:15:10 INFO - PID 4483 | Values: 82.0 81.0 80.0 80.0 93.0 82.0 81.0 81.0 82.0 82.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:132.50 stddev:17.08 (12.9%) stddev-sans-first:17.75 09:15:10 INFO - PID 4483 | Values: 127.0 135.0 130.0 128.0 147.0 128.0 127.0 135.0 182.0 128.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:184.50 stddev:2.95 (1.6%) stddev-sans-first:3.13 09:15:10 INFO - PID 4483 | Values: 184.0 181.0 183.0 177.0 182.0 185.0 186.0 187.0 184.0 186.0 09:15:10 INFO - PID 4483 | 09:15:10 INFO - PID 4483 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:1.69 (2.6%) stddev-sans-first:1.59 09:15:10 INFO - PID 4483 | Values: 68.0 65.0 65.0 65.0 69.0 66.0 67.0 65.0 64.0 64.0 09:15:10 INFO - PID 4483 | -------- Summary: end -------- 09:15:10 INFO - PID 4483 | 09:15:11 INFO - TEST-INFO | 4483: exit 0 09:15:11 INFO - TEST-OK | kraken | took 62108ms 09:15:11 INFO - SUITE-END | took 1179s 09:15:12 INFO - Completed test suite (00:19:39) 09:15:12 INFO - javascript benchmark 09:15:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7610.180571158618, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.0900756795663, 3386.1703882548763, 3405.1487128217955, 3412.385770561298, 3433.742469314802, 5678.6024978251535, 5766.0486019806785, 5886.558508111887, 5914.704264786759, 5945.16767652529, 5864.941350586493, 5879.323877754059, 5892.3518412974645, 5941.28704555454, 5971.343152253248, 4931.630127740415, 5082.593392528607, 5104.310918026074, 5203.869903252421, 5274.841754747364, 5262.973720124558, 5314.229436731672, 5319.228711836781, 5323.547498462635, 5356.625036247464, 5033.874153146164, 5097.980403919194, 5106.310648062501, 5215.322008138917, 5246.134387826004, 5255.553277971377, 5275.261463395128, 5303.893922121536, 5336.332958380202, 5347.59893008022, 5192.091384007784, 5244.239585260154, 5253.133233016548, 5267.914783731448, 5310.893782124336, 5646.435356464321, 5743.856403589902, 5866.589338746289, 5871.060630299132, 5880.059190529495, 6147.600405973598, 6271.529635277372, 6340.968295158541, 6346.777862774827, 6347.87304253917, 6419.711112999879, 6425.678716064178, 6431.871362572769, 6436.324185960453, 6445.291017988017, 5869.559783016291, 5953.642781433085, 5969.104634304846, 5970.522358211333, 5975.701214939236, 6159.692015399212, 6259.0, 6393.392627700361, 6470.352964703586, 6507.9023814642815, 6007.639541627516, 6057.394260573908, 6070.453659170607, 6173.41352571505, 6203.131561581382, 6239.75040998355, 6336.619802811846, 6359.109724638554, 6359.650219237987, 6359.9364006360265, 6312.084747711556, 6314.210723659543, 6316.05259211122, 6320.936790632127, 6357.0, 6139.416755408229, 6144.938550614526, 6229.53278504114, 6344.175257216532, 6359.236891573041, 4796.9760151199025, 4840.249761286936, 4840.709557426566, 4842.661013729005, 4854.80580776765, 4293.119910418357, 4309.719868208556, 4310.245707001262, 4343.739375637472, 4345.283028300295, 5720.799772008043, 5799.536037117021, 5994.430529099728, 5995.280566332068, 5996.2504686914135, 6120.873812997669, 6276.780312689125, 6349.079383489368, 6355.586886852339, 6394.328595497405, 5934.940650593525, 5964.433378829004, 5983.252093488314, 5998.820035398945, 6034.366391528914, 5416.295881535454, 5419.430959749248, 5422.078246698071, 5426.538744206787, 5426.972865135728, 6298.086777417248, 6359.046143078575, 6408.775692850728, 6426.132472116298, 6428.228612566522, 6157.138000679819, 6169.907451388143, 6177.6911154443, 6177.752889884534, 6203.16257305276, 6649.567778094409, 6673.132492775908, 6706.497012724163, 6709.0, 6709.630970296681, 6257.812265632038, 6262.2172228471445, 6263.718132683949, 6263.718132684131, 6266.060090986389, 6095.024796032613, 6367.745290188526, 6368.840778980562, 6369.948958421994, 6371.458426033653, 6061.636301821728, 6145.631262124287, 6146.938530614637, 6170.5372097092, 6185.103160041679, 6141.201643786279, 6148.938510614837, 6152.907706384318, 6156.78451254204, 6159.322474527708, 6144.262688477412, 6149.0, 6161.815145545641, 6164.4143806338325, 6175.2589689237575, 5926.822195334147, 5987.760489580368, 6156.507479401547, 6198.597091189058, 6228.314885362697, 6054.0918862169265, 6073.180120683828, 6075.908861366995, 6076.088586712029, 6081.483073938588], "value": 5781.404971206074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.2071992888605, 737.030804492093, 754.6717178027559, 1120.5741818109118, 1139.2708666453477, 31326.53010204846, 38914.0, 39848.60151398489, 39858.202835943266, 39886.80056599713, 42087.15825683492, 42659.78670106645, 42694.57305426945, 42734.14531709364, 42734.7863260684, 6208.937910620881, 6404.615723056631, 8354.582270886447, 8531.57342132894, 8537.95731021344, 8148.307393871499, 8374.706885259016, 8374.706885259016, 8374.874376884321, 8380.036295825998, 8450.87323690145, 8534.445261058043, 8543.231109200171, 8551.572421378938, 8551.743447696548, 8438.957805210965, 8491.363147763912, 8506.489610623321, 8507.617157227878, 8516.06323304436, 8107.108218096005, 8115.8782618260775, 8141.796455088611, 8155.184481551857, 8165.591720414015, 41419.37870931938, 41625.0, 41642.167156657, 41720.79139604313, 41863.581364186575, 2964.762818974477, 2981.522956326999, 2984.447877142714, 2999.1902186409548, 3019.9849000755075, 28375.71624283772, 28517.572236416472, 28533.57199642007, 28957.71042289571, 29323.70676293231, 3512.3502152101687, 3545.627709090534, 3617.9095522611883, 3620.8732694355836, 3637.7271704621994, 205515.0, 205738.99999999852, 205780.0, 206723.0, 206742.0, 47675.52324476711, 47797.0, 47830.5216947833, 47911.28133078007, 47952.0, 50364.748176259614, 50705.0, 50748.74625626848, 50755.74622126939, 50925.490745092815, 14480.058796178215, 14583.270836458347, 14606.12363258208, 14608.34262458192, 14621.195834229007, 9827.557759900821, 9966.80066398668, 10779.67660970172, 11475.254108483088, 11494.195406321478, 14845.109293442429, 15029.248537573078, 15085.54743357701, 15151.621209469851, 15286.464973725866, 5749.511291540266, 5824.854378640568, 5913.970430147821, 5936.643801371932, 6019.428154325332, 1024.2983556263835, 1038.8078205532001, 1045.163868904873, 1068.7808999155154, 1077.2782235901964, 25062.624060639104, 25396.873015634803, 25669.48661026769, 25709.0, 25969.22092337233, 1137.2948771761396, 1145.1297014269048, 1155.1394211312627, 1158.1487606609135, 1158.1776938373848, 12793.488260469478, 13279.402426890812, 13616.251106189255, 16809.0, 17643.382481613084, 344013.0, 344968.0, 346043.0, 346429.0, 347619.0, 60152.39847601556, 60653.205285233395, 60657.69671151616, 60705.0, 60875.39124608786, 1373.4986729843536, 1425.8788003019858, 1431.6277767780452, 1444.032498226191, 1446.9421223151166, 28318.292042699097, 29602.851985739933, 29802.403951921275, 30478.542821858133, 30600.39896608813, 54055.459445405046, 55134.0, 55185.724071380995, 55297.723511383796, 55300.44699552953, 336732.0, 339528.0, 340451.0, 341356.0, 342097.0, 36493.27013459769, 36611.0, 36904.26191476209, 37062.62937370592, 37099.0, 43826.561734382245, 44547.76796204355, 45883.770581146884, 46016.7699161502, 46172.769136155446, 31748.841255793574, 33293.83353083219, 33502.83248583742, 34026.489602656475, 34750.304993900485, 31923.68076319207, 32846.835765821015, 33220.0, 33719.325613487104, 34258.65741342555, 38558.80720596379, 38649.42025869558, 38926.80536597412, 39209.803950980066, 39616.60383396244, 30285.0, 30455.0, 31222.0, 31395.0, 32727.509087364186, 24731.258062258163, 25858.870705647103, 25920.8703956479, 26146.607800882623, 26437.0], "value": 18154.917784875448, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.8622230441279, 403.1312521516133, 405.5478141871812, 418.2930846868791, 418.4831732809979, 14394.280285985698, 16201.75697364539, 21506.0, 21827.799471029106, 22249.0, 22205.888970555166, 22471.66292505614, 22551.09795608178, 22636.773632263674, 22769.658455123186, 5883.176355310271, 6039.7282122304605, 6146.231721034871, 6155.045967874987, 6157.815265542041, 3595.26297109092, 3761.9059523511855, 5935.169076329317, 6033.668148251866, 6146.938530614703, 6149.046897730859, 6178.320384757673, 6178.443940045395, 6179.629222246657, 6182.103594978726, 5945.910811337833, 6030.577859549833, 6073.4533891949495, 6076.483498902554, 6174.0, 5404.216388623667, 5406.459354064601, 5419.83740487786, 5422.078246698071, 5463.043967305705, 24657.137000204908, 25040.49919001628, 25394.0, 25641.487170256678, 25655.253778050934, 1960.9607807843763, 1961.7155512450615, 1963.2539634938776, 1994.840412766975, 2012.5471768852037, 15631.452899148475, 16080.356785728556, 16478.2584783685, 16500.669986600322, 16674.249658765384, 1772.6986412309939, 1842.1249906294536, 1859.0890463672838, 1878.7745470543487, 1900.7243949627366, 99772.50113749458, 100734.49632751863, 101516.0, 101765.49117254441, 104137.47931260371, 11343.659690209306, 11365.31808091517, 11542.884571154182, 11696.298222106701, 11928.403579820973, 15657.651352297247, 15731.528054158394, 15747.842521574867, 15757.212139392985, 15897.443589474313, 8080.959595202104, 8253.504789712517, 8257.133001034925, 8445.408821382443, 8470.068292487822, 7630.923690763132, 7741.612919354123, 7897.842043159219, 7914.762557123296, 7916.762497125095, 7352.485326027234, 7537.283958023979, 7592.620368981528, 7593.848123037508, 7706.306432420997, 2115.492281852375, 2131.989340053321, 2181.8363622728357, 2188.9233876814556, 2246.0, 990.8662330585423, 1006.1799633298838, 1012.9493525323852, 1027.3219675014454, 1047.8585390972273, 19644.410667679993, 19746.40760777179, 19800.306989255594, 20012.89993550023, 20354.694679579523, 1043.7860238651058, 1044.8014877173314, 1048.2871647279771, 1053.6891616973012, 1059.7456610413444, 10149.289549731595, 10906.400147991779, 10917.727056823644, 10996.450177491093, 11105.666829995112, 617189.0, 622356.0, 622434.0, 638934.0, 646778.0, 105191.0, 105218.0, 106434.0, 106652.0, 109114.0, 1158.8841115888345, 1185.9229150105216, 1210.963671089851, 1218.500414829933, 1221.3832014832453, 16063.704678188116, 16705.83294167043, 16976.745348820026, 17022.2339994703, 17162.313507459563, 47857.52142478531, 48647.62171404449, 48873.26690099722, 49956.50043499664, 50345.74827125987, 63471.6826415865, 63962.68018659877, 64417.67791161014, 65695.67152164399, 65752.0, 9006.448034389641, 9006.819863602823, 9072.455652660861, 9252.259819214582, 9293.070692930653, 14003.719925601226, 14170.645733856736, 14356.353964071433, 14641.41434342657, 15183.772243416137, 12491.812622810483, 12610.747785044432, 12654.114212005072, 12739.490420383081, 12937.611871643865, 11681.824772628588, 11689.649310520697, 11945.0, 11983.76032479363, 12395.380230988594, 12096.455659495168, 12126.878731212575, 12629.87370126287, 12963.351832408152, 13092.476300947856, 9038.819223615623, 9086.863697044682, 9105.590248438704, 9298.302627302844, 9303.627854886, 12217.389130543259, 12393.070519710878, 12824.615261542169, 13006.154599950973, 13061.412236449192], "value": 9983.680625386256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.7562763075018, 1347.555306748773, 1348.5077946549507, 1368.3637108744435, 1374.8418931822844, 10553.997370249823, 11081.445927703613, 11082.16883733719, 11085.334879907192, 11096.389698566576, 10784.46077696116, 10803.189760767935, 10927.453627318622, 10927.562897484091, 10933.289336193142, 2339.251439539348, 2365.8698771567642, 2380.3573035280465, 2384.7496012918655, 2389.940251493709, 1958.6670266054734, 2256.8194544436487, 2338.5089131282452, 2391.0, 2394.4732158925094, 2024.2004408258729, 2275.9317220483413, 2359.5988681924027, 2362.5865473542062, 2368.0882860098814, 2282.760310167425, 2342.437814924423, 2351.8118550516, 2355.8115350771895, 2359.905603775847, 1910.8184722451344, 1973.6348775476583, 2220.9000594973104, 2287.9885600571893, 2298.528801595669, 11066.778664426747, 11113.555457781678, 11132.944335278271, 11134.665960021212, 11153.553857845758, 5912.438318359749, 6183.258009038899, 6186.443220110166, 6187.752489900398, 6193.907091393633, 3683.9079023024638, 3754.9061273468383, 3821.9044523886846, 3835.2137811748526, 3870.825812838401, 1308.5812539987207, 1312.4553310376182, 1326.7147563273943, 1358.4090920449637, 1364.1474078700812, 15064.623384415478, 15118.09291442517, 16028.679426411523, 16441.095739734308, 16458.341666333334, 4913.0, 5023.095842748267, 5096.770645320896, 5147.047796157723, 5150.8969820604125, 12216.144869859203, 12220.388980550937, 12240.326782026896, 12256.142070055188, 12345.814812777815, 6055.091736239599, 6064.575479716465, 6071.848203794852, 6086.421789929949, 6109.358517355702, 5557.527610153102, 5652.321721393377, 5660.575456840671, 5735.77056917727, 5754.338251101093, 4083.7549747015273, 4098.174977593485, 4129.29801933672, 4130.958690413117, 4171.749695018248, 1121.955121795119, 1131.7114135895458, 1146.48408216303, 1154.1343992005995, 1156.1329003247565, 819.5779173725537, 820.5897051474263, 837.3371295252715, 856.5075081827974, 857.498363457372, 6004.219451471281, 6117.082437634391, 6138.294096178907, 6173.135760993465, 6405.35946405365, 568.3833041150398, 571.4428432278495, 577.8670905691714, 587.529976019183, 596.4155127974609, 3960.2277555876904, 4175.603317684815, 4350.347447882779, 4370.650347972155, 4415.62467190286, 14157.787633185511, 14643.707125857423, 14652.267386630625, 14668.0, 14687.0, 14052.437902483785, 14462.710745785236, 14533.128012319296, 14731.33708983077, 14741.00996365477, 10418.385150301716, 10623.150147987988, 10628.46857657114, 10654.840177397346, 10670.466476676134, 6320.462760665395, 6536.627308265128, 6647.667616619053, 6787.592744435349, 6815.284395138439, 12819.230846149261, 12862.163959342613, 12933.03002274852, 12952.158109722837, 13093.399315188399, 13085.607431777062, 13149.671258218621, 13184.143030702973, 13212.471501140231, 13302.40139193758, 9281.628734850801, 9448.48033358172, 9451.291153163404, 9459.38513996588, 9625.374350667184, 10343.793124137324, 10391.168706503311, 10457.16342692598, 10464.0, 10542.789144217226, 8716.825663486821, 8796.252318552995, 8818.823623527365, 8936.955315223382, 8987.101289870961, 8559.186877246651, 8618.78453038679, 8661.263792577702, 8706.956465217634, 8786.384953053224, 7906.446548741533, 7952.443328966917, 8004.679812807422, 8103.068147162916, 8107.594620269081, 5929.673867937305, 5950.5239580834295, 6055.2430946131735, 6251.124842521959, 6279.2464904209955, 6062.636241825505, 6105.389461053859, 6112.877742445037, 6243.687815609293, 6366.904496432465], "value": 5142.6469010574865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.7812203288192, 401.11554023378454, 401.44600451377096, 401.74890693316695, 401.76295985368637, 5917.757270973096, 5920.4671579557835, 5960.64236145831, 5998.820035398945, 5999.790007349744, 5651.191618682024, 5808.2449281593335, 5815.73829177687, 5830.4169583041785, 5855.268091488564, 4577.336286238502, 4586.578160770172, 4588.8298483886565, 4591.071749865065, 4606.56237657422, 4611.515790841963, 4612.677112602119, 4615.723056616614, 4620.1221767864, 4626.352310676508, 4278.422412974255, 4453.888652783674, 4454.777261136946, 4458.1306645204195, 4607.0, 4451.198784218839, 4452.354408610766, 4464.709793863421, 4466.0, 4473.060657261979, 3920.294347017564, 3925.528936527635, 3942.6057394260633, 3948.368261078214, 3948.506436695413, 5445.673259604437, 5656.858578535528, 5691.971540142315, 5701.857453563694, 5704.1443783432405, 5178.40448348441, 5179.352580927384, 5183.403908550527, 5185.325907632021, 5200.29795977542, 6130.448259656608, 6145.692715364214, 6151.907721384183, 6155.938440615581, 6201.286852011986, 4417.757023363713, 4566.45202575693, 4593.931091033637, 4601.332806743037, 4633.536646335339, 6165.229346331708, 6361.173047503795, 6460.192475940507, 6567.376099270562, 6578.440832529241, 4347.500037495728, 4540.228161212602, 4545.931811022837, 4561.863144105682, 4562.361269422284, 4613.308003799457, 4786.688865223749, 4799.5601319603975, 4800.639952003614, 4811.4707382187935, 5350.224217488442, 5353.57171426285, 5375.704336261543, 5376.731163441812, 5380.973095134499, 5987.317799553243, 6196.504279657616, 6258.311585725566, 6283.08895210192, 6288.213973253343, 1664.991675041617, 1664.991675041617, 1665.76679264903, 1668.449411694138, 1668.8581470575136, 1117.5082963496036, 1172.2263306217856, 1181.9822702659467, 1183.8401815754935, 1185.1230089733535, 6009.729562169713, 6016.879662406727, 6021.157038014681, 6023.2772067351325, 6023.728932198062, 6291.0, 6341.651209183447, 6372.776952806629, 6375.5017570870805, 6395.936040639627, 5742.54059675225, 5910.734016969161, 5913.704314784243, 5914.9112763308585, 5956.55325850563, 3310.7682462227895, 3339.699427051577, 3365.360581489509, 3393.8642454302044, 3394.7114495267683, 6439.903401448982, 6737.831554211184, 6751.831204219934, 6753.3246675332075, 6756.797296081126, 6565.376289252514, 6567.179102612174, 6577.934220657828, 6588.571742836701, 6592.637404942679, 6447.3552644735155, 6662.900621397415, 6687.063811066358, 6720.126383570105, 6735.494837887178, 6360.395762402564, 6362.409397650587, 6362.427381535684, 6378.170837791057, 6393.808185754435, 6167.378863982879, 6294.779682711083, 6322.683865806784, 6345.302016778059, 6361.586496877688, 6702.798916032527, 6735.6295403753265, 6746.392824645805, 6749.797506074826, 6765.526413151032, 4474.865754027384, 4476.955230447654, 4480.731156130642, 4490.169318676056, 4491.169133710274, 6323.620582765049, 6370.745170193326, 6440.710168042543, 6444.774432895014, 6453.225612926291, 6174.919389106799, 6179.969100154651, 6186.566940314135, 6220.937790622036, 6223.128761973237, 6043.153958445909, 6177.752889884354, 6185.824318995317, 6208.596441231305, 6232.844178895564, 6157.938420615916, 6183.103449999635, 6194.721237544231, 6194.907076393768, 6207.317195108625, 6168.907466387918, 6216.880961426987, 6262.123302737529, 6273.902067138324, 6275.811725648238, 5856.648601083949, 6005.759769609167, 6012.1582978382185, 6032.939670603413, 6047.969760151171], "value": 4764.912773917655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.544501021892, 781.2812212764256, 784.1061190243124, 787.6888628991545, 801.8997625296835, 16367.918160409195, 16651.417200397987, 16676.499705008868, 16713.916430417863, 16724.498265052054, 15874.444394446196, 15967.201639918016, 15998.120103394309, 16046.1174635395, 16052.43816466424, 931.8136372725448, 956.3879117364858, 984.4339504784778, 989.4557993103764, 995.437577768562, 982.6266018912803, 983.6409710455667, 983.7786498037956, 984.2421335571605, 986.9259805514579, 1034.3276870034463, 1038.185024755567, 1038.6883934819562, 1039.132324509036, 1039.1478987230473, 1027.7327894747382, 1029.0, 1032.3702541449709, 1032.664384075175, 1035.7410647338165, 752.2289653105556, 757.7802437293178, 757.8029712274848, 758.0940775772954, 759.3204082346269, 16414.589635259093, 16443.58891027734, 16608.418705345375, 16850.915745421316, 17068.2319295632, 15065.171415572138, 15066.623334416618, 15079.773803392958, 15342.539723808304, 15562.922185389114, 12333.444994975158, 12423.31671758053, 12663.366831658472, 12663.366831658472, 12784.360781960957, 2880.74073333401, 2935.8825646974096, 3020.1845501714633, 3039.7112274333904, 3045.5888455058507, 85128.0, 85637.57181214116, 86694.0, 87398.12601873964, 88125.55937220337, 11016.504257308441, 11092.500837462172, 11384.943075284737, 11636.12729045325, 12053.457594408274, 24055.759442405702, 24986.250412487654, 25019.249422517354, 25173.496530069297, 25416.618750718753, 8244.014079262884, 8246.257836794717, 8324.958375208085, 8406.327493800482, 8619.61211745473, 3991.840326386912, 4025.134596061861, 4139.834406623701, 4159.563245859202, 4200.201961627281, 3598.1184609770776, 3630.5098811660614, 3633.981830090833, 3638.8544458221904, 3662.1027848176836, 840.6133178737726, 842.1241908415302, 854.0818619983543, 864.2653744317406, 868.301017680773, 616.7687117331001, 624.9218847644045, 630.895902176145, 632.6552029144127, 633.1168020611221, 10248.64129755455, 10977.012068913837, 11051.889481105247, 11060.778784424427, 11255.66233013011, 618.4588485075559, 644.577801539992, 648.0861984601689, 653.31075715121, 653.7744478155029, 4348.565143485626, 4692.700576717384, 5317.230177473524, 5554.972225138848, 5726.828195154152, 72700.63942646558, 73664.0, 79151.60424197957, 83266.0, 83352.16647833565, 62382.37617623856, 62786.372136278966, 63097.0, 63178.68410658009, 64354.6782266095, 60035.69982150061, 60424.697876510334, 61399.386006139364, 61633.44575297215, 62331.0, 11391.829122563335, 11658.300501969909, 11670.94164529172, 11744.647660570197, 11758.470868811095, 31376.68623313829, 32657.020289391356, 33092.1726956828, 33157.83947561824, 33650.32699346048, 53277.200841986625, 53825.19262210991, 53858.0, 54337.0, 55457.0, 13405.91460889435, 13534.526291579747, 13569.1858488491, 13605.79591306151, 14020.088694234842, 15406.845931540542, 15425.460108896135, 15548.766768498255, 15551.688966220838, 15873.761893571836, 13661.726765464833, 13705.862941370458, 13922.791158132839, 14122.43510259578, 14583.197924114276, 14480.710385792436, 14527.491537796126, 14974.700505990037, 15154.772678409612, 15342.846571534143, 13761.17432954026, 13858.930705346409, 13860.722785544434, 14066.156030638194, 14084.577462676136, 10085.486218389708, 10213.642522511676, 10448.582056717647, 10520.15838732915, 10995.615153469591, 10868.239223254297, 11410.535329347042, 11475.0, 11935.343556104497, 12391.318477483825], "value": 7564.437118957374, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 111.0, 110.0, 109.0, 108.0, 109.0, 108.0, 108.0, 110.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 118.0, 157.0, 118.0, 118.0, 119.0, 120.0, 146.0, 118.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 164.0, 165.0, 164.0, 164.0, 163.0, 163.0, 166.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 106.0, 77.0, 74.0, 77.0, 74.0, 89.0, 76.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 85.0, 85.0, 84.0, 97.0, 84.0, 84.0, 107.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 149.0, 149.0, 148.0, 149.0, 148.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 56.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 80.0, 80.0, 93.0, 82.0, 81.0, 81.0, 82.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 135.0, 130.0, 128.0, 147.0, 128.0, 127.0, 135.0, 182.0, 128.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 183.0, 177.0, 182.0, 185.0, 186.0, 187.0, 184.0, 186.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 65.0, 69.0, 66.0, 67.0, 65.0, 64.0, 64.0], "value": 65.8, "unit": "score"}]}]} 09:15:12 INFO - Return code: 0 09:15:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:15:12 ERROR - # TBPL SUCCESS # 09:15:12 INFO - Running post-action listener: _resource_record_post_action 09:15:12 INFO - [mozharness: 2017-03-30 16:15:12.343618Z] Finished run-tests step (success) 09:15:12 INFO - Running post-run listener: _resource_record_post_run 09:15:12 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 380764160; Read time: 0; Write time: 282156 09:15:12 INFO - TinderboxPrint: CPU usage
13.0% 09:15:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:15:12 INFO - TinderboxPrint: I/O write bytes / time
380,764,160 / 282,156 09:15:12 INFO - TinderboxPrint: CPU idle
8,312.2 (87.0%) 09:15:12 INFO - TinderboxPrint: CPU user
1,193.4 (12.5%) 09:15:12 INFO - TinderboxPrint: Swap in / out
0 / 0 09:15:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 123473920; Read time: 0; Write time: 85260 09:15:12 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 257290240; Read time: 0; Write time: 196896 09:15:12 INFO - Running post-run listener: _upload_blobber_files 09:15:12 INFO - Blob upload gear active. 09:15:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:15:12 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:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:15:13 INFO - (blobuploader) - INFO - Open directory for files ... 09:15:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:15:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:14 INFO - (blobuploader) - INFO - Done attempting. 09:15:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:15:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:15:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:15 INFO - (blobuploader) - INFO - Done attempting. 09:15:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:15:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:15:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:15 INFO - (blobuploader) - INFO - Done attempting. 09:15:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:15:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:15:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:19 INFO - (blobuploader) - INFO - Done attempting. 09:15:19 INFO - (blobuploader) - INFO - Iteration through files over. 09:15:19 INFO - Return code: 0 09:15:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:15:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:15:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b224a75bdbc8cec1a1759b905605315822d6410b041b02ba7987c42998d3561055e7d582f8a627cb02f810ff1f7ace94d447a9c9a3f3f39bb9d17e9bd9383bf3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e532634826849d24646e2b656bc50d33ced35cc06dcd43febfc3497376fa0b60f83e4ef6e92b62ecc6241f5d1f80efd668c201364b7bd05f1af087d519ae8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba5e4fc79146db90ffc5250bd69f1aa0c50b2163b8b9d8171459e99dd8ba733a74d9716bb16d9a4df0fb8d0a327fa239f271aa160602c6751578bd046af2eba0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f58f5a50825a8d3c2f2faccbd6575ac9c212f719c90c96dd8a26bf0bc087acfee123e6533cfc5d45e9ef93b8907b73085a97e208ae019ed84b25931de37ad89f"} 09:15:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:15:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:15:19 INFO - Contents: 09:15:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b224a75bdbc8cec1a1759b905605315822d6410b041b02ba7987c42998d3561055e7d582f8a627cb02f810ff1f7ace94d447a9c9a3f3f39bb9d17e9bd9383bf3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e532634826849d24646e2b656bc50d33ced35cc06dcd43febfc3497376fa0b60f83e4ef6e92b62ecc6241f5d1f80efd668c201364b7bd05f1af087d519ae8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba5e4fc79146db90ffc5250bd69f1aa0c50b2163b8b9d8171459e99dd8ba733a74d9716bb16d9a4df0fb8d0a327fa239f271aa160602c6751578bd046af2eba0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f58f5a50825a8d3c2f2faccbd6575ac9c212f719c90c96dd8a26bf0bc087acfee123e6533cfc5d45e9ef93b8907b73085a97e208ae019ed84b25931de37ad89f"} 09:15:19 INFO - Running post-run listener: copy_logs_to_upload_dir 09:15:19 INFO - Copying logs to upload dir... 09:15:19 INFO - mkdir: /builds/slave/test/build/upload/logs 09:15:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.842001 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-03-30 09:15:19.401502) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 09:15:19.406786) ========= 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=2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b224a75bdbc8cec1a1759b905605315822d6410b041b02ba7987c42998d3561055e7d582f8a627cb02f810ff1f7ace94d447a9c9a3f3f39bb9d17e9bd9383bf3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e532634826849d24646e2b656bc50d33ced35cc06dcd43febfc3497376fa0b60f83e4ef6e92b62ecc6241f5d1f80efd668c201364b7bd05f1af087d519ae8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba5e4fc79146db90ffc5250bd69f1aa0c50b2163b8b9d8171459e99dd8ba733a74d9716bb16d9a4df0fb8d0a327fa239f271aa160602c6751578bd046af2eba0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f58f5a50825a8d3c2f2faccbd6575ac9c212f719c90c96dd8a26bf0bc087acfee123e6533cfc5d45e9ef93b8907b73085a97e208ae019ed84b25931de37ad89f"} build_url:https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/WgH8lurJR5CFvoQqZS9iMQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b224a75bdbc8cec1a1759b905605315822d6410b041b02ba7987c42998d3561055e7d582f8a627cb02f810ff1f7ace94d447a9c9a3f3f39bb9d17e9bd9383bf3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e532634826849d24646e2b656bc50d33ced35cc06dcd43febfc3497376fa0b60f83e4ef6e92b62ecc6241f5d1f80efd668c201364b7bd05f1af087d519ae8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba5e4fc79146db90ffc5250bd69f1aa0c50b2163b8b9d8171459e99dd8ba733a74d9716bb16d9a4df0fb8d0a327fa239f271aa160602c6751578bd046af2eba0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f58f5a50825a8d3c2f2faccbd6575ac9c212f719c90c96dd8a26bf0bc087acfee123e6533cfc5d45e9ef93b8907b73085a97e208ae019ed84b25931de37ad89f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 09:15:19.435165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 09:15:19.435682) ========= 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=2432103b8b3de4003b23cad4000001c2-1490889206.250997-433512343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 09:15:19.518678) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 09:15:19.519210) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 09:15:19.519713) ========= ========= Total master_lag: 0.16 =========