builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1487166495.35 results: success (0) revision: 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:15.354060) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:15.354559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:15.354874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:15.371539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:15.371951) ========= 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=52faae308a556c440401f8e5000001e8-1487166444.330375-74213130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-15 05:48:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.2M=0s 2017-02-15 05:48:16 (24.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147304 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:15.532887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:15.533171) ========= 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=52faae308a556c440401f8e5000001e8-1487166444.330375-74213130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020925 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:15.582962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:15.583272) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 --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=52faae308a556c440401f8e5000001e8-1487166444.330375-74213130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-15 05:48:16,468 truncating revision to first 12 chars 2017-02-15 05:48:16,468 Setting DEBUG logging. 2017-02-15 05:48:16,468 attempt 1/10 2017-02-15 05:48:16,469 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6c660ca9126f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 05:48:16,784 unpacking tar archive at: mozilla-aurora-6c660ca9126f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646538 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:16.245040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:16.245721) ========= script_repo_revision: 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:16.246337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:16.246623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 05:48:16.259489) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-02-15 05:48:16.259759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1487166444.330375-74213130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:48:17 INFO - MultiFileLogger online at 20170215 05:48:17 in /builds/slave/test 05:48:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:48:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:17 INFO - {'append_to_log': False, 05:48:17 INFO - 'base_work_dir': '/builds/slave/test', 05:48:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:48:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:17 INFO - 'branch': 'Mozilla-Aurora', 05:48:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:17 INFO - 'config_files': ('talos/linux_config.py',), 05:48:17 INFO - 'default_actions': ('clobber', 05:48:17 INFO - 'read-buildbot-config', 05:48:17 INFO - 'download-and-extract', 05:48:17 INFO - 'populate-webroot', 05:48:17 INFO - 'create-virtualenv', 05:48:17 INFO - 'install', 05:48:17 INFO - 'run-tests'), 05:48:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:17 INFO - 'download_minidump_stackwalk': True, 05:48:17 INFO - 'download_symbols': 'ondemand', 05:48:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:17 INFO - 'installer_path': 'installer.exe', 05:48:17 INFO - 'log_level': 'info', 05:48:17 INFO - 'log_name': 'talos', 05:48:17 INFO - 'log_to_console': True, 05:48:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:48:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:48:17 INFO - 'opt_config_files': (), 05:48:17 INFO - 'pip_index': False, 05:48:17 INFO - 'sps_profile': False, 05:48:17 INFO - 'sps_profile_interval': 0, 05:48:17 INFO - 'suite': 'dromaeojs', 05:48:17 INFO - 'system_bits': '32', 05:48:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:17 INFO - 'title': 'talos-linux64-ix-056', 05:48:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:17 INFO - 'use_talos_json': True, 05:48:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:17 INFO - 'work_dir': 'build'} 05:48:17 INFO - [mozharness: 2017-02-15 13:48:17.249622Z] Running clobber step. 05:48:17 INFO - Running pre-action listener: _resource_record_pre_action 05:48:17 INFO - Running main action method: clobber 05:48:17 INFO - rmtree: /builds/slave/test/build 05:48:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:18 INFO - Running post-action listener: _resource_record_post_action 05:48:18 INFO - [mozharness: 2017-02-15 13:48:18.181987Z] Finished clobber step (success) 05:48:18 INFO - [mozharness: 2017-02-15 13:48:18.182088Z] Running read-buildbot-config step. 05:48:18 INFO - Running pre-action listener: _resource_record_pre_action 05:48:18 INFO - Running main action method: read_buildbot_config 05:48:18 INFO - Using buildbot properties: 05:48:18 INFO - { 05:48:18 INFO - "project": "", 05:48:18 INFO - "product": "firefox", 05:48:18 INFO - "who": "paul@paul.cx", 05:48:18 INFO - "installer_path": "public/build/target.tar.bz2", 05:48:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:48:18 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 05:48:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:48:18 INFO - "stage_platform": "linux64-pgo", 05:48:18 INFO - "basedir": "/builds/slave/test", 05:48:18 INFO - "buildnumber": 1059, 05:48:18 INFO - "platform": "ubuntu64_hw", 05:48:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:48:18 INFO - "slavebuilddir": "test", 05:48:18 INFO - "taskId": "Zui0P2K4T8W6TRWhx9d8Ew", 05:48:18 INFO - "branch": "mozilla-aurora", 05:48:18 INFO - "script_repo_revision": "production", 05:48:18 INFO - "revision": "6c660ca9126fbc8f2c9fd91d7c48853d2268d136", 05:48:18 INFO - "slavename": "talos-linux64-ix-056", 05:48:18 INFO - "repo_path": "releases/mozilla-aurora" 05:48:18 INFO - } 05:48:18 INFO - Finding installer, test and symbols from parent task. 05:48:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zui0P2K4T8W6TRWhx9d8Ew'}, attempt #1 05:48:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zui0P2K4T8W6TRWhx9d8Ew'}, attempt #1 05:48:19 INFO - Task dependencies: aoR_uvPXRz-K8DLMQSlEqA 05:48:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA'}, attempt #1 05:48:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.tar.bz2 05:48:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/test_packages.json 05:48:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.crashreporter-symbols.zip 05:48:19 INFO - Running post-action listener: _resource_record_post_action 05:48:19 INFO - [mozharness: 2017-02-15 13:48:19.576943Z] Finished read-buildbot-config step (success) 05:48:19 INFO - [mozharness: 2017-02-15 13:48:19.577161Z] Running download-and-extract step. 05:48:19 INFO - Running pre-action listener: _resource_record_pre_action 05:48:19 INFO - Running main action method: download_and_extract 05:48:19 INFO - mkdir: /builds/slave/test/build/tests 05:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:19 INFO - trying https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.test_packages.json 05:48:19 INFO - Downloading https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:48:20 INFO - Downloaded 896 bytes. 05:48:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:48:20 INFO - Using the following test package requirements: 05:48:20 INFO - {u'common': [u'target.common.tests.zip'], 05:48:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:48:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:48:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:48:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:48:20 INFO - u'mozbase': [u'target.common.tests.zip'], 05:48:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:48:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:48:20 INFO - u'web-platform': [u'target.common.tests.zip', 05:48:20 INFO - u'target.web-platform.tests.zip'], 05:48:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:48:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:48:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.common.tests.zip 05:48:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:48:20 INFO - Fetch https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.common.tests.zip into memory 05:48:20 INFO - Expected file size: 21858917 05:48:20 INFO - Obtained file size: 21858917 05:48:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:48:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.common.tests.zip 05:48:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:48:25 INFO - Fetch https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.common.tests.zip into memory 05:48:25 INFO - Expected file size: 21858917 05:48:25 INFO - Obtained file size: 21858917 05:48:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.talos.tests.zip 05:48:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:48:30 INFO - Fetch https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.talos.tests.zip into memory 05:48:31 INFO - Expected file size: 14403485 05:48:31 INFO - Obtained file size: 14403485 05:48:31 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')]} 05:48:31 INFO - trying https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.tar.bz2 05:48:31 INFO - Downloading https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:48:32 INFO - Downloaded 66165522 bytes. 05:48:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.tar.bz2 05:48:32 INFO - mkdir: /builds/slave/test/properties 05:48:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:48:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:48:32 INFO - Contents: 05:48:32 INFO - build_url:https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.tar.bz2 05:48:32 INFO - Running post-action listener: _resource_record_post_action 05:48:32 INFO - Running post-action listener: set_extra_try_arguments 05:48:32 INFO - [mozharness: 2017-02-15 13:48:32.666576Z] Finished download-and-extract step (success) 05:48:32 INFO - [mozharness: 2017-02-15 13:48:32.666673Z] Running populate-webroot step. 05:48:32 INFO - Running pre-action listener: _resource_record_pre_action 05:48:32 INFO - Running main action method: populate_webroot 05:48:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:32 INFO - '--tppagecycles', 05:48:32 INFO - '7'], 05:48:32 INFO - 'tests': ['tsvgm']}}, 05:48:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:48:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:48:32 INFO - 'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:48:32 INFO - 'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['damp', 'tps']}, 05:48:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:48:32 INFO - 'tests': ['damp', 'tps']}, 05:48:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['dromaeo_dom']}, 05:48:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['basic_compositor_video']}, 05:48:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:48:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['a11yr', 05:48:32 INFO - 'ts_paint', 05:48:32 INFO - 'tpaint', 05:48:32 INFO - 'sessionrestore', 05:48:32 INFO - 'sessionrestore_no_auto_restore', 05:48:32 INFO - 'tabpaint']}, 05:48:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['tsvgx', 05:48:32 INFO - 'tsvgr_opacity', 05:48:32 INFO - 'tart', 05:48:32 INFO - 'tscrollx', 05:48:32 INFO - 'cart', 05:48:32 INFO - 'tsvg_static']}, 05:48:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:32 INFO - 'tsvgr_opacity', 05:48:32 INFO - 'tart', 05:48:32 INFO - 'tscrollx', 05:48:32 INFO - 'cart', 05:48:32 INFO - 'tsvg_static']}, 05:48:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:48:32 INFO - 'talos_options': ['--disable-e10s'], 05:48:32 INFO - 'tests': ['tp5o']}, 05:48:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:48:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:48:32 INFO - 'talos_options': ['--disable-e10s', 05:48:32 INFO - '--xperf_path', 05:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:32 INFO - 'tests': ['tp5n']}, 05:48:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:48:32 INFO - 'talos_options': ['--xperf_path', 05:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:32 INFO - 'tests': ['tp5n']}}, 05:48:32 INFO - 'talos.zip': {'path': '', 05:48:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:32 INFO - Running post-action listener: _resource_record_post_action 05:48:32 INFO - [mozharness: 2017-02-15 13:48:32.679864Z] Finished populate-webroot step (success) 05:48:32 INFO - [mozharness: 2017-02-15 13:48:32.679954Z] Running create-virtualenv step. 05:48:32 INFO - Running pre-action listener: _resource_record_pre_action 05:48:32 INFO - Running main action method: create_virtualenv 05:48:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:48:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:32 INFO - Using real prefix '/usr' 05:48:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:35 INFO - Installing pip.................done. 05:48:35 INFO - Return code: 0 05:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:48:35 INFO - Reading from file tmpfile_stdout 05:48:35 INFO - Output received: 05:48:35 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) 05:48:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:35 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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:48:35 INFO - Using env: {'DISPLAY': ':0', 05:48:35 INFO - 'HOME': '/home/cltbld', 05:48:35 INFO - 'LANG': 'en_US.UTF-8', 05:48:35 INFO - 'LANGUAGE': 'en_US:en', 05:48:35 INFO - 'LOGNAME': 'cltbld', 05:48:35 INFO - 'MAIL': '/var/mail/cltbld', 05:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:35 INFO - 'MOZ_NO_REMOTE': '1', 05:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:35 INFO - 'NO_EM_RESTART': '1', 05:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:35 INFO - 'PWD': '/builds/slave/test', 05:48:35 INFO - 'SHELL': '/bin/bash', 05:48:35 INFO - 'SHLVL': '1', 05:48:35 INFO - 'TERM': 'linux', 05:48:35 INFO - 'TMOUT': '86400', 05:48:35 INFO - 'USER': 'cltbld', 05:48:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:35 INFO - '_': '/tools/buildbot/bin/python'} 05:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:48:35 INFO - Cleaning up... 05:48:35 INFO - Return code: 0 05:48:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:35 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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:35 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 05:48:35 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 05:48:35 INFO - Using env: {'DISPLAY': ':0', 05:48:35 INFO - 'HOME': '/home/cltbld', 05:48:35 INFO - 'LANG': 'en_US.UTF-8', 05:48:35 INFO - 'LANGUAGE': 'en_US:en', 05:48:35 INFO - 'LOGNAME': 'cltbld', 05:48:35 INFO - 'MAIL': '/var/mail/cltbld', 05:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:35 INFO - 'MOZ_NO_REMOTE': '1', 05:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:35 INFO - 'NO_EM_RESTART': '1', 05:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:35 INFO - 'PWD': '/builds/slave/test', 05:48:35 INFO - 'SHELL': '/bin/bash', 05:48:35 INFO - 'SHLVL': '1', 05:48:35 INFO - 'TERM': 'linux', 05:48:35 INFO - 'TMOUT': '86400', 05:48:35 INFO - 'USER': 'cltbld', 05:48:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:35 INFO - '_': '/tools/buildbot/bin/python'} 05:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:35 INFO - Downloading/unpacking psutil>=3.1.1 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:38 INFO - Installing collected packages: psutil 05:48:38 INFO - Running setup.py install for psutil 05:48:38 INFO - building 'psutil._psutil_linux' extension 05:48:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:48:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:48:38 INFO - building 'psutil._psutil_posix' extension 05:48:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:48:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:48:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:38 INFO - Successfully installed psutil 05:48:38 INFO - Cleaning up... 05:48:38 INFO - Return code: 0 05:48:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:48:38 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')]} 05:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:38 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')]} 05:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:38 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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:38 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 05:48:38 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 05:48:38 INFO - Using env: {'DISPLAY': ':0', 05:48:38 INFO - 'HOME': '/home/cltbld', 05:48:38 INFO - 'LANG': 'en_US.UTF-8', 05:48:38 INFO - 'LANGUAGE': 'en_US:en', 05:48:38 INFO - 'LOGNAME': 'cltbld', 05:48:38 INFO - 'MAIL': '/var/mail/cltbld', 05:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:38 INFO - 'MOZ_NO_REMOTE': '1', 05:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:38 INFO - 'NO_EM_RESTART': '1', 05:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:38 INFO - 'PWD': '/builds/slave/test', 05:48:38 INFO - 'SHELL': '/bin/bash', 05:48:38 INFO - 'SHLVL': '1', 05:48:38 INFO - 'TERM': 'linux', 05:48:38 INFO - 'TMOUT': '86400', 05:48:38 INFO - 'USER': 'cltbld', 05:48:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:38 INFO - '_': '/tools/buildbot/bin/python'} 05:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:48:40 INFO - Installing collected packages: mozsystemmonitor 05:48:40 INFO - Running setup.py install for mozsystemmonitor 05:48:40 INFO - Successfully installed mozsystemmonitor 05:48:40 INFO - Cleaning up... 05:48:41 INFO - Return code: 0 05:48:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:48:41 INFO - Using env: {'DISPLAY': ':0', 05:48:41 INFO - 'HOME': '/home/cltbld', 05:48:41 INFO - 'LANG': 'en_US.UTF-8', 05:48:41 INFO - 'LANGUAGE': 'en_US:en', 05:48:41 INFO - 'LOGNAME': 'cltbld', 05:48:41 INFO - 'MAIL': '/var/mail/cltbld', 05:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:41 INFO - 'MOZ_NO_REMOTE': '1', 05:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:41 INFO - 'NO_EM_RESTART': '1', 05:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:41 INFO - 'PWD': '/builds/slave/test', 05:48:41 INFO - 'SHELL': '/bin/bash', 05:48:41 INFO - 'SHLVL': '1', 05:48:41 INFO - 'TERM': 'linux', 05:48:41 INFO - 'TMOUT': '86400', 05:48:41 INFO - 'USER': 'cltbld', 05:48:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:41 INFO - '_': '/tools/buildbot/bin/python'} 05:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:41 INFO - Downloading/unpacking jsonschema==2.5.1 05:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:43 INFO - warning: no files found matching '*.txt' 05:48:43 INFO - no previously-included directories found matching 'build' 05:48:43 INFO - no previously-included directories found matching 'dist' 05:48:43 INFO - no previously-included directories found matching '.git*' 05:48:43 INFO - Installing collected packages: jsonschema, functools32 05:48:43 INFO - Running setup.py install for functools32 05:48:43 INFO - warning: no files found matching '*.txt' 05:48:43 INFO - no previously-included directories found matching 'build' 05:48:43 INFO - no previously-included directories found matching 'dist' 05:48:43 INFO - no previously-included directories found matching '.git*' 05:48:43 INFO - Successfully installed jsonschema functools32 05:48:43 INFO - Cleaning up... 05:48:43 INFO - Return code: 0 05:48:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:48:43 INFO - Using env: {'DISPLAY': ':0', 05:48:43 INFO - 'HOME': '/home/cltbld', 05:48:43 INFO - 'LANG': 'en_US.UTF-8', 05:48:43 INFO - 'LANGUAGE': 'en_US:en', 05:48:43 INFO - 'LOGNAME': 'cltbld', 05:48:43 INFO - 'MAIL': '/var/mail/cltbld', 05:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:43 INFO - 'MOZ_NO_REMOTE': '1', 05:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:43 INFO - 'NO_EM_RESTART': '1', 05:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:43 INFO - 'PWD': '/builds/slave/test', 05:48:43 INFO - 'SHELL': '/bin/bash', 05:48:43 INFO - 'SHLVL': '1', 05:48:43 INFO - 'TERM': 'linux', 05:48:43 INFO - 'TMOUT': '86400', 05:48:43 INFO - 'USER': 'cltbld', 05:48:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:43 INFO - '_': '/tools/buildbot/bin/python'} 05:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:48:43 INFO - Cleaning up... 05:48:43 INFO - Return code: 0 05:48:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:48:43 INFO - Using env: {'DISPLAY': ':0', 05:48:43 INFO - 'HOME': '/home/cltbld', 05:48:43 INFO - 'LANG': 'en_US.UTF-8', 05:48:43 INFO - 'LANGUAGE': 'en_US:en', 05:48:43 INFO - 'LOGNAME': 'cltbld', 05:48:43 INFO - 'MAIL': '/var/mail/cltbld', 05:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:43 INFO - 'MOZ_NO_REMOTE': '1', 05:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:43 INFO - 'NO_EM_RESTART': '1', 05:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:43 INFO - 'PWD': '/builds/slave/test', 05:48:43 INFO - 'SHELL': '/bin/bash', 05:48:43 INFO - 'SHLVL': '1', 05:48:43 INFO - 'TERM': 'linux', 05:48:43 INFO - 'TMOUT': '86400', 05:48:43 INFO - 'USER': 'cltbld', 05:48:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:43 INFO - '_': '/tools/buildbot/bin/python'} 05:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:46 INFO - Downloading docopt-0.6.1.tar.gz 05:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:47 INFO - Running setup.py install for blobuploader 05:48:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:47 INFO - Running setup.py install for requests 05:48:47 INFO - Running setup.py install for docopt 05:48:47 INFO - Successfully installed blobuploader requests docopt 05:48:47 INFO - Cleaning up... 05:48:47 INFO - Return code: 0 05:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:47 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')]} 05:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:47 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')]} 05:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:47 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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:47 INFO - Using env: {'DISPLAY': ':0', 05:48:47 INFO - 'HOME': '/home/cltbld', 05:48:47 INFO - 'LANG': 'en_US.UTF-8', 05:48:47 INFO - 'LANGUAGE': 'en_US:en', 05:48:47 INFO - 'LOGNAME': 'cltbld', 05:48:47 INFO - 'MAIL': '/var/mail/cltbld', 05:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:47 INFO - 'MOZ_NO_REMOTE': '1', 05:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:47 INFO - 'NO_EM_RESTART': '1', 05:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:47 INFO - 'PWD': '/builds/slave/test', 05:48:47 INFO - 'SHELL': '/bin/bash', 05:48:47 INFO - 'SHLVL': '1', 05:48:47 INFO - 'TERM': 'linux', 05:48:47 INFO - 'TMOUT': '86400', 05:48:47 INFO - 'USER': 'cltbld', 05:48:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:47 INFO - '_': '/tools/buildbot/bin/python'} 05:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:47 INFO - Running setup.py (path:/tmp/pip-IIRQaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:47 INFO - Running setup.py (path:/tmp/pip-UIQKxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:48 INFO - Running setup.py (path:/tmp/pip-ietpji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:48 INFO - Running setup.py (path:/tmp/pip-UBppIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:48 INFO - Running setup.py (path:/tmp/pip-Uc5mB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:48 INFO - Running setup.py (path:/tmp/pip-L6yUZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:48 INFO - Running setup.py (path:/tmp/pip-F4BHPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:48 INFO - Running setup.py (path:/tmp/pip-9jIoT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:48 INFO - Running setup.py (path:/tmp/pip-duLMsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:48 INFO - Running setup.py (path:/tmp/pip-TrJDhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:48 INFO - Running setup.py (path:/tmp/pip-28OLMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:48 INFO - Running setup.py (path:/tmp/pip-qQD94W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:48 INFO - Running setup.py (path:/tmp/pip-ylKR7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:48 INFO - Running setup.py (path:/tmp/pip-zcTs7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:48 INFO - Running setup.py (path:/tmp/pip-1tBxpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:48 INFO - Running setup.py (path:/tmp/pip-INdpu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:49 INFO - Running setup.py (path:/tmp/pip-RvSN7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:49 INFO - Running setup.py install for manifestparser 05:48:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozcrash 05:48:49 INFO - Running setup.py install for mozdebug 05:48:49 INFO - Running setup.py install for mozdevice 05:48:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozfile 05:48:49 INFO - Running setup.py install for mozhttpd 05:48:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozinfo 05:48:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozInstall 05:48:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozleak 05:48:50 INFO - Running setup.py install for mozlog 05:48:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for moznetwork 05:48:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozprocess 05:48:50 INFO - Running setup.py install for mozprofile 05:48:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozrunner 05:48:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozscreenshot 05:48:50 INFO - Running setup.py install for moztest 05:48:50 INFO - Running setup.py install for mozversion 05:48:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:50 INFO - Cleaning up... 05:48:50 INFO - Return code: 0 05:48:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:50 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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:50 INFO - Using env: {'DISPLAY': ':0', 05:48:50 INFO - 'HOME': '/home/cltbld', 05:48:50 INFO - 'LANG': 'en_US.UTF-8', 05:48:50 INFO - 'LANGUAGE': 'en_US:en', 05:48:50 INFO - 'LOGNAME': 'cltbld', 05:48:50 INFO - 'MAIL': '/var/mail/cltbld', 05:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:50 INFO - 'MOZ_NO_REMOTE': '1', 05:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:50 INFO - 'NO_EM_RESTART': '1', 05:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:50 INFO - 'PWD': '/builds/slave/test', 05:48:50 INFO - 'SHELL': '/bin/bash', 05:48:50 INFO - 'SHLVL': '1', 05:48:50 INFO - 'TERM': 'linux', 05:48:50 INFO - 'TMOUT': '86400', 05:48:50 INFO - 'USER': 'cltbld', 05:48:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:50 INFO - '_': '/tools/buildbot/bin/python'} 05:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:51 INFO - Running setup.py (path:/tmp/pip-7mJ3Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:51 INFO - Running setup.py (path:/tmp/pip-8vDO_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:51 INFO - Running setup.py (path:/tmp/pip-4zNYVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:51 INFO - Running setup.py (path:/tmp/pip-Tx1yHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:51 INFO - Running setup.py (path:/tmp/pip-QhK80t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:51 INFO - Running setup.py (path:/tmp/pip-Rpr6it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:51 INFO - Running setup.py (path:/tmp/pip-D8j5TH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:51 INFO - Running setup.py (path:/tmp/pip-QcQLJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:51 INFO - Running setup.py (path:/tmp/pip-gTciCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:51 INFO - Running setup.py (path:/tmp/pip-2yaaIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:51 INFO - Running setup.py (path:/tmp/pip-tmeXEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:51 INFO - Running setup.py (path:/tmp/pip-JrftPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:52 INFO - Running setup.py (path:/tmp/pip-X0kLAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:52 INFO - Running setup.py (path:/tmp/pip-EP0i6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:52 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)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:52 INFO - Running setup.py (path:/tmp/pip-JwwX43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:52 INFO - Running setup.py (path:/tmp/pip-hT8nqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:52 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)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:52 INFO - Running setup.py (path:/tmp/pip-gCXzMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:48:52 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)) 05:48:52 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)) 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:52 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)) 05:48:52 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)) 05:48:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:54 INFO - Downloading blessings-1.6.tar.gz 05:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:54 INFO - Installing collected packages: blessings 05:48:54 INFO - Running setup.py install for blessings 05:48:54 INFO - Successfully installed blessings 05:48:54 INFO - Cleaning up... 05:48:54 INFO - Return code: 0 05:48:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:54 INFO - Reading from file tmpfile_stdout 05:48:54 INFO - Current package versions: 05:48:54 INFO - argparse == 1.2.1 05:48:54 INFO - blessings == 1.6 05:48:54 INFO - blobuploader == 1.2.4 05:48:54 INFO - docopt == 0.6.1 05:48:54 INFO - functools32 == 3.2.3-2 05:48:54 INFO - jsonschema == 2.5.1 05:48:54 INFO - manifestparser == 1.1 05:48:54 INFO - mozInstall == 1.12 05:48:54 INFO - mozcrash == 1.0 05:48:54 INFO - mozdebug == 0.1 05:48:54 INFO - mozdevice == 0.49 05:48:54 INFO - mozfile == 1.2 05:48:54 INFO - mozhttpd == 0.7 05:48:54 INFO - mozinfo == 0.9 05:48:54 INFO - mozleak == 0.1 05:48:54 INFO - mozlog == 3.4 05:48:54 INFO - moznetwork == 0.27 05:48:54 INFO - mozprocess == 0.24 05:48:54 INFO - mozprofile == 0.28 05:48:54 INFO - mozrunner == 6.13 05:48:54 INFO - mozscreenshot == 0.1 05:48:54 INFO - mozsystemmonitor == 0.3 05:48:54 INFO - moztest == 0.8 05:48:54 INFO - mozversion == 1.4 05:48:54 INFO - psutil == 3.1.1 05:48:54 INFO - requests == 1.2.3 05:48:54 INFO - wsgiref == 0.1.2 05:48:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:54 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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:54 INFO - Using env: {'DISPLAY': ':0', 05:48:54 INFO - 'HOME': '/home/cltbld', 05:48:54 INFO - 'LANG': 'en_US.UTF-8', 05:48:54 INFO - 'LANGUAGE': 'en_US:en', 05:48:54 INFO - 'LOGNAME': 'cltbld', 05:48:54 INFO - 'MAIL': '/var/mail/cltbld', 05:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:54 INFO - 'MOZ_NO_REMOTE': '1', 05:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:54 INFO - 'NO_EM_RESTART': '1', 05:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:54 INFO - 'PWD': '/builds/slave/test', 05:48:54 INFO - 'SHELL': '/bin/bash', 05:48:54 INFO - 'SHLVL': '1', 05:48:54 INFO - 'TERM': 'linux', 05:48:54 INFO - 'TMOUT': '86400', 05:48:54 INFO - 'USER': 'cltbld', 05:48:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:54 INFO - '_': '/tools/buildbot/bin/python'} 05:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:48:55 INFO - Cleaning up... 05:48:55 INFO - Return code: 0 05:48:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:55 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 0x22421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2352a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, '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': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:48:55 INFO - Using env: {'DISPLAY': ':0', 05:48:55 INFO - 'HOME': '/home/cltbld', 05:48:55 INFO - 'LANG': 'en_US.UTF-8', 05:48:55 INFO - 'LANGUAGE': 'en_US:en', 05:48:55 INFO - 'LOGNAME': 'cltbld', 05:48:55 INFO - 'MAIL': '/var/mail/cltbld', 05:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:55 INFO - 'MOZ_NO_REMOTE': '1', 05:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:55 INFO - 'NO_EM_RESTART': '1', 05:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:55 INFO - 'PWD': '/builds/slave/test', 05:48:55 INFO - 'SHELL': '/bin/bash', 05:48:55 INFO - 'SHLVL': '1', 05:48:55 INFO - 'TERM': 'linux', 05:48:55 INFO - 'TMOUT': '86400', 05:48:55 INFO - 'USER': 'cltbld', 05:48:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:55 INFO - '_': '/tools/buildbot/bin/python'} 05:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:48:55 INFO - Cleaning up... 05:48:55 INFO - Return code: 0 05:48:55 INFO - Running post-action listener: _resource_record_post_action 05:48:55 INFO - Running post-action listener: _start_resource_monitoring 05:48:55 INFO - Starting resource monitoring. 05:48:55 INFO - [mozharness: 2017-02-15 13:48:55.403513Z] Finished create-virtualenv step (success) 05:48:55 INFO - [mozharness: 2017-02-15 13:48:55.404098Z] Running install step. 05:48:55 INFO - Running pre-action listener: _resource_record_pre_action 05:48:55 INFO - Running main action method: install 05:48:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:55 INFO - Reading from file tmpfile_stdout 05:48:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:55 INFO - Reading from file tmpfile_stdout 05:48:55 INFO - Output received: 05:48:55 INFO - Usage: mozinstall [options] installer 05:48:55 INFO - Options: 05:48:55 INFO - -h, --help show this help message and exit 05:48:55 INFO - -d DEST, --destination=DEST 05:48:55 INFO - Directory to install application into. [default: 05:48:55 INFO - "/builds/slave/test"] 05:48:55 INFO - --app=APP Application being installed. [default: firefox] 05:48:55 INFO - mkdir: /builds/slave/test/build/application 05:48:55 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'] 05:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:49:12 INFO - Reading from file tmpfile_stdout 05:49:12 INFO - Output received: 05:49:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:12 INFO - Running post-action listener: _resource_record_post_action 05:49:12 INFO - [mozharness: 2017-02-15 13:49:12.169307Z] Finished install step (success) 05:49:12 INFO - [mozharness: 2017-02-15 13:49:12.169581Z] Running run-tests step. 05:49:12 INFO - Running pre-action listener: _resource_record_pre_action 05:49:12 INFO - Running main action method: run_tests 05:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:12 INFO - Python 2.7.3 05:49:12 INFO - Return code: 0 05:49:12 INFO - grabbing minidump binary from tooltool 05:49:12 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')]} 05:49:12 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 0x263d850>, '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 0x25b26d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b2b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:49:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:49:12 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 05:49:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:12 INFO - Return code: 0 05:49:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:49:12 INFO - Using env: {'DISPLAY': ':0', 05:49:12 INFO - 'HOME': '/home/cltbld', 05:49:12 INFO - 'LANG': 'en_US.UTF-8', 05:49:12 INFO - 'LANGUAGE': 'en_US:en', 05:49:12 INFO - 'LOGNAME': 'cltbld', 05:49:12 INFO - 'MAIL': '/var/mail/cltbld', 05:49:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:12 INFO - 'MOZ_NO_REMOTE': '1', 05:49:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:12 INFO - 'NO_EM_RESTART': '1', 05:49:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:12 INFO - 'PWD': '/builds/slave/test', 05:49:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:12 INFO - 'SHELL': '/bin/bash', 05:49:12 INFO - 'SHLVL': '1', 05:49:12 INFO - 'TERM': 'linux', 05:49:12 INFO - 'TMOUT': '86400', 05:49:12 INFO - 'USER': 'cltbld', 05:49:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1487166444.330375-74213130', 05:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:12 INFO - '_': '/tools/buildbot/bin/python'} 05:49:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:49:12 INFO - mozversion application_buildid: 20170215124947 05:49:12 INFO - mozversion application_changeset: 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 05:49:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:49:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:12 INFO - mozversion application_name: Firefox 05:49:12 INFO - mozversion application_remotingname: firefox-dev 05:49:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:49:12 INFO - mozversion application_vendor: Mozilla 05:49:12 INFO - mozversion application_version: 53.0a2 05:49:12 INFO - mozversion platform_buildid: 20170215124947 05:49:12 INFO - mozversion platform_changeset: 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 05:49:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:49:12 INFO - mozversion platform_version: 53.0a2 05:49:12 INFO - using testdate: 1487166552 05:49:12 INFO - actual date: 1487166552 05:49:12 INFO - starting webserver on 'localhost:39181' 05:49:12 INFO - SUITE-START | Running 2 tests 05:49:12 INFO - TEST-START | dromaeo_css 05:49:12 INFO - operating with platform_type : linux_ 05:49:12 INFO - Initialising browser for dromaeo_css test... 05:49:12 INFO - TEST-INFO | started process 28108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp39EdbL/profile http://localhost:39181/getInfo.html) 05:49:17 INFO - PROCESS | 28108 | __metrics Screen width/height:1600/1200 05:49:17 INFO - PROCESS | 28108 | colorDepth:24 05:49:17 INFO - PROCESS | 28108 | Browser inner width/height: 1024/697 05:49:17 INFO - PROCESS | 28108 | __metrics 05:49:17 INFO - PROCESS | 28108 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:49:17 INFO - PROCESS | 28108 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:49:18 INFO - TEST-INFO | 28108: exit 0 05:49:18 INFO - Browser initialized. 05:49:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:49:18 INFO - TEST-INFO | started process 28200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp39EdbL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:30 INFO - PROCESS | 28200 | RSS: Main: 138522624 05:49:30 INFO - PROCESS | 28200 | 05:52:31 INFO - PROCESS | 28200 | Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39181/tests/dromaeo/cssquery-ext.html) 05:52:32 INFO - PROCESS | 28200 | RSS: Main: 242331648 05:52:32 INFO - PROCESS | 28200 | 05:54:20 INFO - PROCESS | 28200 | ************************* 05:54:20 INFO - PROCESS | 28200 | A coding exception was thrown and uncaught in a Task. 05:54:20 INFO - PROCESS | 28200 | 05:54:20 ERROR - PROCESS | 28200 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:54:20 INFO - PROCESS | 28200 | Full stack: 05:54:20 INFO - PROCESS | 28200 | ************************* 05:55:34 INFO - PROCESS | 28200 | Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-ext.html (next: http://localhost:39181/tests/dromaeo/cssquery-jquery.html) 05:55:35 INFO - PROCESS | 28200 | RSS: Main: 221835264 05:55:35 INFO - PROCESS | 28200 | 05:58:37 INFO - PROCESS | 28200 | Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39181/tests/dromaeo/cssquery-mootools.html) 05:58:37 INFO - PROCESS | 28200 | RSS: Main: 227090432 05:58:37 INFO - PROCESS | 28200 | 06:01:39 INFO - PROCESS | 28200 | Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39181/tests/dromaeo/cssquery-prototype.html) 06:01:40 INFO - PROCESS | 28200 | RSS: Main: 170115072 06:01:40 INFO - PROCESS | 28200 | 06:04:42 INFO - PROCESS | 28200 | Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39181/tests/dromaeo/cssquery-yui.html) 06:04:43 INFO - PROCESS | 28200 | RSS: Main: 170496000 06:04:43 INFO - PROCESS | 28200 | 06:07:45 INFO - PROCESS | 28200 | Cycle 1(1): loaded http://localhost:39181/tests/dromaeo/cssquery-yui.html (next: http://localhost:39181/tests/dromaeo/cssquery-dojo.html) 06:07:46 INFO - PROCESS | 28200 | RSS: Main: 268390400 06:07:46 INFO - PROCESS | 28200 | 06:07:46 INFO - PROCESS | 28200 | __start_tp_report 06:07:46 INFO - PROCESS | 28200 | _x_x_mozilla_page_load 06:07:46 INFO - PROCESS | 28200 | _x_x_mozilla_page_load_details 06:07:46 INFO - PROCESS | 28200 | |i|pagename|runs| 06:07:46 INFO - PROCESS | 28200 | |0;dojo.html;3112.455320318944;3149.4331020416344;3161.3993341265164;3173.412918610057;3177.062766483887;5304.416514183436;5409.24270602116;5420.159875219348;5454.34547854257;5469.206964990074;5540.390557038722;5560.332760068787;5579.9163012554845;5596.832095037145;5598.916016259749;5069.619778516617;5077.289179514871;5128.05131050755;5132.230165475171;5152.124138896396;5007.574356179711;5031.6729412588065;5121.2318152277085;5149.098907691157;5198.558122559587;4990.3762029746285;4991.850244492671;5002.099622068026;5083.79664813407;5110.6422550421485;5096.133657278272;5121.206213036985;5129.204973229155;5136.58907287418;5155.381354237478;4883.438404583448;5026.748662566857;5033.496650334937;5076.568491678212;5095.082885080684;5361.383440904307;5427.294451721251;5428.565714742811;5430.809921652763;5490.725463726838;5823.417658234185;5878.853028674317;5880.235569375954;5898.705064746746;5901.675407852566;5903.321118071433;5925.585209035369;5928.081147422156;5930.792422265243;5931.347551769302;5312.2297266896085;5331.013762453958;5423.810166644188;5448.318960129984;5477.397486276506;5971.940280597139;5990.610610310316;5998.340182579913;6001.609895356788;6041.607295525777;5730.1404789281105;5785.768569257182;5792.710364481759;5795.304563452412;5802.245708057925;5724.942750572524;5744.109663002241;5838.007538718343;5859;5861.0915308127305;5861.736221870026;5900.1739756434135;5905.645661260338;5939.70301484924;5950.672713000827;5892.94107058924;5905.114232865105;5917.289925208916;5918.348981612019;5921.526277897758;4493.932591011137;4502.144592527475;4521.095780843844;4580.8167673293365;4582;4017.91964160721;4060.5939406059156;4070.7964601769795;4082.408050832613;4093.324601440729;5723.942760572424;5724.542036637059;5734.942650573441;5740.1102829061565;5745.511631511285;5615.634983726045;5698.914516282259;5848.736806843703;5883.558733095035;5938.851528711731;5713.657180569179;5751.396103409165;5759.481646651821;5761.423857614205;5766.135079738073;5015.949840501621;5019.29729837823;5020.623453241022;5029.2958985742025;5030.572401345853;6057.757689692363;6182.381761823782;6222.471089957405;6232.688365581703;6239.96880015597;5813.534917206529;5877.85381850535;5916.556258280732;5924.140999555127;5998.310194327533;6196.096797819686;6220.595661282002;6226.159468471698;6230.59501132425;6230.59501132425;5785.9132113017495;5851.678157701367;5856.707164641665;5862.237909071793;5885.117232415172;5814.825555233349;5867.647941123546;5869.207656966255;5880.970595146997;5880.970595146997;5790.449907258803;5791.276090488689;5800.303963524404;5804.767809287581;5809.5352371811;5802.94197058024;5803.709814509342;5804.622699524517;5808.36108028125;5809.796657116981;5642.069058605448;5710.942890571041;5780.566457515619;5795.8551036224435;5837.124431335334;5864.208331875142;5869.559783016376;5870.17817505541;5875.794347197828;5880.14737863016;5698.54411647059;5719.828405147852;5741.3971532988435;5752.712364381848;5764.394738552559 06:07:46 INFO - PROCESS | 28200 | |1;ext.html;599.9820005399837;605.6699098991049;619.59106989387;626.6365508005357;659.0871642774756;35766.463503047446;46658.53341466584;47687.999999999956;47704.522954770444;47832.52167478324;48936.51063489364;49475.25787113196;49501.257481137814;49540.25689614659;49624.255636165486;8628.482291062524;8855.07021762712;9280.953595232015;9476.573554190043;9479.95260023699;10956.56173753049;11247.83128253077;11249;11558.248713833616;11583.247088939233;11278.661640150809;11305.039071678917;11340.659780206606;11348.546058157664;11354.261972971772;11235.494402751896;11314.038306743936;11327.716807079847;11381.317120972686;11403.315801051922;11127.165462590337;11193.888061119365;11201.103911687045;11214.102871770321;11218.102551795837;46339;46636.3004554932;46691.066178676236;46777.76611116923;46861.76569117133;4375.2999520076955;4378.9562104378865;4438.489573699034;4513.255312873372;4548;33972.49041264383;34649.307013859834;34672.306553869035;34752.30495390103;35707.28585428277;4240.491141063061;4288.52826189119;4361.934570981438;4376.102898905717;4429.446319210098;370502.73743156367;371557;371649;371671;372091.99999999726;61342;61506.384936150964;61647.07529387063;61834;68593;70744.23139421556;71126;71158.2884171162;71202.64398677973;71266.64366678134;19753.703694444594;20380.286689966077;20384.184632614826;20417.081231344328;20462.590748184954;13084.738305234032;13359.532416365575;15488.457903973307;15688.137152456497;15924.283407246701;18200;18627.627447451247;18677;18726;18812.52968675794;6911.1988406376295;7161.856762864713;7164.641767911584;7299.452541059336;7335.193128755833;958.5878072428923;961.5288508630721;961.6345788600287;974.0308393148862;979.3193730357333;31522.054338369886;32844.671553284636;33654;33828.32343353168;33839.66160338414;1069.4225118436113;1171.1041053594008;1178.8644305904759;1179.778928808696;1197.0722689915385;15237.923810380877;16556.50330490087;16663.416780412626;16678.833211667727;16826;561055;561394;565092;565499;567102;60966;61109.08336374958;61261.693691531254;61265;61288;1499.65507933176;1523.7638166084275;1531.6860043691017;1535.08662345904;1561.2662048837028;30331.69668303377;31521;31593;31608;31701.097934124027;48249.27626085541;48597.51402486071;48739.756301219684;48858;49007;418785;418787;419602;419735;420343;25663.743362566136;26218.21345359642;28925.42149156963;48089.75955120202;49866.75066624644;51243.48756512387;55652.44347556472;55807.16289255583;55946;56819;44434.777826110665;45220.32169517394;45308.773456132505;46221;46955;43766.56233437625;46039;46070;46427.53572464232;47119.764401177774;46928.29607555821;50524.74737626289;50576.49423505718;50912.74543627406;51959;40280.1943961125;41917.371239430824;42324.78837605792;42425.15149696927;42559;30559.694403056576;30633;30767.321448960633;31105.37789244157;31526.369472610877 06:07:46 INFO - PROCESS | 28200 | |2;jquery.html;430.25995288104457;433.26777745609934;435.92499701421247;440.5286343612334;453.89560401107724;20088.096035678394;21095.367138985817;21987.120515179373;22098;22162.445938851535;21721.456963575918;22193.55612887741;22311.330660080184;22490.32529024132;22874.428139296484;5886.146508756227;6211.192544969148;6214.65819379934;6214.8446288842915;6224.346443623423;5983.700814959257;6250.218722659668;6296.307406185339;6383.2340119185765;6388.425041746242;6396.712147953353;6411.647359395231;6417.294097649278;6565.34346565342;6917.930820691804;7029.47278954078;7086.787396378143;7087.255838136973;7099.112610923635;7104.609246491441;6174.722137503823;6320.81037568869;6365.936340636581;6372;6375.585586936834;25343.239702808944;25815.612765808528;25889.482210355876;26028.63549422941;26213.475730485476;3134.1851118709073;3205.599300087489;3224.580804495424;3302.669733026702;3303.900882973515;11287.661370158909;11593.594224202112;15549.236082304235;16691.332346706116;16709.498715038448;1972.1815446589649;2027.1485975890162;2030.522827135622;2044.7546294444612;2044.7750747417772;93630;95883.52058239664;102636.99999999926;105238;106616;12375;12456.75086498283;12716.872831271754;12735.363231838372;12982.610521684364;18224.08879556017;18371;18376.724349134773;18405.723914141297;18412.81587184138;8927.464352138762;9339.813203736023;9389.201917836925;9395.107464790834;9654.131128198496;9035;9049.963758154494;9057.637694492278;9076;9238.58426370815;5507.091329930517;5555.083411237181;5560.499555040065;5580.693061881554;5637.408072152447;2192.8793916334753;2247.2359397804826;2261.3442101790297;2267.535155293161;2275.8520696154696;939.1313035442189;940.8212439636447;949.8622699708503;973.4986481961795;975.8292298847673;20228.393148205578;21007.684884726743;21187.470313241985;21337.46656333573;21680.674789878165;968.2399316536626;968.7142293023575;969.4425705219527;974.1573538888811;991.4943378876825;11489.42552872353;11714.589989350332;11994.160408771477;12000.519979200908;12038.939805301092;687284;687482;692374;708497;710833;83420;87688;88654.55672721595;114763.42618286856;118837.40581297038;1124.0894875151155;1160.0777381981345;1164.301419148504;1169.5263418315596;1170.69561913903;18575.44273671792;19477.61044779125;19504.317348893288;19512.02439878029;19812;47160;47234.29148562843;47361;48042.5195748052;48226;65245.67377163273;65492.34507654863;66445.33554664585;66577.33556661122;66877.3312266871;8521.147885211429;9635.759106022406;9698.75753106178;9809;9908.504574771088;12474.376281185723;14719.926400368358;14740.778888316469;14951.25243737787;14999.175045372609;12038.75922481528;12200.75598488043;12303.200291980993;12417.130800843854;12777.74444511086;12123.515059397525;12192.146549741434;12231.633051008484;12513.874861251272;12657.746845062862;12191.146619736533;12382.5666101686;12560.246385216917;12627.684307892376;12813.871861281641;8278.503289802631;8805.515696636747;8909.287257019552;9128.361014728906;9779.85330220033;9541.379810312308;12132.090093243218;12332.34368239666;12399.566015189424;12572.811407829073 06:07:46 INFO - PROCESS | 28200 | |3;mootools.html;1489.1809504772386;1534.6393597504584;1541.4681934732514;1542.9691406171876;1563.593465698918;8881.911180888197;9232.538373081345;9232.8615070774;9242.584083716232;9244.768880777983;7851;8105.3110485608795;8510.617022233999;8758.211760941515;8766.079561646031;2487.2786891801356;2530.165045534969;2536.3405514566252;2537.13737329308;2537.7842883354847;2536.467341858203;2545.6945166579944;2546.0834099724084;2576.3172759218824;2593.2220333899754;2474.7030356357172;2476.1209770531473;2493.1772515070074;2518.9496210075786;2530.114459939025;2409.108629806974;2439.42673471734;2457.8156638252112;2467.9753202467923;2469.2715648883623;2448.987755061231;2461.2616215135386;2464.260721783458;2514.484530671208;2524.5203411351786;9055.728328150166;9059.048799875984;9091.454512729257;9130.726078217664;9172.724818255463;5522.751476183581;5668.829935101953;5674;5680.261565996435;5681.744321505542;3603.783772973604;3700.5559332879957;3763.303788799081;3770.547534295875;3829.9808500957597;1508.6530098077394;2087.697283893827;2133.9466513337293;2155.9892200539052;2205.283282933053;12411.255324680458;12437.129400941938;12595.559155429608;12599.622011339674;12607.873921260762;4801.4718380978065;4873.878153046202;4888.2178851383605;4953.6037117030555;4976.2286845539;9806.95096524527;9871.506424678737;9952.502374881227;9994.200463962865;10006.449645269435;5557.333120025542;5626.803061892814;5628.549716022709;5632.887342253132;5633.802816901389;4568.497465278817;4613.561711637389;5124.231365295235;5197.29836472079;5206.193040078794;3903.7072219583647;3984.940225896556;4053.3514637658423;4053.918921621551;4063.837446502107;1224.7691070474116;1227.6194379742308;1239.9070069744625;1241.596481143632;1255.0210835548287;867.3711559119588;873.5326600268826;884.8186121845006;886.1670030171747;903.3586153830854;5925.555583331267;6008.939910600925;6027.9095813562835;6141.6007959482495;6180.196574445384;648.2027106658836;667.4927055437902;673.6564352180424;689.0387908867102;691.2879733874117;3914.706397020235;3971.046948732341;3998.580149084304;4013.8795836124964;4019.31671615826;10794.136469082454;11048.226624136234;11102.777944441228;11159.107271418266;11218;10370.481475926174;10979.28634638746;11104.500297486633;11111.72220694489;11112.722181945353;8543.743687689379;8703.086175951561;8720.12798720123;8722.912770872337;8734.126587341341;5897.64614123154;5941.494972927177;6032.51504632513;6051.515878729779;6251.781187658592;9758.80482390334;9840.311178217456;9902.960189180032;9928.900710992797;9986.251031172545;9991.700248992542;10221.131203847755;10296.845547316647;10350.792984140124;10396.688099357032;7095.574265544084;7222.96388518054;7772.883406748791;7962.7213047543055;8106.310963568163;8812.779680508038;8873.467591944504;8874;8892.777680558038;8912.910870891208;7778.377729781717;7795.376369890282;7829.804254893673;7859.52842829432;7969;7848.372130229682;7869.465454236369;7894.684212631661;7896.605169741605;8030.23712747288;7021.227664956748;7024;7041.5422997505;7084.574925504487;7120.679569419285;4992.2511623256805;5014.5737612303365;5053.797848086036;5088.542031217208;5178.689278643294;5088.4148322941855;5089.13484707608;5098.668586541863;5169.612279079009;5204.791808327776 06:07:46 INFO - PROCESS | 28200 | |4;prototype.html;399.44676622877313;402.9133736246707;409.98360065597376;412.8596277265729;418.6483353982654;5312.867178320544;5355.28630838132;5392.164214546741;5394.595405344605;5410.188471729238;5093.949060509393;5181.326427564421;5229.294045303883;5340.1430234824375;5344.759485823138;4304.536457604414;4307.203167414023;4315.33112367582;4324.589164029412;4334.349847522881;4309.461317335333;4335.934960975572;4340.631046361063;4345.261305578059;4354;4164.7709375984305;4253.489581250239;4319.956800431987;4322.632576231024;4334;4247.68142389322;4283.293256612656;4286.699931004831;4301.118270754488;4305.332673435607;3886.5724770275247;3891.1633998690418;3892.5402973884793;3896.3960586109197;3907.98046009771;5035.194368900959;5134.101532231844;5169.224616307546;5205.869853253661;5212.739363031871;4856.68431551948;4886.143265559065;4896.657233993622;4905.215165573527;4917.311576379309;5554.444555544454;5561.944380556223;5563.499285064364;5569.164625306196;5573.164025396182;4087.9795601021806;4261.254280500931;4263.59495847894;4274.893127671802;4278.101598664284;5472.644278121949;5627.606067575312;5688.60179787415;5747.56893233005;5755.625884317506;4296.849610263625;4384.56154384559;4392.626626736763;4397.31841564558;4404.647628189737;4465.486469056035;4478.820847166142;4500.729956202638;4502.649205238416;4505.81976720934;4664.720116793003;4727.669063165546;4792.400949881265;4919.2867034279825;4955.628327875424;5566.832995010156;5568.49883510486;5568.860778480571;5594.944050559442;5623.240862483594;1494.8505149484965;1500.7748837674437;1504.4433559583024;1509.3811537269667;1521.6043828604643;960.5016174767385;994.5027486256871;998.6205242007991;1014.5383850348074;1071.9035286824067;5182.870428239325;5257.921131183035;5273.472652734773;5274.92087618686;5281.471852814765;5432.049391356497;5487.972560137174;5515.944840551543;5535;5586.636868603528;5059.443461219263;5250.789968401221;5289.9471005290225;5297.311349524614;5337.332833395825;2890.6531216254184;2892.3492214251623;2907.360380716239;2911.505044142501;2918.7373136417823;5455.290812194389;5673.914891276634;5699.458551437607;5724.33818274496;5743.425657434307;5533.644257156941;5549.944500554942;5567.638103523258;5572.721363931787;5576.498115169654;5685.77256909719;5689.789555728731;5706.657600543981;5728.914066289009;5750.482456578928;5290.391604965478;5434.2935418395355;5477.863053423537;5479.726013699379;5497.202905578749;5301.6818990860675;5338.3060202173465;5373.731313434235;5389.83830485086;5393.599848067573;5727.8568035799435;5755.3093628763145;5895.995361576913;5925;5987.550933679904;4182.728122672017;4183.477065366829;4193.266178418704;4204.8528301509305;4220.514640816223;5522.641028333145;5678.4605462480995;5729.684867332337;5785.30576330843;5804.448577385142;5463.289772329572;5492.457364999473;5494.642848214853;5538.972305138448;5562.3047119110115;5486.214511986716;5504.587155963399;5560.249366335493;5573.442655734394;5599.916001260066;5375.516203541543;5445.727713614383;5497.065498865282;5527.806526771544;5533.501984821224;5519.751611177427;5526.723663816873;5532.114861622121;5538.723063846872;5579.69311687861;5196.220566914993;5445.09421702401;5458;5503.284573005483;5512.80705175317 06:07:46 INFO - PROCESS | 28200 | |5;yui.html;830.2610676497918;856.3962406503416;859.3383095016837;895.9104089591042;935.0836180543065;16476.505704828858;17308.91345543272;17927.551811204725;17953.28186872527;18409.44771656849;15994.120323382209;16169.838301616981;16171.91914040431;16538.586535336624;16547.25537350819;802.5866678660494;816.742726041298;819.2626636027563;819.3895547816855;819.8852160697508;695.6695569604448;713.3722324354561;792.8969233999572;807.4791759315267;817.3787921179886;860.5052095045343;861.0485413617956;862.5687156421789;862.6678728689468;862.8705694145897;849.2059923971045;849.6516428264382;851.1445996773265;851.3019324154196;852.5992783391796;529.1031701266355;539.2908325551887;540.9323834520685;625.3402660193494;626.6929204689715;13619.455221791215;15759.92120039404;16230.431934882223;16483.91758041214;17126.82873171265;16728.41450549225;16959.406420775213;16988.830111698848;17038.847223392608;17337.913310433367;13077.280749558771;13082.411291491906;13167.078304518687;13262.137961032502;13562.59312220635;4046.3930410438375;4073.8574149904907;4133.256013917494;4157.875263742093;4223.324268117117;67784.32215677878;74476.25523744748;84255;85600.57199714024;86819.56590217071;12297.631071067883;12912.16070955385;12961.41673624689;13051.934740326427;13236.669083272802;23563.23275754291;23812.64281035786;23957;24080.7591924082;24148.758512415003;9091.772705682411;9163.129502697366;9222.44665320083;9319.207867331217;9366.110219529133;4944.3572335596145;4994.675346102492;5039.899202015939;5053.69677819332;5084.186530155157;3895.5130608673917;3998.6401223889407;4046.77742724153;4059.411385349108;4062.6952978526137;686.0943554508101;688.8828899087067;691.9654017299115;699.5348093517754;707.0596107177441;829.088003196479;835.2023817254508;847.8050048488882;867.5271976772674;884.0143240287163;10537.683869483928;10691.465426728633;10882.455877206108;11178.832317515244;11242.831357529643;826.7478419082238;829.5561874397168;829.6805729793952;845.3533047218882;846.4244313866507;5155.690658560498;5179.45615710345;5189.091908916;5216.295800066942;5232;63744.36255637477;69639.65180174066;72394;82902.58548707339;85347;70935.29064709287;72168.63915680493;72750;72750.63624681842;75493;63417.36582634115;65561;65656;65856;68106.65946670235;9428.15146636806;9761.36011747199;9774.12032917041;9803.607855685692;9861.802763944825;44199;44652.55347446484;45203.54796451993;45276.094478110914;46248.30627540522;52624.73687631537;55112.72443637756;55737.442625573225;56237.43762562322;57380;12441.440135193758;12585.24488530691;12672.176308539916;12712.364381781059;12936;13532;13619.86380136186;13762.380692869045;13772;14155.858441415454;13204;13242.53651122206;13260.933695331461;13504.122232055279;13723.794143087662;12312.692182695504;12360.690982725504;12400.131990760921;13045.478180872658;13069.477220911058;12842.871571284168;12942.288174150512;13234.073614846868;13234.139780914209;13284.601461956157;10528.684139475828;10755.139588833032;11165.218434709492;11209.383483908463;11250.549978000789;9490.481522956294;10341.145561730462;10573.9471302643;10713.250072494851;10829.350238985686 06:07:46 INFO - PROCESS | 28200 | __end_tp_report 06:07:46 INFO - PROCESS | 28200 | __start_cc_report 06:07:46 INFO - PROCESS | 28200 | _x_x_mozilla_cycle_collect,932 06:07:46 INFO - PROCESS | 28200 | __end_cc_report 06:07:46 INFO - PROCESS | 28200 | __startTimestamp1487167666147__endTimestamp 06:07:46 INFO - PROCESS | 28200 | 06:07:46 INFO - PROCESS | 28200 | ------- Summary: start ------- 06:07:46 INFO - PROCESS | 28200 | Number of tests: 6 06:07:46 INFO - PROCESS | 28200 | 06:07:46 INFO - PROCESS | 28200 | [#0] dojo.html Cycles:165 Average:5499.23 Median:5752.71 stddev:625.66 (10.9%) stddev-sans-first:598.91 06:07:46 INFO - PROCESS | 28200 | Values: 3112.5 3149.4 3161.4 3173.4 3177.1 5304.4 5409.2 5420.2 5454.3 5469.2 5540.4 5560.3 5579.9 5596.8 5598.9 5069.6 5077.3 5128.1 5132.2 5152.1 5007.6 5031.7 5121.2 5149.1 5198.6 4990.4 4991.9 5002.1 5083.8 5110.6 5096.1 5121.2 5129.2 5136.6 5155.4 4883.4 5026.7 5033.5 5076.6 5095.1 5361.4 5427.3 5428.6 5430.8 5490.7 5823.4 5878.9 5880.2 5898.7 5901.7 5903.3 5925.6 5928.1 5930.8 5931.3 5312.2 5331.0 5423.8 5448.3 5477.4 5971.9 5990.6 5998.3 6001.6 6041.6 5730.1 5785.8 5792.7 5795.3 5802.2 5724.9 5744.1 5838.0 5859.0 5861.1 5861.7 5900.2 5905.6 5939.7 5950.7 5892.9 5905.1 5917.3 5918.3 5921.5 4493.9 4502.1 4521.1 4580.8 4582.0 4017.9 4060.6 4070.8 4082.4 4093.3 5723.9 5724.5 5734.9 5740.1 5745.5 5615.6 5698.9 5848.7 5883.6 5938.9 5713.7 5751.4 5759.5 5761.4 5766.1 5015.9 5019.3 5020.6 5029.3 5030.6 6057.8 6182.4 6222.5 6232.7 6240.0 5813.5 5877.9 5916.6 5924.1 5998.3 6196.1 6220.6 6226.2 6230.6 6230.6 5785.9 5851.7 5856.7 5862.2 5885.1 5814.8 5867.6 5869.2 5881.0 5881.0 5790.4 5791.3 5800.3 5804.8 5809.5 5802.9 5803.7 5804.6 5808.4 5809.8 5642.1 5710.9 5780.6 5795.9 5837.1 5864.2 5869.6 5870.2 5875.8 5880.1 5698.5 5719.8 5741.4 5752.7 5764.4 06:07:46 INFO - PROCESS | 28200 | 06:07:46 INFO - PROCESS | 28200 | [#1] ext.html Cycles:180 Average:63590.98 Median:4325.23 stddev:121375.66 (2806.2%) stddev-sans-first:121624.01 06:07:46 INFO - PROCESS | 28200 | Values: 600.0 605.7 619.6 626.6 659.1 35766.5 46658.5 47688.0 47704.5 47832.5 48936.5 49475.3 49501.3 49540.3 49624.3 8628.5 8855.1 9281.0 9476.6 9480.0 10956.6 11247.8 11249.0 11558.2 11583.2 11278.7 11305.0 11340.7 11348.5 11354.3 11235.5 11314.0 11327.7 11381.3 11403.3 11127.2 11193.9 11201.1 11214.1 11218.1 46339.0 46636.3 46691.1 46777.8 46861.8 4375.3 4379.0 4438.5 4513.3 4548.0 33972.5 34649.3 34672.3 34752.3 35707.3 4240.5 4288.5 4361.9 4376.1 4429.4 370502.7 371557.0 371649.0 371671.0 372092.0 61342.0 61506.4 61647.1 61834.0 68593.0 70744.2 71126.0 71158.3 71202.6 71266.6 19753.7 20380.3 20384.2 20417.1 20462.6 13084.7 13359.5 15488.5 15688.1 15924.3 18200.0 18627.6 18677.0 18726.0 18812.5 6911.2 7161.9 7164.6 7299.5 7335.2 958.6 961.5 961.6 974.0 979.3 31522.1 32844.7 33654.0 33828.3 33839.7 1069.4 1171.1 1178.9 1179.8 1197.1 15237.9 16556.5 16663.4 16678.8 16826.0 561055.0 561394.0 565092.0 565499.0 567102.0 60966.0 61109.1 61261.7 61265.0 61288.0 1499.7 1523.8 1531.7 1535.1 1561.3 30331.7 31521.0 31593.0 31608.0 31701.1 48249.3 48597.5 48739.8 48858.0 49007.0 418785.0 418787.0 419602.0 419735.0 420343.0 25663.7 26218.2 28925.4 48089.8 49866.8 51243.5 55652.4 55807.2 55946.0 56819.0 44434.8 45220.3 45308.8 46221.0 46955.0 43766.6 46039.0 46070.0 46427.5 47119.8 46928.3 50524.7 50576.5 50912.7 51959.0 40280.2 41917.4 42324.8 42425.2 42559.0 30559.7 30633.0 30767.3 31105.4 31526.4 06:07:46 INFO - PROCESS | 28200 | 06:07:46 INFO - PROCESS | 28200 | [#2] jquery.html Cycles:180 Average:36864.35 Median:3215.09 stddev:114445.92 (3559.6%) stddev-sans-first:114734.27 06:07:46 INFO - PROCESS | 28200 | Values: 430.3 433.3 435.9 440.5 453.9 20088.1 21095.4 21987.1 22098.0 22162.4 21721.5 22193.6 22311.3 22490.3 22874.4 5886.1 6211.2 6214.7 6214.8 6224.3 5983.7 6250.2 6296.3 6383.2 6388.4 6396.7 6411.6 6417.3 6565.3 6917.9 7029.5 7086.8 7087.3 7099.1 7104.6 6174.7 6320.8 6365.9 6372.0 6375.6 25343.2 25815.6 25889.5 26028.6 26213.5 3134.2 3205.6 3224.6 3302.7 3303.9 11287.7 11593.6 15549.2 16691.3 16709.5 1972.2 2027.1 2030.5 2044.8 2044.8 93630.0 95883.5 102637.0 105238.0 106616.0 12375.0 12456.8 12716.9 12735.4 12982.6 18224.1 18371.0 18376.7 18405.7 18412.8 8927.5 9339.8 9389.2 9395.1 9654.1 9035.0 9050.0 9057.6 9076.0 9238.6 5507.1 5555.1 5560.5 5580.7 5637.4 2192.9 2247.2 2261.3 2267.5 2275.9 939.1 940.8 949.9 973.5 975.8 20228.4 21007.7 21187.5 21337.5 21680.7 968.2 968.7 969.4 974.2 991.5 11489.4 11714.6 11994.2 12000.5 12038.9 687284.0 687482.0 692374.0 708497.0 710833.0 83420.0 87688.0 88654.6 114763.4 118837.4 1124.1 1160.1 1164.3 1169.5 1170.7 18575.4 19477.6 19504.3 19512.0 19812.0 47160.0 47234.3 47361.0 48042.5 48226.0 65245.7 65492.3 66445.3 66577.3 66877.3 8521.1 9635.8 9698.8 9809.0 9908.5 12474.4 14719.9 14740.8 14951.3 14999.2 12038.8 12200.8 12303.2 12417.1 12777.7 12123.5 12192.1 12231.6 12513.9 12657.7 12191.1 12382.6 12560.2 12627.7 12813.9 8278.5 8805.5 8909.3 9128.4 9779.9 9541.4 12132.1 12332.3 12399.6 12572.8 06:07:46 INFO - PROCESS | 28200 | 06:07:46 INFO - PROCESS | 28200 | [#3] mootools.html Cycles:180 Average:5923.42 Median:5174.15 stddev:3279.21 (63.4%) stddev-sans-first:3271.47 06:07:46 INFO - PROCESS | 28200 | Values: 1489.2 1534.6 1541.5 1543.0 1563.6 8881.9 9232.5 9232.9 9242.6 9244.8 7851.0 8105.3 8510.6 8758.2 8766.1 2487.3 2530.2 2536.3 2537.1 2537.8 2536.5 2545.7 2546.1 2576.3 2593.2 2474.7 2476.1 2493.2 2518.9 2530.1 2409.1 2439.4 2457.8 2468.0 2469.3 2449.0 2461.3 2464.3 2514.5 2524.5 9055.7 9059.0 9091.5 9130.7 9172.7 5522.8 5668.8 5674.0 5680.3 5681.7 3603.8 3700.6 3763.3 3770.5 3830.0 1508.7 2087.7 2133.9 2156.0 2205.3 12411.3 12437.1 12595.6 12599.6 12607.9 4801.5 4873.9 4888.2 4953.6 4976.2 9807.0 9871.5 9952.5 9994.2 10006.4 5557.3 5626.8 5628.5 5632.9 5633.8 4568.5 4613.6 5124.2 5197.3 5206.2 3903.7 3984.9 4053.4 4053.9 4063.8 1224.8 1227.6 1239.9 1241.6 1255.0 867.4 873.5 884.8 886.2 903.4 5925.6 6008.9 6027.9 6141.6 6180.2 648.2 667.5 673.7 689.0 691.3 3914.7 3971.0 3998.6 4013.9 4019.3 10794.1 11048.2 11102.8 11159.1 11218.0 10370.5 10979.3 11104.5 11111.7 11112.7 8543.7 8703.1 8720.1 8722.9 8734.1 5897.6 5941.5 6032.5 6051.5 6251.8 9758.8 9840.3 9903.0 9928.9 9986.3 9991.7 10221.1 10296.8 10350.8 10396.7 7095.6 7223.0 7772.9 7962.7 8106.3 8812.8 8873.5 8874.0 8892.8 8912.9 7778.4 7795.4 7829.8 7859.5 7969.0 7848.4 7869.5 7894.7 7896.6 8030.2 7021.2 7024.0 7041.5 7084.6 7120.7 4992.3 5014.6 5053.8 5088.5 5178.7 5088.4 5089.1 5098.7 5169.6 5204.8 06:07:46 INFO - PROCESS | 28200 | 06:07:46 INFO - PROCESS | 28200 | [#4] prototype.html Cycles:180 Average:4702.94 Median:5299.50 stddev:1309.74 (24.7%) stddev-sans-first:1272.96 06:07:46 INFO - PROCESS | 28200 | Values: 399.4 402.9 410.0 412.9 418.6 5312.9 5355.3 5392.2 5394.6 5410.2 5093.9 5181.3 5229.3 5340.1 5344.8 4304.5 4307.2 4315.3 4324.6 4334.3 4309.5 4335.9 4340.6 4345.3 4354.0 4164.8 4253.5 4320.0 4322.6 4334.0 4247.7 4283.3 4286.7 4301.1 4305.3 3886.6 3891.2 3892.5 3896.4 3908.0 5035.2 5134.1 5169.2 5205.9 5212.7 4856.7 4886.1 4896.7 4905.2 4917.3 5554.4 5561.9 5563.5 5569.2 5573.2 4088.0 4261.3 4263.6 4274.9 4278.1 5472.6 5627.6 5688.6 5747.6 5755.6 4296.8 4384.6 4392.6 4397.3 4404.6 4465.5 4478.8 4500.7 4502.6 4505.8 4664.7 4727.7 4792.4 4919.3 4955.6 5566.8 5568.5 5568.9 5594.9 5623.2 1494.9 1500.8 1504.4 1509.4 1521.6 960.5 994.5 998.6 1014.5 1071.9 5182.9 5257.9 5273.5 5274.9 5281.5 5432.0 5488.0 5515.9 5535.0 5586.6 5059.4 5250.8 5289.9 5297.3 5337.3 2890.7 2892.3 2907.4 2911.5 2918.7 5455.3 5673.9 5699.5 5724.3 5743.4 5533.6 5549.9 5567.6 5572.7 5576.5 5685.8 5689.8 5706.7 5728.9 5750.5 5290.4 5434.3 5477.9 5479.7 5497.2 5301.7 5338.3 5373.7 5389.8 5393.6 5727.9 5755.3 5896.0 5925.0 5987.6 4182.7 4183.5 4193.3 4204.9 4220.5 5522.6 5678.5 5729.7 5785.3 5804.4 5463.3 5492.5 5494.6 5539.0 5562.3 5486.2 5504.6 5560.2 5573.4 5599.9 5375.5 5445.7 5497.1 5527.8 5533.5 5519.8 5526.7 5532.1 5538.7 5579.7 5196.2 5445.1 5458.0 5503.3 5512.8 06:07:46 INFO - PROCESS | 28200 | 06:07:46 INFO - PROCESS | 28200 | [#5] yui.html Cycles:180 Average:18131.76 Median:5017.29 stddev:22729.06 (453.0%) stddev-sans-first:22755.69 06:07:46 INFO - PROCESS | 28200 | Values: 830.3 856.4 859.3 895.9 935.1 16476.5 17308.9 17927.6 17953.3 18409.4 15994.1 16169.8 16171.9 16538.6 16547.3 802.6 816.7 819.3 819.4 819.9 695.7 713.4 792.9 807.5 817.4 860.5 861.0 862.6 862.7 862.9 849.2 849.7 851.1 851.3 852.6 529.1 539.3 540.9 625.3 626.7 13619.5 15759.9 16230.4 16483.9 17126.8 16728.4 16959.4 16988.8 17038.8 17337.9 13077.3 13082.4 13167.1 13262.1 13562.6 4046.4 4073.9 4133.3 4157.9 4223.3 67784.3 74476.3 84255.0 85600.6 86819.6 12297.6 12912.2 12961.4 13051.9 13236.7 23563.2 23812.6 23957.0 24080.8 24148.8 9091.8 9163.1 9222.4 9319.2 9366.1 4944.4 4994.7 5039.9 5053.7 5084.2 3895.5 3998.6 4046.8 4059.4 4062.7 686.1 688.9 692.0 699.5 707.1 829.1 835.2 847.8 867.5 884.0 10537.7 10691.5 10882.5 11178.8 11242.8 826.7 829.6 829.7 845.4 846.4 5155.7 5179.5 5189.1 5216.3 5232.0 63744.4 69639.7 72394.0 82902.6 85347.0 70935.3 72168.6 72750.0 72750.6 75493.0 63417.4 65561.0 65656.0 65856.0 68106.7 9428.2 9761.4 9774.1 9803.6 9861.8 44199.0 44652.6 45203.5 45276.1 46248.3 52624.7 55112.7 55737.4 56237.4 57380.0 12441.4 12585.2 12672.2 12712.4 12936.0 13532.0 13619.9 13762.4 13772.0 14155.9 13204.0 13242.5 13260.9 13504.1 13723.8 12312.7 12360.7 12400.1 13045.5 13069.5 12842.9 12942.3 13234.1 13234.1 13284.6 10528.7 10755.1 11165.2 11209.4 11250.5 9490.5 10341.1 10573.9 10713.3 10829.4 06:07:46 INFO - PROCESS | 28200 | -------- Summary: end -------- 06:07:46 INFO - PROCESS | 28200 | 06:07:46 INFO - TEST-INFO | 28200: exit 0 06:07:46 INFO - TEST-OK | dromaeo_css | took 1114493ms 06:07:46 INFO - TEST-START | kraken 06:07:46 INFO - operating with platform_type : linux_ 06:07:46 INFO - Initialising browser for kraken test... 06:07:46 INFO - TEST-INFO | started process 28519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq4HZuK/profile http://localhost:39181/getInfo.html) 06:07:51 INFO - PROCESS | 28519 | __metrics Screen width/height:1600/1200 06:07:51 INFO - PROCESS | 28519 | colorDepth:24 06:07:51 INFO - PROCESS | 28519 | Browser inner width/height: 1024/697 06:07:51 INFO - PROCESS | 28519 | __metrics 06:07:51 INFO - PROCESS | 28519 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:07:51 INFO - PROCESS | 28519 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:07:52 INFO - TEST-INFO | 28519: exit 0 06:07:52 INFO - Browser initialized. 06:07:52 INFO - Running cycle 1/1 for kraken test... 06:07:52 INFO - TEST-INFO | started process 28610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq4HZuK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:04 INFO - PROCESS | 28610 | RSS: Main: 138600448 06:08:04 INFO - PROCESS | 28610 | 06:08:07 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39181/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:08 INFO - PROCESS | 28610 | RSS: Main: 182603776 06:08:08 INFO - PROCESS | 28610 | 06:08:10 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39181/tests/kraken/driver.html?testName=audio-dft) 06:08:11 INFO - PROCESS | 28610 | RSS: Main: 172347392 06:08:11 INFO - PROCESS | 28610 | 06:08:14 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39181/tests/kraken/driver.html?testName=audio-fft) 06:08:14 INFO - PROCESS | 28610 | RSS: Main: 264212480 06:08:14 INFO - PROCESS | 28610 | 06:08:16 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39181/tests/kraken/driver.html?testName=audio-oscillator) 06:08:17 INFO - PROCESS | 28610 | RSS: Main: 169803776 06:08:17 INFO - PROCESS | 28610 | 06:08:19 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39181/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:19 INFO - PROCESS | 28610 | RSS: Main: 172806144 06:08:19 INFO - PROCESS | 28610 | 06:08:22 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39181/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:23 INFO - PROCESS | 28610 | RSS: Main: 210837504 06:08:23 INFO - PROCESS | 28610 | 06:08:26 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39181/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:27 INFO - PROCESS | 28610 | RSS: Main: 210362368 06:08:27 INFO - PROCESS | 28610 | 06:08:30 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39181/tests/kraken/driver.html?testName=json-parse-financial) 06:08:30 INFO - PROCESS | 28610 | RSS: Main: 208596992 06:08:30 INFO - PROCESS | 28610 | 06:08:32 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39181/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:32 INFO - PROCESS | 28610 | RSS: Main: 170856448 06:08:32 INFO - PROCESS | 28610 | 06:08:34 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:35 INFO - PROCESS | 28610 | RSS: Main: 178049024 06:08:35 INFO - PROCESS | 28610 | 06:08:37 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:37 INFO - PROCESS | 28610 | RSS: Main: 187195392 06:08:37 INFO - PROCESS | 28610 | 06:08:40 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:41 INFO - PROCESS | 28610 | RSS: Main: 196530176 06:08:41 INFO - PROCESS | 28610 | 06:08:43 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:44 INFO - PROCESS | 28610 | RSS: Main: 192974848 06:08:44 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | Cycle 1(1): loaded http://localhost:39181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39181/tests/kraken/driver.html?testName=ai-astar) 06:08:46 INFO - PROCESS | 28610 | RSS: Main: 245174272 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | __start_tp_report 06:08:46 INFO - PROCESS | 28610 | _x_x_mozilla_page_load 06:08:46 INFO - PROCESS | 28610 | _x_x_mozilla_page_load_details 06:08:46 INFO - PROCESS | 28610 | |i|pagename|runs| 06:08:46 INFO - PROCESS | 28610 | |0;ai-astar;103;113;111;115;112;114;112;112;112;112 06:08:46 INFO - PROCESS | 28610 | |1;audio-beat-detection;149;119;118;158;121;119;120;117;134;120 06:08:46 INFO - PROCESS | 28610 | |2;audio-dft;162;161;161;161;161;162;159;162;161;161 06:08:46 INFO - PROCESS | 28610 | |3;audio-fft;76;76;75;117;75;75;75;74;91;74 06:08:46 INFO - PROCESS | 28610 | |4;audio-oscillator;83;83;104;84;84;84;96;83;83;108 06:08:46 INFO - PROCESS | 28610 | |5;imaging-gaussian-blur;118;116;117;118;117;117;117;118;117;117 06:08:46 INFO - PROCESS | 28610 | |6;imaging-darkroom;147;147;148;147;148;147;147;147;146;147 06:08:46 INFO - PROCESS | 28610 | |7;imaging-desaturate;96;96;96;95;95;95;96;95;96;96 06:08:46 INFO - PROCESS | 28610 | |8;json-parse-financial;50;48;49;49;49;49;49;48;48;50 06:08:46 INFO - PROCESS | 28610 | |9;json-stringify-tinderbox;63;64;64;63;65;64;65;65;64;65 06:08:46 INFO - PROCESS | 28610 | |10;stanford-crypto-aes;77;79;82;83;77;80;79;84;79;76 06:08:46 INFO - PROCESS | 28610 | |11;stanford-crypto-ccm;123;122;123;127;125;128;118;119;161;125 06:08:46 INFO - PROCESS | 28610 | |12;stanford-crypto-pbkdf2;162;165;161;165;158;159;157;160;166;164 06:08:46 INFO - PROCESS | 28610 | |13;stanford-crypto-sha256-iterative;64;62;65;63;62;65;63;61;60;65 06:08:46 INFO - PROCESS | 28610 | __end_tp_report 06:08:46 INFO - PROCESS | 28610 | __start_cc_report 06:08:46 INFO - PROCESS | 28610 | _x_x_mozilla_cycle_collect,1517 06:08:46 INFO - PROCESS | 28610 | __end_cc_report 06:08:46 INFO - PROCESS | 28610 | __startTimestamp1487167726382__endTimestamp 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | ------- Summary: start ------- 06:08:46 INFO - PROCESS | 28610 | Number of tests: 14 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:3.24 (2.9%) stddev-sans-first:1.24 06:08:46 INFO - PROCESS | 28610 | Values: 103.0 113.0 111.0 115.0 112.0 114.0 112.0 112.0 112.0 112.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:120.50 stddev:14.66 (12.2%) stddev-sans-first:13.33 06:08:46 INFO - PROCESS | 28610 | Values: 149.0 119.0 118.0 158.0 121.0 119.0 120.0 117.0 134.0 120.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 06:08:46 INFO - PROCESS | 28610 | Values: 162.0 161.0 161.0 161.0 161.0 162.0 159.0 162.0 161.0 161.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:13.69 (18.3%) stddev-sans-first:14.41 06:08:46 INFO - PROCESS | 28610 | Values: 76.0 76.0 75.0 117.0 75.0 75.0 75.0 74.0 91.0 74.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:83.50 stddev:9.74 (11.7%) stddev-sans-first:10.07 06:08:46 INFO - PROCESS | 28610 | Values: 83.0 83.0 104.0 84.0 84.0 84.0 96.0 83.0 83.0 108.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 06:08:46 INFO - PROCESS | 28610 | Values: 118.0 116.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 06:08:46 INFO - PROCESS | 28610 | Values: 147.0 147.0 148.0 147.0 148.0 147.0 147.0 147.0 146.0 147.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:08:46 INFO - PROCESS | 28610 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.00 stddev:0.74 (1.5%) stddev-sans-first:0.67 06:08:46 INFO - PROCESS | 28610 | Values: 50.0 48.0 49.0 49.0 49.0 49.0 49.0 48.0 48.0 50.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 06:08:46 INFO - PROCESS | 28610 | Values: 63.0 64.0 64.0 63.0 65.0 64.0 65.0 65.0 64.0 65.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:2.67 (3.4%) stddev-sans-first:2.67 06:08:46 INFO - PROCESS | 28610 | Values: 77.0 79.0 82.0 83.0 77.0 80.0 79.0 84.0 79.0 76.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:125.00 stddev:12.32 (9.9%) stddev-sans-first:12.98 06:08:46 INFO - PROCESS | 28610 | Values: 123.0 122.0 123.0 127.0 125.0 128.0 118.0 119.0 161.0 125.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:163.00 stddev:3.20 (2.0%) stddev-sans-first:3.39 06:08:46 INFO - PROCESS | 28610 | Values: 162.0 165.0 161.0 165.0 158.0 159.0 157.0 160.0 166.0 164.0 06:08:46 INFO - PROCESS | 28610 | 06:08:46 INFO - PROCESS | 28610 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:1.76 (2.8%) stddev-sans-first:1.83 06:08:46 INFO - PROCESS | 28610 | Values: 64.0 62.0 65.0 63.0 62.0 65.0 63.0 61.0 60.0 65.0 06:08:46 INFO - PROCESS | 28610 | -------- Summary: end -------- 06:08:46 INFO - PROCESS | 28610 | 06:08:47 INFO - TEST-INFO | 28610: exit 0 06:08:47 INFO - TEST-OK | kraken | took 60481ms 06:08:47 INFO - SUITE-END | took 1174s 06:08:47 INFO - Completed test suite (00:19:35) 06:08:47 INFO - javascript benchmark 06:08:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.455320318944, 3149.4331020416344, 3161.3993341265164, 3173.412918610057, 3177.062766483887, 5304.416514183436, 5409.24270602116, 5420.159875219348, 5454.34547854257, 5469.206964990074, 5540.390557038722, 5560.332760068787, 5579.9163012554845, 5596.832095037145, 5598.916016259749, 5069.619778516617, 5077.289179514871, 5128.05131050755, 5132.230165475171, 5152.124138896396, 5007.574356179711, 5031.6729412588065, 5121.2318152277085, 5149.098907691157, 5198.558122559587, 4990.3762029746285, 4991.850244492671, 5002.099622068026, 5083.79664813407, 5110.6422550421485, 5096.133657278272, 5121.206213036985, 5129.204973229155, 5136.58907287418, 5155.381354237478, 4883.438404583448, 5026.748662566857, 5033.496650334937, 5076.568491678212, 5095.082885080684, 5361.383440904307, 5427.294451721251, 5428.565714742811, 5430.809921652763, 5490.725463726838, 5823.417658234185, 5878.853028674317, 5880.235569375954, 5898.705064746746, 5901.675407852566, 5903.321118071433, 5925.585209035369, 5928.081147422156, 5930.792422265243, 5931.347551769302, 5312.2297266896085, 5331.013762453958, 5423.810166644188, 5448.318960129984, 5477.397486276506, 5971.940280597139, 5990.610610310316, 5998.340182579913, 6001.609895356788, 6041.607295525777, 5730.1404789281105, 5785.768569257182, 5792.710364481759, 5795.304563452412, 5802.245708057925, 5724.942750572524, 5744.109663002241, 5838.007538718343, 5859.0, 5861.0915308127305, 5861.736221870026, 5900.1739756434135, 5905.645661260338, 5939.70301484924, 5950.672713000827, 5892.94107058924, 5905.114232865105, 5917.289925208916, 5918.348981612019, 5921.526277897758, 4493.932591011137, 4502.144592527475, 4521.095780843844, 4580.8167673293365, 4582.0, 4017.91964160721, 4060.5939406059156, 4070.7964601769795, 4082.408050832613, 4093.324601440729, 5723.942760572424, 5724.542036637059, 5734.942650573441, 5740.1102829061565, 5745.511631511285, 5615.634983726045, 5698.914516282259, 5848.736806843703, 5883.558733095035, 5938.851528711731, 5713.657180569179, 5751.396103409165, 5759.481646651821, 5761.423857614205, 5766.135079738073, 5015.949840501621, 5019.29729837823, 5020.623453241022, 5029.2958985742025, 5030.572401345853, 6057.757689692363, 6182.381761823782, 6222.471089957405, 6232.688365581703, 6239.96880015597, 5813.534917206529, 5877.85381850535, 5916.556258280732, 5924.140999555127, 5998.310194327533, 6196.096797819686, 6220.595661282002, 6226.159468471698, 6230.59501132425, 6230.59501132425, 5785.9132113017495, 5851.678157701367, 5856.707164641665, 5862.237909071793, 5885.117232415172, 5814.825555233349, 5867.647941123546, 5869.207656966255, 5880.970595146997, 5880.970595146997, 5790.449907258803, 5791.276090488689, 5800.303963524404, 5804.767809287581, 5809.5352371811, 5802.94197058024, 5803.709814509342, 5804.622699524517, 5808.36108028125, 5809.796657116981, 5642.069058605448, 5710.942890571041, 5780.566457515619, 5795.8551036224435, 5837.124431335334, 5864.208331875142, 5869.559783016376, 5870.17817505541, 5875.794347197828, 5880.14737863016, 5698.54411647059, 5719.828405147852, 5741.3971532988435, 5752.712364381848, 5764.394738552559], "value": 5456.516073852685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.9820005399837, 605.6699098991049, 619.59106989387, 626.6365508005357, 659.0871642774756, 35766.463503047446, 46658.53341466584, 47687.999999999956, 47704.522954770444, 47832.52167478324, 48936.51063489364, 49475.25787113196, 49501.257481137814, 49540.25689614659, 49624.255636165486, 8628.482291062524, 8855.07021762712, 9280.953595232015, 9476.573554190043, 9479.95260023699, 10956.56173753049, 11247.83128253077, 11249.0, 11558.248713833616, 11583.247088939233, 11278.661640150809, 11305.039071678917, 11340.659780206606, 11348.546058157664, 11354.261972971772, 11235.494402751896, 11314.038306743936, 11327.716807079847, 11381.317120972686, 11403.315801051922, 11127.165462590337, 11193.888061119365, 11201.103911687045, 11214.102871770321, 11218.102551795837, 46339.0, 46636.3004554932, 46691.066178676236, 46777.76611116923, 46861.76569117133, 4375.2999520076955, 4378.9562104378865, 4438.489573699034, 4513.255312873372, 4548.0, 33972.49041264383, 34649.307013859834, 34672.306553869035, 34752.30495390103, 35707.28585428277, 4240.491141063061, 4288.52826189119, 4361.934570981438, 4376.102898905717, 4429.446319210098, 370502.73743156367, 371557.0, 371649.0, 371671.0, 372091.99999999726, 61342.0, 61506.384936150964, 61647.07529387063, 61834.0, 68593.0, 70744.23139421556, 71126.0, 71158.2884171162, 71202.64398677973, 71266.64366678134, 19753.703694444594, 20380.286689966077, 20384.184632614826, 20417.081231344328, 20462.590748184954, 13084.738305234032, 13359.532416365575, 15488.457903973307, 15688.137152456497, 15924.283407246701, 18200.0, 18627.627447451247, 18677.0, 18726.0, 18812.52968675794, 6911.1988406376295, 7161.856762864713, 7164.641767911584, 7299.452541059336, 7335.193128755833, 958.5878072428923, 961.5288508630721, 961.6345788600287, 974.0308393148862, 979.3193730357333, 31522.054338369886, 32844.671553284636, 33654.0, 33828.32343353168, 33839.66160338414, 1069.4225118436113, 1171.1041053594008, 1178.8644305904759, 1179.778928808696, 1197.0722689915385, 15237.923810380877, 16556.50330490087, 16663.416780412626, 16678.833211667727, 16826.0, 561055.0, 561394.0, 565092.0, 565499.0, 567102.0, 60966.0, 61109.08336374958, 61261.693691531254, 61265.0, 61288.0, 1499.65507933176, 1523.7638166084275, 1531.6860043691017, 1535.08662345904, 1561.2662048837028, 30331.69668303377, 31521.0, 31593.0, 31608.0, 31701.097934124027, 48249.27626085541, 48597.51402486071, 48739.756301219684, 48858.0, 49007.0, 418785.0, 418787.0, 419602.0, 419735.0, 420343.0, 25663.743362566136, 26218.21345359642, 28925.42149156963, 48089.75955120202, 49866.75066624644, 51243.48756512387, 55652.44347556472, 55807.16289255583, 55946.0, 56819.0, 44434.777826110665, 45220.32169517394, 45308.773456132505, 46221.0, 46955.0, 43766.56233437625, 46039.0, 46070.0, 46427.53572464232, 47119.764401177774, 46928.29607555821, 50524.74737626289, 50576.49423505718, 50912.74543627406, 51959.0, 40280.1943961125, 41917.371239430824, 42324.78837605792, 42425.15149696927, 42559.0, 30559.694403056576, 30633.0, 30767.321448960633, 31105.37789244157, 31526.369472610877], "value": 22067.570516488322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.25995288104457, 433.26777745609934, 435.92499701421247, 440.5286343612334, 453.89560401107724, 20088.096035678394, 21095.367138985817, 21987.120515179373, 22098.0, 22162.445938851535, 21721.456963575918, 22193.55612887741, 22311.330660080184, 22490.32529024132, 22874.428139296484, 5886.146508756227, 6211.192544969148, 6214.65819379934, 6214.8446288842915, 6224.346443623423, 5983.700814959257, 6250.218722659668, 6296.307406185339, 6383.2340119185765, 6388.425041746242, 6396.712147953353, 6411.647359395231, 6417.294097649278, 6565.34346565342, 6917.930820691804, 7029.47278954078, 7086.787396378143, 7087.255838136973, 7099.112610923635, 7104.609246491441, 6174.722137503823, 6320.81037568869, 6365.936340636581, 6372.0, 6375.585586936834, 25343.239702808944, 25815.612765808528, 25889.482210355876, 26028.63549422941, 26213.475730485476, 3134.1851118709073, 3205.599300087489, 3224.580804495424, 3302.669733026702, 3303.900882973515, 11287.661370158909, 11593.594224202112, 15549.236082304235, 16691.332346706116, 16709.498715038448, 1972.1815446589649, 2027.1485975890162, 2030.522827135622, 2044.7546294444612, 2044.7750747417772, 93630.0, 95883.52058239664, 102636.99999999926, 105238.0, 106616.0, 12375.0, 12456.75086498283, 12716.872831271754, 12735.363231838372, 12982.610521684364, 18224.08879556017, 18371.0, 18376.724349134773, 18405.723914141297, 18412.81587184138, 8927.464352138762, 9339.813203736023, 9389.201917836925, 9395.107464790834, 9654.131128198496, 9035.0, 9049.963758154494, 9057.637694492278, 9076.0, 9238.58426370815, 5507.091329930517, 5555.083411237181, 5560.499555040065, 5580.693061881554, 5637.408072152447, 2192.8793916334753, 2247.2359397804826, 2261.3442101790297, 2267.535155293161, 2275.8520696154696, 939.1313035442189, 940.8212439636447, 949.8622699708503, 973.4986481961795, 975.8292298847673, 20228.393148205578, 21007.684884726743, 21187.470313241985, 21337.46656333573, 21680.674789878165, 968.2399316536626, 968.7142293023575, 969.4425705219527, 974.1573538888811, 991.4943378876825, 11489.42552872353, 11714.589989350332, 11994.160408771477, 12000.519979200908, 12038.939805301092, 687284.0, 687482.0, 692374.0, 708497.0, 710833.0, 83420.0, 87688.0, 88654.55672721595, 114763.42618286856, 118837.40581297038, 1124.0894875151155, 1160.0777381981345, 1164.301419148504, 1169.5263418315596, 1170.69561913903, 18575.44273671792, 19477.61044779125, 19504.317348893288, 19512.02439878029, 19812.0, 47160.0, 47234.29148562843, 47361.0, 48042.5195748052, 48226.0, 65245.67377163273, 65492.34507654863, 66445.33554664585, 66577.33556661122, 66877.3312266871, 8521.147885211429, 9635.759106022406, 9698.75753106178, 9809.0, 9908.504574771088, 12474.376281185723, 14719.926400368358, 14740.778888316469, 14951.25243737787, 14999.175045372609, 12038.75922481528, 12200.75598488043, 12303.200291980993, 12417.130800843854, 12777.74444511086, 12123.515059397525, 12192.146549741434, 12231.633051008484, 12513.874861251272, 12657.746845062862, 12191.146619736533, 12382.5666101686, 12560.246385216917, 12627.684307892376, 12813.871861281641, 8278.503289802631, 8805.515696636747, 8909.287257019552, 9128.361014728906, 9779.85330220033, 9541.379810312308, 12132.090093243218, 12332.34368239666, 12399.566015189424, 12572.811407829073], "value": 10427.517363215444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.1809504772386, 1534.6393597504584, 1541.4681934732514, 1542.9691406171876, 1563.593465698918, 8881.911180888197, 9232.538373081345, 9232.8615070774, 9242.584083716232, 9244.768880777983, 7851.0, 8105.3110485608795, 8510.617022233999, 8758.211760941515, 8766.079561646031, 2487.2786891801356, 2530.165045534969, 2536.3405514566252, 2537.13737329308, 2537.7842883354847, 2536.467341858203, 2545.6945166579944, 2546.0834099724084, 2576.3172759218824, 2593.2220333899754, 2474.7030356357172, 2476.1209770531473, 2493.1772515070074, 2518.9496210075786, 2530.114459939025, 2409.108629806974, 2439.42673471734, 2457.8156638252112, 2467.9753202467923, 2469.2715648883623, 2448.987755061231, 2461.2616215135386, 2464.260721783458, 2514.484530671208, 2524.5203411351786, 9055.728328150166, 9059.048799875984, 9091.454512729257, 9130.726078217664, 9172.724818255463, 5522.751476183581, 5668.829935101953, 5674.0, 5680.261565996435, 5681.744321505542, 3603.783772973604, 3700.5559332879957, 3763.303788799081, 3770.547534295875, 3829.9808500957597, 1508.6530098077394, 2087.697283893827, 2133.9466513337293, 2155.9892200539052, 2205.283282933053, 12411.255324680458, 12437.129400941938, 12595.559155429608, 12599.622011339674, 12607.873921260762, 4801.4718380978065, 4873.878153046202, 4888.2178851383605, 4953.6037117030555, 4976.2286845539, 9806.95096524527, 9871.506424678737, 9952.502374881227, 9994.200463962865, 10006.449645269435, 5557.333120025542, 5626.803061892814, 5628.549716022709, 5632.887342253132, 5633.802816901389, 4568.497465278817, 4613.561711637389, 5124.231365295235, 5197.29836472079, 5206.193040078794, 3903.7072219583647, 3984.940225896556, 4053.3514637658423, 4053.918921621551, 4063.837446502107, 1224.7691070474116, 1227.6194379742308, 1239.9070069744625, 1241.596481143632, 1255.0210835548287, 867.3711559119588, 873.5326600268826, 884.8186121845006, 886.1670030171747, 903.3586153830854, 5925.555583331267, 6008.939910600925, 6027.9095813562835, 6141.6007959482495, 6180.196574445384, 648.2027106658836, 667.4927055437902, 673.6564352180424, 689.0387908867102, 691.2879733874117, 3914.706397020235, 3971.046948732341, 3998.580149084304, 4013.8795836124964, 4019.31671615826, 10794.136469082454, 11048.226624136234, 11102.777944441228, 11159.107271418266, 11218.0, 10370.481475926174, 10979.28634638746, 11104.500297486633, 11111.72220694489, 11112.722181945353, 8543.743687689379, 8703.086175951561, 8720.12798720123, 8722.912770872337, 8734.126587341341, 5897.64614123154, 5941.494972927177, 6032.51504632513, 6051.515878729779, 6251.781187658592, 9758.80482390334, 9840.311178217456, 9902.960189180032, 9928.900710992797, 9986.251031172545, 9991.700248992542, 10221.131203847755, 10296.845547316647, 10350.792984140124, 10396.688099357032, 7095.574265544084, 7222.96388518054, 7772.883406748791, 7962.7213047543055, 8106.310963568163, 8812.779680508038, 8873.467591944504, 8874.0, 8892.777680558038, 8912.910870891208, 7778.377729781717, 7795.376369890282, 7829.804254893673, 7859.52842829432, 7969.0, 7848.372130229682, 7869.465454236369, 7894.684212631661, 7896.605169741605, 8030.23712747288, 7021.227664956748, 7024.0, 7041.5422997505, 7084.574925504487, 7120.679569419285, 4992.2511623256805, 5014.5737612303365, 5053.797848086036, 5088.542031217208, 5178.689278643294, 5088.4148322941855, 5089.13484707608, 5098.668586541863, 5169.612279079009, 5204.791808327776], "value": 4770.949436860495, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.44676622877313, 402.9133736246707, 409.98360065597376, 412.8596277265729, 418.6483353982654, 5312.867178320544, 5355.28630838132, 5392.164214546741, 5394.595405344605, 5410.188471729238, 5093.949060509393, 5181.326427564421, 5229.294045303883, 5340.1430234824375, 5344.759485823138, 4304.536457604414, 4307.203167414023, 4315.33112367582, 4324.589164029412, 4334.349847522881, 4309.461317335333, 4335.934960975572, 4340.631046361063, 4345.261305578059, 4354.0, 4164.7709375984305, 4253.489581250239, 4319.956800431987, 4322.632576231024, 4334.0, 4247.68142389322, 4283.293256612656, 4286.699931004831, 4301.118270754488, 4305.332673435607, 3886.5724770275247, 3891.1633998690418, 3892.5402973884793, 3896.3960586109197, 3907.98046009771, 5035.194368900959, 5134.101532231844, 5169.224616307546, 5205.869853253661, 5212.739363031871, 4856.68431551948, 4886.143265559065, 4896.657233993622, 4905.215165573527, 4917.311576379309, 5554.444555544454, 5561.944380556223, 5563.499285064364, 5569.164625306196, 5573.164025396182, 4087.9795601021806, 4261.254280500931, 4263.59495847894, 4274.893127671802, 4278.101598664284, 5472.644278121949, 5627.606067575312, 5688.60179787415, 5747.56893233005, 5755.625884317506, 4296.849610263625, 4384.56154384559, 4392.626626736763, 4397.31841564558, 4404.647628189737, 4465.486469056035, 4478.820847166142, 4500.729956202638, 4502.649205238416, 4505.81976720934, 4664.720116793003, 4727.669063165546, 4792.400949881265, 4919.2867034279825, 4955.628327875424, 5566.832995010156, 5568.49883510486, 5568.860778480571, 5594.944050559442, 5623.240862483594, 1494.8505149484965, 1500.7748837674437, 1504.4433559583024, 1509.3811537269667, 1521.6043828604643, 960.5016174767385, 994.5027486256871, 998.6205242007991, 1014.5383850348074, 1071.9035286824067, 5182.870428239325, 5257.921131183035, 5273.472652734773, 5274.92087618686, 5281.471852814765, 5432.049391356497, 5487.972560137174, 5515.944840551543, 5535.0, 5586.636868603528, 5059.443461219263, 5250.789968401221, 5289.9471005290225, 5297.311349524614, 5337.332833395825, 2890.6531216254184, 2892.3492214251623, 2907.360380716239, 2911.505044142501, 2918.7373136417823, 5455.290812194389, 5673.914891276634, 5699.458551437607, 5724.33818274496, 5743.425657434307, 5533.644257156941, 5549.944500554942, 5567.638103523258, 5572.721363931787, 5576.498115169654, 5685.77256909719, 5689.789555728731, 5706.657600543981, 5728.914066289009, 5750.482456578928, 5290.391604965478, 5434.2935418395355, 5477.863053423537, 5479.726013699379, 5497.202905578749, 5301.6818990860675, 5338.3060202173465, 5373.731313434235, 5389.83830485086, 5393.599848067573, 5727.8568035799435, 5755.3093628763145, 5895.995361576913, 5925.0, 5987.550933679904, 4182.728122672017, 4183.477065366829, 4193.266178418704, 4204.8528301509305, 4220.514640816223, 5522.641028333145, 5678.4605462480995, 5729.684867332337, 5785.30576330843, 5804.448577385142, 5463.289772329572, 5492.457364999473, 5494.642848214853, 5538.972305138448, 5562.3047119110115, 5486.214511986716, 5504.587155963399, 5560.249366335493, 5573.442655734394, 5599.916001260066, 5375.516203541543, 5445.727713614383, 5497.065498865282, 5527.806526771544, 5533.501984821224, 5519.751611177427, 5526.723663816873, 5532.114861622121, 5538.723063846872, 5579.69311687861, 5196.220566914993, 5445.09421702401, 5458.0, 5503.284573005483, 5512.80705175317], "value": 4306.9614547769925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.2610676497918, 856.3962406503416, 859.3383095016837, 895.9104089591042, 935.0836180543065, 16476.505704828858, 17308.91345543272, 17927.551811204725, 17953.28186872527, 18409.44771656849, 15994.120323382209, 16169.838301616981, 16171.91914040431, 16538.586535336624, 16547.25537350819, 802.5866678660494, 816.742726041298, 819.2626636027563, 819.3895547816855, 819.8852160697508, 695.6695569604448, 713.3722324354561, 792.8969233999572, 807.4791759315267, 817.3787921179886, 860.5052095045343, 861.0485413617956, 862.5687156421789, 862.6678728689468, 862.8705694145897, 849.2059923971045, 849.6516428264382, 851.1445996773265, 851.3019324154196, 852.5992783391796, 529.1031701266355, 539.2908325551887, 540.9323834520685, 625.3402660193494, 626.6929204689715, 13619.455221791215, 15759.92120039404, 16230.431934882223, 16483.91758041214, 17126.82873171265, 16728.41450549225, 16959.406420775213, 16988.830111698848, 17038.847223392608, 17337.913310433367, 13077.280749558771, 13082.411291491906, 13167.078304518687, 13262.137961032502, 13562.59312220635, 4046.3930410438375, 4073.8574149904907, 4133.256013917494, 4157.875263742093, 4223.324268117117, 67784.32215677878, 74476.25523744748, 84255.0, 85600.57199714024, 86819.56590217071, 12297.631071067883, 12912.16070955385, 12961.41673624689, 13051.934740326427, 13236.669083272802, 23563.23275754291, 23812.64281035786, 23957.0, 24080.7591924082, 24148.758512415003, 9091.772705682411, 9163.129502697366, 9222.44665320083, 9319.207867331217, 9366.110219529133, 4944.3572335596145, 4994.675346102492, 5039.899202015939, 5053.69677819332, 5084.186530155157, 3895.5130608673917, 3998.6401223889407, 4046.77742724153, 4059.411385349108, 4062.6952978526137, 686.0943554508101, 688.8828899087067, 691.9654017299115, 699.5348093517754, 707.0596107177441, 829.088003196479, 835.2023817254508, 847.8050048488882, 867.5271976772674, 884.0143240287163, 10537.683869483928, 10691.465426728633, 10882.455877206108, 11178.832317515244, 11242.831357529643, 826.7478419082238, 829.5561874397168, 829.6805729793952, 845.3533047218882, 846.4244313866507, 5155.690658560498, 5179.45615710345, 5189.091908916, 5216.295800066942, 5232.0, 63744.36255637477, 69639.65180174066, 72394.0, 82902.58548707339, 85347.0, 70935.29064709287, 72168.63915680493, 72750.0, 72750.63624681842, 75493.0, 63417.36582634115, 65561.0, 65656.0, 65856.0, 68106.65946670235, 9428.15146636806, 9761.36011747199, 9774.12032917041, 9803.607855685692, 9861.802763944825, 44199.0, 44652.55347446484, 45203.54796451993, 45276.094478110914, 46248.30627540522, 52624.73687631537, 55112.72443637756, 55737.442625573225, 56237.43762562322, 57380.0, 12441.440135193758, 12585.24488530691, 12672.176308539916, 12712.364381781059, 12936.0, 13532.0, 13619.86380136186, 13762.380692869045, 13772.0, 14155.858441415454, 13204.0, 13242.53651122206, 13260.933695331461, 13504.122232055279, 13723.794143087662, 12312.692182695504, 12360.690982725504, 12400.131990760921, 13045.478180872658, 13069.477220911058, 12842.871571284168, 12942.288174150512, 13234.073614846868, 13234.139780914209, 13284.601461956157, 10528.684139475828, 10755.139588833032, 11165.218434709492, 11209.383483908463, 11250.549978000789, 9490.481522956294, 10341.145561730462, 10573.9471302643, 10713.250072494851, 10829.350238985686], "value": 7587.153955617058, "unit": "score"}], "name": "dromaeo_css", "value": 7620.0696099938505, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 111.0, 115.0, 112.0, 114.0, 112.0, 112.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 118.0, 158.0, 121.0, 119.0, 120.0, 117.0, 134.0, 120.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 159.0, 162.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 117.0, 75.0, 75.0, 75.0, 74.0, 91.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 104.0, 84.0, 84.0, 84.0, 96.0, 83.0, 83.0, 108.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 49.0, 49.0, 49.0, 49.0, 49.0, 48.0, 48.0, 50.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 82.0, 83.0, 77.0, 80.0, 79.0, 84.0, 79.0, 76.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 123.0, 127.0, 125.0, 128.0, 118.0, 119.0, 161.0, 125.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 161.0, 165.0, 158.0, 159.0, 157.0, 160.0, 166.0, 164.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 65.0, 63.0, 62.0, 65.0, 63.0, 61.0, 60.0, 65.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1474.6, "alertThreshold": 2.0}]} 06:08:47 INFO - Return code: 0 06:08:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:08:47 ERROR - # TBPL SUCCESS # 06:08:47 INFO - Running post-action listener: _resource_record_post_action 06:08:47 INFO - [mozharness: 2017-02-15 14:08:47.676424Z] Finished run-tests step (success) 06:08:47 INFO - Running post-run listener: _resource_record_post_run 06:08:47 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 363692032; Read time: 32; Write time: 418936 06:08:47 INFO - TinderboxPrint: CPU usage
13.1% 06:08:47 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 06:08:47 INFO - TinderboxPrint: I/O write bytes / time
363,692,032 / 418,936 06:08:47 INFO - TinderboxPrint: CPU idle
8,267.3 (86.9%) 06:08:47 INFO - TinderboxPrint: CPU user
1,195.0 (12.6%) 06:08:47 INFO - TinderboxPrint: Swap in / out
0 / 0 06:08:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110174208; Read time: 0; Write time: 173012 06:08:47 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253517824; Read time: 32; Write time: 245924 06:08:48 INFO - Running post-run listener: _upload_blobber_files 06:08:48 INFO - Blob upload gear active. 06:08:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:08:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:08:48 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:08:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:08:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:52 INFO - (blobuploader) - INFO - Done attempting. 06:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:53 INFO - (blobuploader) - INFO - Done attempting. 06:08:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:08:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:54 INFO - (blobuploader) - INFO - Done attempting. 06:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:55 INFO - (blobuploader) - INFO - Done attempting. 06:08:55 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:55 INFO - Return code: 0 06:08:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:08:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14ffdc055d7519686e4d6ea3d735e7f8f2d347ad5823d6e1544465e4a44befe14a03eb0fb4f37745ec7c3efc94b3b5594937613bbe5ac982dbc7d26a36d699b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/807123d8f23170a27072cdffacfd652a83e26010ef506a1c6829d62ccfc6151cda54af79ae33567abcb5dd80b819a97a3c0c38b378ac41458219605c1a69cef1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd1a6b60439fa3c319b59697dbdef2f84cd024769d2aa1aabac079360b9c1ed6203ad2bc211687addb16af0f4db55532a064e9cc94dc7c9aff79d68daa18c501", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9f79bb0fb823be71d6e02c46d8e4437bb33ebd89f23b91a143abf6d39ba7a3c35f386fe38ef7e838597cc683cb1cf5b432a180a39a4290c1c136593314fd4b3"} 06:08:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:55 INFO - Contents: 06:08:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14ffdc055d7519686e4d6ea3d735e7f8f2d347ad5823d6e1544465e4a44befe14a03eb0fb4f37745ec7c3efc94b3b5594937613bbe5ac982dbc7d26a36d699b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/807123d8f23170a27072cdffacfd652a83e26010ef506a1c6829d62ccfc6151cda54af79ae33567abcb5dd80b819a97a3c0c38b378ac41458219605c1a69cef1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd1a6b60439fa3c319b59697dbdef2f84cd024769d2aa1aabac079360b9c1ed6203ad2bc211687addb16af0f4db55532a064e9cc94dc7c9aff79d68daa18c501", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9f79bb0fb823be71d6e02c46d8e4437bb33ebd89f23b91a143abf6d39ba7a3c35f386fe38ef7e838597cc683cb1cf5b432a180a39a4290c1c136593314fd4b3"} 06:08:55 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:55 INFO - Copying logs to upload dir... 06:08:55 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.997618 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-02-15 06:08:54.260942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 06:08:54.267718) ========= 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=52faae308a556c440401f8e5000001e8-1487166444.330375-74213130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14ffdc055d7519686e4d6ea3d735e7f8f2d347ad5823d6e1544465e4a44befe14a03eb0fb4f37745ec7c3efc94b3b5594937613bbe5ac982dbc7d26a36d699b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/807123d8f23170a27072cdffacfd652a83e26010ef506a1c6829d62ccfc6151cda54af79ae33567abcb5dd80b819a97a3c0c38b378ac41458219605c1a69cef1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd1a6b60439fa3c319b59697dbdef2f84cd024769d2aa1aabac079360b9c1ed6203ad2bc211687addb16af0f4db55532a064e9cc94dc7c9aff79d68daa18c501", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9f79bb0fb823be71d6e02c46d8e4437bb33ebd89f23b91a143abf6d39ba7a3c35f386fe38ef7e838597cc683cb1cf5b432a180a39a4290c1c136593314fd4b3"} build_url:https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/aoR_uvPXRz-K8DLMQSlEqA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b14ffdc055d7519686e4d6ea3d735e7f8f2d347ad5823d6e1544465e4a44befe14a03eb0fb4f37745ec7c3efc94b3b5594937613bbe5ac982dbc7d26a36d699b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/807123d8f23170a27072cdffacfd652a83e26010ef506a1c6829d62ccfc6151cda54af79ae33567abcb5dd80b819a97a3c0c38b378ac41458219605c1a69cef1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd1a6b60439fa3c319b59697dbdef2f84cd024769d2aa1aabac079360b9c1ed6203ad2bc211687addb16af0f4db55532a064e9cc94dc7c9aff79d68daa18c501", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9f79bb0fb823be71d6e02c46d8e4437bb33ebd89f23b91a143abf6d39ba7a3c35f386fe38ef7e838597cc683cb1cf5b432a180a39a4290c1c136593314fd4b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 06:08:54.295313) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 06:08:54.295714) ========= 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=52faae308a556c440401f8e5000001e8-1487166444.330375-74213130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 06:08:54.378170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 06:08:54.381380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 06:08:54.381755) ========= ========= Total master_lag: 0.16 =========