builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1490284848.59 results: success (0) revision: 786d0d85a2c3df3348cf7deaf6d2e69e8e52c9d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:48.589988) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:48.590416) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:48.590757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:48.606096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:48.606400) ========= 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=4300f881736b422476174874000001bc-1490284848.16097-2009590757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 09:00:48-- 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% 55.5M=0s 2017-03-23 09:00:48 (55.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:48.729376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:48.729702) ========= 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=4300f881736b422476174874000001bc-1490284848.16097-2009590757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017794 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:48.779642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 09:00:48.779972) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 786d0d85a2c3df3348cf7deaf6d2e69e8e52c9d7 --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 786d0d85a2c3df3348cf7deaf6d2e69e8e52c9d7 --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=4300f881736b422476174874000001bc-1490284848.16097-2009590757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 09:00:48,916 truncating revision to first 12 chars 2017-03-23 09:00:48,916 Setting DEBUG logging. 2017-03-23 09:00:48,916 attempt 1/10 2017-03-23 09:00:48,916 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/786d0d85a2c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 09:00:49,591 unpacking tar archive at: mozilla-aurora-786d0d85a2c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.060070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 09:00:49.853282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:49.853607) ========= script_repo_revision: 786d0d85a2c3df3348cf7deaf6d2e69e8e52c9d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:49.853984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:49.854245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 09:00:49.862612) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-23 09:00:49.862878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1490284848.16097-2009590757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:00:50 INFO - MultiFileLogger online at 20170323 09:00:50 in /builds/slave/test 09:00:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 09:00:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:00:50 INFO - {'append_to_log': False, 09:00:50 INFO - 'base_work_dir': '/builds/slave/test', 09:00:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 09:00:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:00:50 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 09:00:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:00:50 INFO - 'config_files': ('talos/linux_config.py',), 09:00:50 INFO - 'default_actions': ('clobber', 09:00:50 INFO - 'read-buildbot-config', 09:00:50 INFO - 'download-and-extract', 09:00:50 INFO - 'populate-webroot', 09:00:50 INFO - 'create-virtualenv', 09:00:50 INFO - 'install', 09:00:50 INFO - 'run-tests'), 09:00:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:00:50 INFO - 'download_minidump_stackwalk': True, 09:00:50 INFO - 'download_symbols': 'ondemand', 09:00:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:00:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:00:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:00:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:00:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:00:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:00:50 INFO - 'gecko_profile': False, 09:00:50 INFO - 'gecko_profile_interval': 0, 09:00:50 INFO - 'installer_path': 'installer.exe', 09:00:50 INFO - 'log_level': 'info', 09:00:50 INFO - 'log_name': 'talos', 09:00:50 INFO - 'log_to_console': True, 09:00:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:00:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:00:50 INFO - 'opt_config_files': (), 09:00:50 INFO - 'pip_index': False, 09:00:50 INFO - 'suite': 'dromaeojs', 09:00:50 INFO - 'system_bits': '32', 09:00:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:00:50 INFO - 'title': 'talos-linux64-ix-045', 09:00:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:00:50 INFO - 'use_talos_json': True, 09:00:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:00:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:00:50 INFO - 'work_dir': 'build'} 09:00:50 INFO - [mozharness: 2017-03-23 16:00:50.096069Z] Running clobber step. 09:00:50 INFO - Running pre-action listener: _resource_record_pre_action 09:00:50 INFO - Running main action method: clobber 09:00:50 INFO - rmtree: /builds/slave/test/build 09:00:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:00:51 INFO - Running post-action listener: _resource_record_post_action 09:00:51 INFO - [mozharness: 2017-03-23 16:00:51.187644Z] Finished clobber step (success) 09:00:51 INFO - [mozharness: 2017-03-23 16:00:51.187744Z] Running read-buildbot-config step. 09:00:51 INFO - Running pre-action listener: _resource_record_pre_action 09:00:51 INFO - Running main action method: read_buildbot_config 09:00:51 INFO - Using buildbot properties: 09:00:51 INFO - { 09:00:51 INFO - "project": "", 09:00:51 INFO - "product": "firefox", 09:00:51 INFO - "who": "cbook@mozilla.com", 09:00:51 INFO - "installer_path": "public/build/target.tar.bz2", 09:00:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:00:51 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:00:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 09:00:51 INFO - "stage_platform": "linux64", 09:00:51 INFO - "basedir": "/builds/slave/test", 09:00:51 INFO - "buildnumber": 88, 09:00:51 INFO - "platform": "ubuntu64_hw", 09:00:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:00:51 INFO - "slavebuilddir": "test", 09:00:51 INFO - "taskId": "TQWFM8yCTim1Zp8OKrMe9w", 09:00:51 INFO - "branch": "mozilla-aurora", 09:00:51 INFO - "script_repo_revision": "production", 09:00:51 INFO - "revision": "786d0d85a2c3df3348cf7deaf6d2e69e8e52c9d7", 09:00:51 INFO - "slavename": "talos-linux64-ix-045", 09:00:51 INFO - "repo_path": "releases/mozilla-aurora" 09:00:51 INFO - } 09:00:51 INFO - Finding installer, test and symbols from parent task. 09:00:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQWFM8yCTim1Zp8OKrMe9w'}, attempt #1 09:00:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQWFM8yCTim1Zp8OKrMe9w'}, attempt #1 09:00:52 INFO - Task dependencies: XZ0YVrU2T_eUbdZ6LJcDPg 09:00:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg'}, attempt #1 09:00:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.tar.bz2 09:00:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/test_packages.json 09:00:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.crashreporter-symbols.zip 09:00:52 INFO - Running post-action listener: _resource_record_post_action 09:00:52 INFO - [mozharness: 2017-03-23 16:00:52.576642Z] Finished read-buildbot-config step (success) 09:00:52 INFO - [mozharness: 2017-03-23 16:00:52.576860Z] Running download-and-extract step. 09:00:52 INFO - Running pre-action listener: _resource_record_pre_action 09:00:52 INFO - Running main action method: download_and_extract 09:00:52 INFO - mkdir: /builds/slave/test/build/tests 09:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:52 INFO - trying https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.test_packages.json 09:00:52 INFO - Downloading https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:00:53 INFO - Downloaded 896 bytes. 09:00:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:00:53 INFO - Using the following test package requirements: 09:00:53 INFO - {u'common': [u'target.common.tests.zip'], 09:00:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:00:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:00:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:00:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:00:53 INFO - u'mozbase': [u'target.common.tests.zip'], 09:00:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:00:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:00:53 INFO - u'web-platform': [u'target.common.tests.zip', 09:00:53 INFO - u'target.web-platform.tests.zip'], 09:00:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:00:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:00:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.common.tests.zip 09:00:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:00:53 INFO - Fetch https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.common.tests.zip into memory 09:00:54 INFO - Expected file size: 59533648 09:00:54 INFO - Obtained file size: 59533648 09:01:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:01:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.common.tests.zip 09:01:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:01:03 INFO - Fetch https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.common.tests.zip into memory 09:01:05 INFO - Expected file size: 59533648 09:01:05 INFO - Obtained file size: 59533648 09:01:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.talos.tests.zip 09:01:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:01:15 INFO - Fetch https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.talos.tests.zip into memory 09:01:16 INFO - Expected file size: 14404438 09:01:16 INFO - Obtained file size: 14404438 09:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:16 INFO - trying https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.tar.bz2 09:01:16 INFO - Downloading https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:01:17 INFO - Downloaded 66686339 bytes. 09:01:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.tar.bz2 09:01:17 INFO - mkdir: /builds/slave/test/properties 09:01:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:01:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:01:17 INFO - Contents: 09:01:17 INFO - build_url:https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.tar.bz2 09:01:17 INFO - Running post-action listener: _resource_record_post_action 09:01:17 INFO - Running post-action listener: set_extra_try_arguments 09:01:17 INFO - [mozharness: 2017-03-23 16:01:17.793606Z] Finished download-and-extract step (success) 09:01:17 INFO - [mozharness: 2017-03-23 16:01:17.793701Z] Running populate-webroot step. 09:01:17 INFO - Running pre-action listener: _resource_record_pre_action 09:01:17 INFO - Running main action method: populate_webroot 09:01:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:17 INFO - '--tppagecycles', 09:01:17 INFO - '7'], 09:01:17 INFO - 'tests': ['tsvgm']}}, 09:01:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:01:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:01:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:01:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:01:17 INFO - 'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:01:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:01:17 INFO - 'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['damp', 'tps']}, 09:01:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:01:17 INFO - 'tests': ['damp', 'tps']}, 09:01:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['dromaeo_dom']}, 09:01:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['basic_compositor_video']}, 09:01:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:01:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['a11yr', 09:01:17 INFO - 'ts_paint', 09:01:17 INFO - 'tpaint', 09:01:17 INFO - 'sessionrestore', 09:01:17 INFO - 'sessionrestore_no_auto_restore', 09:01:17 INFO - 'tabpaint']}, 09:01:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:01:17 INFO - 'ts_paint', 09:01:17 INFO - 'tpaint', 09:01:17 INFO - 'sessionrestore', 09:01:17 INFO - 'sessionrestore_no_auto_restore', 09:01:17 INFO - 'tabpaint']}, 09:01:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:01:17 INFO - 'ts_paint', 09:01:17 INFO - 'tpaint', 09:01:17 INFO - 'sessionrestore', 09:01:17 INFO - 'sessionrestore_no_auto_restore', 09:01:17 INFO - 'tabpaint']}, 09:01:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:01:17 INFO - 'ts_paint', 09:01:17 INFO - 'tpaint', 09:01:17 INFO - 'sessionrestore', 09:01:17 INFO - 'sessionrestore_no_auto_restore', 09:01:17 INFO - 'tabpaint']}, 09:01:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['a11yr', 09:01:17 INFO - 'ts_paint', 09:01:17 INFO - 'tpaint', 09:01:17 INFO - 'sessionrestore', 09:01:17 INFO - 'sessionrestore_no_auto_restore', 09:01:17 INFO - 'tabpaint']}, 09:01:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['a11yr', 09:01:17 INFO - 'ts_paint', 09:01:17 INFO - 'tpaint', 09:01:17 INFO - 'sessionrestore', 09:01:17 INFO - 'sessionrestore_no_auto_restore', 09:01:17 INFO - 'tabpaint']}, 09:01:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['tsvgx', 09:01:17 INFO - 'tsvgr_opacity', 09:01:17 INFO - 'tart', 09:01:17 INFO - 'tscrollx', 09:01:17 INFO - 'cart', 09:01:17 INFO - 'tsvg_static']}, 09:01:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:01:17 INFO - 'tsvgr_opacity', 09:01:17 INFO - 'tart', 09:01:17 INFO - 'tscrollx', 09:01:17 INFO - 'cart', 09:01:17 INFO - 'tsvg_static']}, 09:01:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:01:17 INFO - 'talos_options': ['--disable-e10s'], 09:01:17 INFO - 'tests': ['tp5o']}, 09:01:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:01:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:01:17 INFO - 'talos_options': ['--disable-e10s', 09:01:17 INFO - '--xperf_path', 09:01:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:17 INFO - 'tests': ['tp5n']}, 09:01:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:01:17 INFO - 'talos_options': ['--xperf_path', 09:01:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:17 INFO - 'tests': ['tp5n']}}, 09:01:17 INFO - 'talos.zip': {'path': '', 09:01:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:17 INFO - Running post-action listener: _resource_record_post_action 09:01:17 INFO - [mozharness: 2017-03-23 16:01:17.806779Z] Finished populate-webroot step (success) 09:01:17 INFO - [mozharness: 2017-03-23 16:01:17.806869Z] Running create-virtualenv step. 09:01:17 INFO - Running pre-action listener: _resource_record_pre_action 09:01:17 INFO - Running main action method: create_virtualenv 09:01:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:01:17 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 09:01:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:01:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:17 INFO - Using real prefix '/usr' 09:01:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:01:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:20 INFO - Installing pip.................done. 09:01:20 INFO - Return code: 0 09:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:01:20 INFO - Reading from file tmpfile_stdout 09:01:20 INFO - Output received: 09:01:20 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) 09:01:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:01:20 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')]} 09:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:20 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')]} 09:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:20 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 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01:20 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 09:01:20 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 09:01:20 INFO - Using env: {'DISPLAY': ':0', 09:01:20 INFO - 'HOME': '/home/cltbld', 09:01:20 INFO - 'LANG': 'en_US.UTF-8', 09:01:20 INFO - 'LANGUAGE': 'en_US:en', 09:01:20 INFO - 'LOGNAME': 'cltbld', 09:01:20 INFO - 'MAIL': '/var/mail/cltbld', 09:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:20 INFO - 'MOZ_NO_REMOTE': '1', 09:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:20 INFO - 'NO_EM_RESTART': '1', 09:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:20 INFO - 'PWD': '/builds/slave/test', 09:01:20 INFO - 'SHELL': '/bin/bash', 09:01:20 INFO - 'SHLVL': '1', 09:01:20 INFO - 'TERM': 'linux', 09:01:20 INFO - 'TMOUT': '86400', 09:01:20 INFO - 'USER': 'cltbld', 09:01:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:20 INFO - '_': '/tools/buildbot/bin/python'} 09:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:20 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 09:01:20 INFO - Cleaning up... 09:01:20 INFO - Return code: 0 09:01:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:01:20 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')]} 09:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:20 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')]} 09:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:20 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 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01:20 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 09:01:20 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 09:01:20 INFO - Using env: {'DISPLAY': ':0', 09:01:20 INFO - 'HOME': '/home/cltbld', 09:01:20 INFO - 'LANG': 'en_US.UTF-8', 09:01:20 INFO - 'LANGUAGE': 'en_US:en', 09:01:20 INFO - 'LOGNAME': 'cltbld', 09:01:20 INFO - 'MAIL': '/var/mail/cltbld', 09:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:20 INFO - 'MOZ_NO_REMOTE': '1', 09:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:20 INFO - 'NO_EM_RESTART': '1', 09:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:20 INFO - 'PWD': '/builds/slave/test', 09:01:20 INFO - 'SHELL': '/bin/bash', 09:01:20 INFO - 'SHLVL': '1', 09:01:20 INFO - 'TERM': 'linux', 09:01:20 INFO - 'TMOUT': '86400', 09:01:20 INFO - 'USER': 'cltbld', 09:01:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:20 INFO - '_': '/tools/buildbot/bin/python'} 09:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:21 INFO - Downloading/unpacking psutil>=3.1.1 09:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:01:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:24 INFO - Installing collected packages: psutil 09:01:24 INFO - Running setup.py install for psutil 09:01:24 INFO - building 'psutil._psutil_linux' extension 09:01:24 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 09:01:24 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 09:01:24 INFO - building 'psutil._psutil_posix' extension 09:01:24 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 09:01:24 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 09:01:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:24 INFO - Successfully installed psutil 09:01:24 INFO - Cleaning up... 09:01:24 INFO - Return code: 0 09:01:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:01:24 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')]} 09:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:24 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')]} 09:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:24 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 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01:24 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 09:01:24 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 09:01:24 INFO - Using env: {'DISPLAY': ':0', 09:01:24 INFO - 'HOME': '/home/cltbld', 09:01:24 INFO - 'LANG': 'en_US.UTF-8', 09:01:24 INFO - 'LANGUAGE': 'en_US:en', 09:01:24 INFO - 'LOGNAME': 'cltbld', 09:01:24 INFO - 'MAIL': '/var/mail/cltbld', 09:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:24 INFO - 'MOZ_NO_REMOTE': '1', 09:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:24 INFO - 'NO_EM_RESTART': '1', 09:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:24 INFO - 'PWD': '/builds/slave/test', 09:01:24 INFO - 'SHELL': '/bin/bash', 09:01:24 INFO - 'SHLVL': '1', 09:01:24 INFO - 'TERM': 'linux', 09:01:24 INFO - 'TMOUT': '86400', 09:01:24 INFO - 'USER': 'cltbld', 09:01:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:24 INFO - '_': '/tools/buildbot/bin/python'} 09:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:01:27 INFO - Installing collected packages: mozsystemmonitor 09:01:27 INFO - Running setup.py install for mozsystemmonitor 09:01:27 INFO - Successfully installed mozsystemmonitor 09:01:27 INFO - Cleaning up... 09:01:27 INFO - Return code: 0 09:01:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:01:27 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')]} 09:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:27 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')]} 09:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:27 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 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01:27 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 09:01:27 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 09:01:27 INFO - Using env: {'DISPLAY': ':0', 09:01:27 INFO - 'HOME': '/home/cltbld', 09:01:27 INFO - 'LANG': 'en_US.UTF-8', 09:01:27 INFO - 'LANGUAGE': 'en_US:en', 09:01:27 INFO - 'LOGNAME': 'cltbld', 09:01:27 INFO - 'MAIL': '/var/mail/cltbld', 09:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:27 INFO - 'MOZ_NO_REMOTE': '1', 09:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:27 INFO - 'NO_EM_RESTART': '1', 09:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:27 INFO - 'PWD': '/builds/slave/test', 09:01:27 INFO - 'SHELL': '/bin/bash', 09:01:27 INFO - 'SHLVL': '1', 09:01:27 INFO - 'TERM': 'linux', 09:01:27 INFO - 'TMOUT': '86400', 09:01:27 INFO - 'USER': 'cltbld', 09:01:27 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:27 INFO - '_': '/tools/buildbot/bin/python'} 09:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:27 INFO - Downloading/unpacking jsonschema==2.5.1 09:01:27 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 09:01:27 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 09:01:27 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 09:01:27 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 09:01:27 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 09:01:27 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 09:01:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:01:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:01:29 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 09:01:29 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 09:01:29 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 09:01:29 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 09:01:29 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 09:01:29 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 09:01:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:01:29 INFO - warning: no files found matching '*.txt' 09:01:29 INFO - no previously-included directories found matching 'build' 09:01:29 INFO - no previously-included directories found matching 'dist' 09:01:29 INFO - no previously-included directories found matching '.git*' 09:01:29 INFO - Installing collected packages: jsonschema, functools32 09:01:29 INFO - Running setup.py install for functools32 09:01:29 INFO - warning: no files found matching '*.txt' 09:01:29 INFO - no previously-included directories found matching 'build' 09:01:29 INFO - no previously-included directories found matching 'dist' 09:01:29 INFO - no previously-included directories found matching '.git*' 09:01:29 INFO - Successfully installed jsonschema functools32 09:01:29 INFO - Cleaning up... 09:01:29 INFO - Return code: 0 09:01:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:01:29 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')]} 09:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:29 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')]} 09:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:29 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 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01:29 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 09:01:29 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 09:01:29 INFO - Using env: {'DISPLAY': ':0', 09:01:29 INFO - 'HOME': '/home/cltbld', 09:01:29 INFO - 'LANG': 'en_US.UTF-8', 09:01:29 INFO - 'LANGUAGE': 'en_US:en', 09:01:29 INFO - 'LOGNAME': 'cltbld', 09:01:29 INFO - 'MAIL': '/var/mail/cltbld', 09:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:29 INFO - 'MOZ_NO_REMOTE': '1', 09:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:29 INFO - 'NO_EM_RESTART': '1', 09:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:29 INFO - 'PWD': '/builds/slave/test', 09:01:29 INFO - 'SHELL': '/bin/bash', 09:01:29 INFO - 'SHLVL': '1', 09:01:29 INFO - 'TERM': 'linux', 09:01:29 INFO - 'TMOUT': '86400', 09:01:29 INFO - 'USER': 'cltbld', 09:01:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:29 INFO - '_': '/tools/buildbot/bin/python'} 09:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:01:30 INFO - Cleaning up... 09:01:30 INFO - Return code: 0 09:01:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:01:30 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')]} 09:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:30 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')]} 09:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:30 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 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01:30 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 09:01:30 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 09:01:30 INFO - Using env: {'DISPLAY': ':0', 09:01:30 INFO - 'HOME': '/home/cltbld', 09:01:30 INFO - 'LANG': 'en_US.UTF-8', 09:01:30 INFO - 'LANGUAGE': 'en_US:en', 09:01:30 INFO - 'LOGNAME': 'cltbld', 09:01:30 INFO - 'MAIL': '/var/mail/cltbld', 09:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:30 INFO - 'MOZ_NO_REMOTE': '1', 09:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:30 INFO - 'NO_EM_RESTART': '1', 09:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:30 INFO - 'PWD': '/builds/slave/test', 09:01:30 INFO - 'SHELL': '/bin/bash', 09:01:30 INFO - 'SHLVL': '1', 09:01:30 INFO - 'TERM': 'linux', 09:01:30 INFO - 'TMOUT': '86400', 09:01:30 INFO - 'USER': 'cltbld', 09:01:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:30 INFO - '_': '/tools/buildbot/bin/python'} 09:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:01:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:01:32 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 09:01:32 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 09:01:32 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 09:01:32 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 09:01:32 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 09:01:32 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 09:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:01:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:01:32 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 09:01:32 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 09:01:32 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 09:01:32 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 09:01:32 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 09:01:32 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 09:01:33 INFO - Downloading docopt-0.6.1.tar.gz 09:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:01:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:01:33 INFO - Running setup.py install for blobuploader 09:01:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:01:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:01:33 INFO - Running setup.py install for requests 09:01:33 INFO - Running setup.py install for docopt 09:01:33 INFO - Successfully installed blobuploader requests docopt 09:01:33 INFO - Cleaning up... 09:01:33 INFO - Return code: 0 09:01:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:33 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 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01:33 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 09:01:33 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 09:01:33 INFO - Using env: {'DISPLAY': ':0', 09:01:33 INFO - 'HOME': '/home/cltbld', 09:01:33 INFO - 'LANG': 'en_US.UTF-8', 09:01:33 INFO - 'LANGUAGE': 'en_US:en', 09:01:33 INFO - 'LOGNAME': 'cltbld', 09:01:33 INFO - 'MAIL': '/var/mail/cltbld', 09:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:33 INFO - 'MOZ_NO_REMOTE': '1', 09:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:33 INFO - 'NO_EM_RESTART': '1', 09:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:33 INFO - 'PWD': '/builds/slave/test', 09:01:33 INFO - 'SHELL': '/bin/bash', 09:01:33 INFO - 'SHLVL': '1', 09:01:33 INFO - 'TERM': 'linux', 09:01:33 INFO - 'TMOUT': '86400', 09:01:33 INFO - 'USER': 'cltbld', 09:01:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:33 INFO - '_': '/tools/buildbot/bin/python'} 09:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:34 INFO - Running setup.py (path:/tmp/pip-qpYBmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:34 INFO - Running setup.py (path:/tmp/pip-bP4j07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:34 INFO - Running setup.py (path:/tmp/pip-FGJeBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:34 INFO - Running setup.py (path:/tmp/pip-kG9hUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:34 INFO - Running setup.py (path:/tmp/pip-VtMKUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:34 INFO - Running setup.py (path:/tmp/pip-xzNtlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:34 INFO - Running setup.py (path:/tmp/pip-XT_Xd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:34 INFO - Running setup.py (path:/tmp/pip-LIal__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:34 INFO - Running setup.py (path:/tmp/pip-yiGJrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:34 INFO - Running setup.py (path:/tmp/pip-9YzhIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:34 INFO - Running setup.py (path:/tmp/pip-1d7kv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:34 INFO - Running setup.py (path:/tmp/pip-C857KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:34 INFO - Running setup.py (path:/tmp/pip-bdezVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:35 INFO - Running setup.py (path:/tmp/pip-3modEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:35 INFO - Running setup.py (path:/tmp/pip-I4kCP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:35 INFO - Running setup.py (path:/tmp/pip-WoYQZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:35 INFO - Running setup.py (path:/tmp/pip-qj_hAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:01:35 INFO - Running setup.py install for manifestparser 09:01:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:01:35 INFO - Running setup.py install for mozcrash 09:01:35 INFO - Running setup.py install for mozdebug 09:01:35 INFO - Running setup.py install for mozdevice 09:01:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:01:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:01:35 INFO - Running setup.py install for mozfile 09:01:35 INFO - Running setup.py install for mozhttpd 09:01:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:01:35 INFO - Running setup.py install for mozinfo 09:01:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Running setup.py install for mozInstall 09:01:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Running setup.py install for mozleak 09:01:36 INFO - Running setup.py install for mozlog 09:01:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Running setup.py install for moznetwork 09:01:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Running setup.py install for mozprocess 09:01:36 INFO - Running setup.py install for mozprofile 09:01:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Running setup.py install for mozrunner 09:01:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:01:36 INFO - Running setup.py install for mozscreenshot 09:01:36 INFO - Running setup.py install for moztest 09:01:36 INFO - Running setup.py install for mozversion 09:01:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:01:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:01:37 INFO - Cleaning up... 09:01:37 INFO - Return code: 0 09:01:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:37 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 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01:37 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 09:01:37 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 09:01:37 INFO - Using env: {'DISPLAY': ':0', 09:01:37 INFO - 'HOME': '/home/cltbld', 09:01:37 INFO - 'LANG': 'en_US.UTF-8', 09:01:37 INFO - 'LANGUAGE': 'en_US:en', 09:01:37 INFO - 'LOGNAME': 'cltbld', 09:01:37 INFO - 'MAIL': '/var/mail/cltbld', 09:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:37 INFO - 'MOZ_NO_REMOTE': '1', 09:01:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:37 INFO - 'NO_EM_RESTART': '1', 09:01:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:37 INFO - 'PWD': '/builds/slave/test', 09:01:37 INFO - 'SHELL': '/bin/bash', 09:01:37 INFO - 'SHLVL': '1', 09:01:37 INFO - 'TERM': 'linux', 09:01:37 INFO - 'TMOUT': '86400', 09:01:37 INFO - 'USER': 'cltbld', 09:01:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:37 INFO - '_': '/tools/buildbot/bin/python'} 09:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:37 INFO - Running setup.py (path:/tmp/pip-he5BJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:37 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)) 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:37 INFO - Running setup.py (path:/tmp/pip-Tu8pUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:37 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)) 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:37 INFO - Running setup.py (path:/tmp/pip-aulfCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:37 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)) 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:37 INFO - Running setup.py (path:/tmp/pip-_PoyLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:37 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)) 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:37 INFO - Running setup.py (path:/tmp/pip-U5rzsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:37 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)) 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:37 INFO - Running setup.py (path:/tmp/pip-VSB2TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:37 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)) 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:37 INFO - Running setup.py (path:/tmp/pip-TgK5Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:37 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)) 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:37 INFO - Running setup.py (path:/tmp/pip-PF4cE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:37 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)) 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:37 INFO - Running setup.py (path:/tmp/pip-xweno3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:37 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)) 09:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:37 INFO - Running setup.py (path:/tmp/pip-I7htDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:38 INFO - Running setup.py (path:/tmp/pip-sjNqGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:38 INFO - Running setup.py (path:/tmp/pip-w9g0D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:38 INFO - Running setup.py (path:/tmp/pip-5Rsmlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:38 INFO - Running setup.py (path:/tmp/pip-w1IJav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:38 INFO - Running setup.py (path:/tmp/pip-gMaY3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:38 INFO - Running setup.py (path:/tmp/pip-wjPjVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:38 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)) 09:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:38 INFO - Running setup.py (path:/tmp/pip-Ud6n9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:38 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)) 09:01:38 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)) 09:01:38 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)) 09:01:38 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)) 09:01:38 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)) 09:01:38 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)) 09:01:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01:40 INFO - Downloading blessings-1.6.tar.gz 09:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:01:40 INFO - Installing collected packages: blessings 09:01:40 INFO - Running setup.py install for blessings 09:01:40 INFO - Successfully installed blessings 09:01:40 INFO - Cleaning up... 09:01:40 INFO - Return code: 0 09:01:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:01:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:41 INFO - Reading from file tmpfile_stdout 09:01:41 INFO - Current package versions: 09:01:41 INFO - argparse == 1.2.1 09:01:41 INFO - blessings == 1.6 09:01:41 INFO - blobuploader == 1.2.4 09:01:41 INFO - docopt == 0.6.1 09:01:41 INFO - functools32 == 3.2.3-2 09:01:41 INFO - jsonschema == 2.5.1 09:01:41 INFO - manifestparser == 1.1 09:01:41 INFO - mozInstall == 1.12 09:01:41 INFO - mozcrash == 1.0 09:01:41 INFO - mozdebug == 0.1 09:01:41 INFO - mozdevice == 0.49 09:01:41 INFO - mozfile == 1.2 09:01:41 INFO - mozhttpd == 0.7 09:01:41 INFO - mozinfo == 0.9 09:01:41 INFO - mozleak == 0.1 09:01:41 INFO - mozlog == 3.4 09:01:41 INFO - moznetwork == 0.27 09:01:41 INFO - mozprocess == 0.25 09:01:41 INFO - mozprofile == 0.28 09:01:41 INFO - mozrunner == 6.13 09:01:41 INFO - mozscreenshot == 0.1 09:01:41 INFO - mozsystemmonitor == 0.3 09:01:41 INFO - moztest == 0.8 09:01:41 INFO - mozversion == 1.4 09:01:41 INFO - psutil == 3.1.1 09:01:41 INFO - requests == 1.2.3 09:01:41 INFO - wsgiref == 0.1.2 09:01:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:41 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 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01:41 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 09:01:41 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 09:01:41 INFO - Using env: {'DISPLAY': ':0', 09:01:41 INFO - 'HOME': '/home/cltbld', 09:01:41 INFO - 'LANG': 'en_US.UTF-8', 09:01:41 INFO - 'LANGUAGE': 'en_US:en', 09:01:41 INFO - 'LOGNAME': 'cltbld', 09:01:41 INFO - 'MAIL': '/var/mail/cltbld', 09:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:41 INFO - 'MOZ_NO_REMOTE': '1', 09:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:41 INFO - 'NO_EM_RESTART': '1', 09:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:41 INFO - 'PWD': '/builds/slave/test', 09:01:41 INFO - 'SHELL': '/bin/bash', 09:01:41 INFO - 'SHLVL': '1', 09:01:41 INFO - 'TERM': 'linux', 09:01:41 INFO - 'TMOUT': '86400', 09:01:41 INFO - 'USER': 'cltbld', 09:01:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:41 INFO - '_': '/tools/buildbot/bin/python'} 09:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:41 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)) 09:01:41 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)) 09:01:41 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)) 09:01:41 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)) 09:01:41 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)) 09:01:41 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)) 09:01:41 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)) 09:01:41 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)) 09:01:41 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)) 09:01:41 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)) 09:01:41 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)) 09:01:41 INFO - Cleaning up... 09:01:41 INFO - Return code: 0 09:01:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fb310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, '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': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', '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 09:01: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'] in /builds/slave/test/build 09:01: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 09:01:41 INFO - Using env: {'DISPLAY': ':0', 09:01:41 INFO - 'HOME': '/home/cltbld', 09:01:41 INFO - 'LANG': 'en_US.UTF-8', 09:01:41 INFO - 'LANGUAGE': 'en_US:en', 09:01:41 INFO - 'LOGNAME': 'cltbld', 09:01:41 INFO - 'MAIL': '/var/mail/cltbld', 09:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:41 INFO - 'MOZ_NO_REMOTE': '1', 09:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:41 INFO - 'NO_EM_RESTART': '1', 09:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:41 INFO - 'PWD': '/builds/slave/test', 09:01:41 INFO - 'SHELL': '/bin/bash', 09:01:41 INFO - 'SHLVL': '1', 09:01:41 INFO - 'TERM': 'linux', 09:01:41 INFO - 'TMOUT': '86400', 09:01:41 INFO - 'USER': 'cltbld', 09:01:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:41 INFO - '_': '/tools/buildbot/bin/python'} 09:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:01:41 INFO - Cleaning up... 09:01:41 INFO - Return code: 0 09:01:41 INFO - Running post-action listener: _resource_record_post_action 09:01:41 INFO - Running post-action listener: _start_resource_monitoring 09:01:41 INFO - Starting resource monitoring. 09:01:41 INFO - [mozharness: 2017-03-23 16:01:41.550418Z] Finished create-virtualenv step (success) 09:01:41 INFO - [mozharness: 2017-03-23 16:01:41.550892Z] Running install step. 09:01:41 INFO - Running pre-action listener: _resource_record_pre_action 09:01:41 INFO - Running main action method: install 09:01:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:41 INFO - Reading from file tmpfile_stdout 09:01:41 INFO - Detecting whether we're running mozinstall >=1.0... 09:01:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:01:41 INFO - Reading from file tmpfile_stdout 09:01:41 INFO - Output received: 09:01:41 INFO - Usage: mozinstall [options] installer 09:01:41 INFO - Options: 09:01:41 INFO - -h, --help show this help message and exit 09:01:41 INFO - -d DEST, --destination=DEST 09:01:41 INFO - Directory to install application into. [default: 09:01:41 INFO - "/builds/slave/test"] 09:01:41 INFO - --app=APP Application being installed. [default: firefox] 09:01:41 INFO - mkdir: /builds/slave/test/build/application 09:01:41 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'] 09:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:01:58 INFO - Reading from file tmpfile_stdout 09:01:58 INFO - Output received: 09:01:58 INFO - /builds/slave/test/build/application/firefox/firefox 09:01:58 INFO - Running post-action listener: _resource_record_post_action 09:01:58 INFO - [mozharness: 2017-03-23 16:01:58.423246Z] Finished install step (success) 09:01:58 INFO - [mozharness: 2017-03-23 16:01:58.423580Z] Running run-tests step. 09:01:58 INFO - Running pre-action listener: _resource_record_pre_action 09:01:58 INFO - Running main action method: run_tests 09:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:01:58 INFO - Python 2.7.3 09:01:58 INFO - Return code: 0 09:01:58 INFO - grabbing minidump binary from tooltool 09:01:58 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')]} 09:01:58 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 0x14f8400>, '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 0x14f93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f9840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:01:58 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 09:01:58 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 09:01:58 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 09:01:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:01:58 INFO - Return code: 0 09:01:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:01:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:01:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:01:58 INFO - ENV: RUST_BACKTRACE is now 1 09:01:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:01:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 09:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 09:01:58 INFO - Using env: {'DISPLAY': ':0', 09:01:58 INFO - 'HOME': '/home/cltbld', 09:01:58 INFO - 'LANG': 'en_US.UTF-8', 09:01:58 INFO - 'LANGUAGE': 'en_US:en', 09:01:58 INFO - 'LOGNAME': 'cltbld', 09:01:58 INFO - 'MAIL': '/var/mail/cltbld', 09:01:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:58 INFO - 'MOZ_NO_REMOTE': '1', 09:01:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:58 INFO - 'NO_EM_RESTART': '1', 09:01:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:58 INFO - 'PWD': '/builds/slave/test', 09:01:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:58 INFO - 'RUST_BACKTRACE': '1', 09:01:58 INFO - 'SHELL': '/bin/bash', 09:01:58 INFO - 'SHLVL': '1', 09:01:58 INFO - 'TERM': 'linux', 09:01:58 INFO - 'TMOUT': '86400', 09:01:58 INFO - 'USER': 'cltbld', 09:01:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1490284848.16097-2009590757', 09:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:58 INFO - '_': '/tools/buildbot/bin/python'} 09:01:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 09:01:58 INFO - mozversion application_buildid: 20170323150154 09:01:58 INFO - mozversion application_changeset: 786d0d85a2c3df3348cf7deaf6d2e69e8e52c9d7 09:01:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:01:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:01:58 INFO - mozversion application_name: Firefox 09:01:58 INFO - mozversion application_remotingname: firefox-dev 09:01:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:01:58 INFO - mozversion application_vendor: Mozilla 09:01:58 INFO - mozversion application_version: 54.0a2 09:01:58 INFO - mozversion platform_buildid: 20170323150154 09:01:58 INFO - mozversion platform_changeset: 786d0d85a2c3df3348cf7deaf6d2e69e8e52c9d7 09:01:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:01:58 INFO - mozversion platform_version: 54.0a2 09:01:58 INFO - using testdate: 1490284918 09:01:58 INFO - actual date: 1490284918 09:01:58 INFO - starting webserver on 'localhost:55194' 09:01:58 INFO - SUITE-START | Running 2 tests 09:01:58 INFO - TEST-START | dromaeo_css 09:01:58 INFO - operating with platform_type : linux_ 09:01:58 INFO - Initialising browser for dromaeo_css test... 09:01:58 INFO - TEST-INFO | started process 8960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRAC6L/profile http://localhost:55194/getInfo.html) 09:02:02 INFO - PROCESS | 8960 | __metrics Screen width/height:1600/1200 09:02:02 INFO - PROCESS | 8960 | colorDepth:24 09:02:02 INFO - PROCESS | 8960 | Browser inner width/height: 1024/697 09:02:02 INFO - PROCESS | 8960 | __metrics 09:02:03 INFO - PROCESS | 8960 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:02:03 INFO - PROCESS | 8960 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:04 INFO - TEST-INFO | 8960: exit 0 09:02:04 INFO - Browser initialized. 09:02:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:02:04 INFO - TEST-INFO | started process 9054 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRAC6L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:16 INFO - PROCESS | 9054 | RSS: Main: 139759616 09:02:16 INFO - PROCESS | 9054 | 09:05:17 INFO - PROCESS | 9054 | Cycle 1(1): loaded http://localhost:55194/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55194/tests/dromaeo/cssquery-ext.html) 09:05:19 INFO - PROCESS | 9054 | RSS: Main: 291385344 09:05:19 INFO - PROCESS | 9054 | 09:07:05 INFO - PROCESS | 9054 | ************************* 09:07:05 INFO - PROCESS | 9054 | A coding exception was thrown and uncaught in a Task. 09:07:05 INFO - PROCESS | 9054 | 09:07:05 ERROR - PROCESS | 9054 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:07:05 INFO - PROCESS | 9054 | Full stack: 09:07:05 INFO - PROCESS | 9054 | ************************* 09:08:21 INFO - PROCESS | 9054 | Cycle 1(1): loaded http://localhost:55194/tests/dromaeo/cssquery-ext.html (next: http://localhost:55194/tests/dromaeo/cssquery-jquery.html) 09:08:22 INFO - PROCESS | 9054 | RSS: Main: 227475456 09:08:22 INFO - PROCESS | 9054 | 09:11:24 INFO - PROCESS | 9054 | Cycle 1(1): loaded http://localhost:55194/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55194/tests/dromaeo/cssquery-mootools.html) 09:11:24 INFO - PROCESS | 9054 | RSS: Main: 200896512 09:11:24 INFO - PROCESS | 9054 | 09:14:26 INFO - PROCESS | 9054 | Cycle 1(1): loaded http://localhost:55194/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55194/tests/dromaeo/cssquery-prototype.html) 09:14:27 INFO - PROCESS | 9054 | RSS: Main: 171356160 09:14:27 INFO - PROCESS | 9054 | 09:17:30 INFO - PROCESS | 9054 | Cycle 1(1): loaded http://localhost:55194/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55194/tests/dromaeo/cssquery-yui.html) 09:17:30 INFO - PROCESS | 9054 | RSS: Main: 177479680 09:17:30 INFO - PROCESS | 9054 | 09:20:33 INFO - PROCESS | 9054 | Cycle 1(1): loaded http://localhost:55194/tests/dromaeo/cssquery-yui.html (next: http://localhost:55194/tests/dromaeo/cssquery-dojo.html) 09:20:33 INFO - PROCESS | 9054 | RSS: Main: 259653632 09:20:33 INFO - PROCESS | 9054 | 09:20:33 INFO - PROCESS | 9054 | __start_tp_report 09:20:33 INFO - PROCESS | 9054 | _x_x_mozilla_page_load 09:20:33 INFO - PROCESS | 9054 | _x_x_mozilla_page_load_details 09:20:33 INFO - PROCESS | 9054 | |i|pagename|runs| 09:20:33 INFO - PROCESS | 9054 | |0;dojo.html;3361.3109312590905;3401.370746411914;3403.693667569919;3422.640622734614;3455.5507783988087;5695.829125126248;5783.103618939066;5790.507806836414;5792.68140252286;5804.303483581965;5774.797882074128;5814.447627475393;5817.650940943547;5819.098039803837;5829.679367634779;5151.871203219921;5191.299174611436;5194.792208311663;5197.558207552363;5250.264962905197;5043.495650434964;5087.694738315695;5253.133233016567;5262.500062494057;5264.815731449381;5085.160948443502;5097.541221290083;5181.559567436772;5204.167333226685;5215.608829337796;5207.843764687046;5213.921791173136;5221.190715439113;5224.111900976843;5238.60710446718;4978.5768209701855;5072.746362681888;5140.074786538422;5180.896382072375;5201;5642.6614403135945;5652.236948012048;5718.79984200551;5730.914036289459;5732.856678583027;6193.783217587408;6219.067139929001;6229.439350458435;6231.501479881644;6244.812655620339;6271.749130034838;6303.495720342362;6307.211598550181;6313.368663133696;6321.336259692712;5607.663540187602;5643.209950606918;5741.368449470513;5797.855053623609;5797.913031304533;6382.553221274559;6383.872322553616;6385.2656944451055;6388.105665206875;6391.07329437229;6107.4197951194565;6152.446279834837;6162.168107305546;6173.938260617426;6176.938230617726;5979.043353063489;6031.396860314021;6117.888303246575;6157.415045570664;6236.906446403307;6202.658853763086;6226.59527130735;6239.937600624026;6242.719077641517;6245.094461303085;5979.79070732531;6016.368281330485;6093.817185484442;6125.816225513242;6221.346758590283;4647.117047760915;4739.597134243559;4743.193657078305;4764.6426518011285;4765.189917713997;4145.150244199932;4159.792010399528;4196.832126714959;4234.13200293939;4250.149970006011;6011.48902343297;6062.181605483203;6067.484263837535;6092.573519853568;6100.298465676416;6246.798776697545;6272.090546870678;6278.497720182374;6284.151639528696;6290.0879372491645;5881.882362352729;5894.263217097863;6062.696865156725;6063.272407311151;6065.5450841187085;5224.399194092652;5248.081585722483;5299.947000529945;5321.760520776497;5337.172738225581;6485.189351331083;6512.674366281667;6516.706748196248;6518.315576864456;6520.543561950618;5976.97011514957;6078.848028799315;6254.405831446005;6264.968675156595;6269.435750782452;6395.904061438989;6442.065900444503;6527.249366322933;6552.246491653521;6574.638394888327;6189.257289125334;6190.566660333733;6190.783322583688;6198.132261483486;6204.13142160089;6014.0678194879865;6268.2478102626155;6281.371862813682;6281.560290779602;6285.842853928505;5907.084401917709;6019.18740969981;6036.486898613667;6113.141862489121;6129.328227221949;6053.9091913622215;6097.908531372122;6105.633661980295;6111.7249723763425;6127.632342059491;5765.596408251382;6038.064100064497;6039.63762174271;6043.123747056564;6044.063170208625;6023.066424704178;6025.1564780931585;6026.668533230539;6028.246469191351;6053.243344581927;6003;6003.699815009145;6005.819825405245;6035.547333949883;6046.939530604637 09:20:33 INFO - PROCESS | 9054 | |1;ext.html;709.6700034483964;798.8761741930001;816.7672213419173;833.9833203335937;852.2117041736392;31904.680953190462;44112.55887441125;46018.309725354105;46185.459799711;46263.53736462635;42444.15111697764;42674.573254267445;42692.35961460573;47549.762251188695;47902.52097479024;7658.540487570764;9172.770680732969;9297.30270229732;9310.044890572988;9319.394239374453;7822;10203.6938891833;10448.216383771209;10765.515551800148;10773.407462589554;10532.842007369896;10553.472326383688;10560.471976401188;10560.630377936774;10564.630237941674;10484.685459436152;10543.789124217512;10572.682819515427;10575.682729518127;10584.470776461185;10665.626703065356;10728.892711072946;10735.604371431742;10742.570297188104;10744.946275268652;43883.341749873776;43992.78003609993;44019.77990110061;44029;44029.33955990663;4173.4157217989505;4178.707490475668;4231.090315582134;4307.547707490731;4341.240282950471;29887;30493.69506304953;30535.541966870514;31211.843940780152;31909;4371.540988196225;4435.60079592835;4444.266695995157;4447.246658855773;4474.82100715971;233819;234653;234897;235186;235618;54298.728506358006;54317.45682543124;54349.45650543523;54396.72801636046;54404;56703.43296567064;57066.42933570694;57120;57295.71352143296;57387.71306143443;16878.915605421895;17159.142042898056;17189.05460199676;17201.483955481355;17221;12936.482540698455;13362.53231136925;15170.165640889636;15192;15210.163441010629;13159.342032898317;13351;13423.932880335731;13534.120282181626;13781.242031688153;5162.66442681232;5233.973830130825;5234.790608375699;5290;5310.150375939908;984.5864736810556;1002.754325190333;1008.8284991551454;1011.3325205364424;1027.2039169643585;28988.7101128986;29066.082906008436;29444.705552944626;29485.85257073701;29747.256318591775;1078.800421921947;1080.4327727942893;1088.5264909764278;1089.0742868561658;1094.2559059839227;14832.480863169952;15620.609484762745;15638.139902305482;15736.921315393578;16003.199840007954;327462;328711;330684;330886;332322;52204.21693674598;52310;52322.47677523252;52347;52382.738086310084;1445.4218312675014;1445.6916490575836;1475.4024620028906;1483.3028476615973;1493.596728883217;27869.303267417665;29094;29519.26201844971;29780.70219297779;29810.254743631584;37787.24425511529;37863.43204851985;37877.43183852299;37888.43167352547;37961.43057854079;294303;294640;295287;295406;296039;25065.498690026463;25720;30066.24834379158;30074.24814379658;30088.24779380533;38361.808190958865;39284.214315714096;42652.78673606612;43034.78482607567;43416.34875476934;32879;34212.82893585516;34379.48430773491;34398;34454.31091378209;33925.32149357048;34089.48865766966;34169.48745768766;34179.31641367209;34287;34748.82625586856;35350.07365012014;35411;35527.289454211284;36016;29305.413891722474;30856.691433085383;31316.217094571908;31368.843155784074;31433.37133257368;24849.50300994006;24877.62683559712;24971.12601058954;25152.11967581126;25321.746782532675 09:20:33 INFO - PROCESS | 9054 | |2;jquery.html;421.91350773091517;459.7153339390058;462.80099557190414;474.8124490826124;486.2244719672123;18936.337228196997;19852;20669.896650516745;20738.688919666216;20744.170233190693;20760.584788304262;21212;22255.554888902214;22259.109635614597;22467.32598022058;6727.6636168191635;6731.8317042074095;6856.382925536701;6988.056612357317;6989.440844732435;6789.694463749119;6866.588004719708;6868.7252509899545;6875.518713690044;6877.312268773133;6703.9329606703795;6836.418904393133;6843.247242803288;6857.3828355448;6884.5525040872435;6683.2648408675;6839.350261725178;6869.965650171742;6928.72285108595;6929.1684997800085;6628.966855165693;6726.529142959995;6726.562773419761;6735.29279425663;6739.932600673979;25070.373240668945;25422.618660720105;25724.48551028969;25845.74154258452;25894;3083.213780485984;3121.5941927549275;3137.4980003199607;3165.129589362921;3217.4369485340208;16037.278322475517;16967.406140785013;17215.311387544483;17233.827661723473;17521.03634300113;2179.400664817188;2229.888505574731;2246.2025980776752;2271.909123635069;2337.94155146121;113431.43284283526;116777.41611291889;116919;117662;118110;14707.749841263612;16269.430569929995;18477.630447391246;18493.81506184948;18957.62084758297;32331.191720206712;32342.83828580889;32414;32438.189045273586;32919.50620740691;9594.712158635251;9650.71047868565;9667.178289845302;9751.65869194589;9973.202143828476;7908.2091790821605;7949.443538952218;7957.681692732226;8119.79700507492;8253.463524870864;9257.583408746623;9307.720768376825;9406.90593094074;9408.294377921546;9460.249853776935;3749.3251214781058;3750.3057043177796;3882.475865758143;3923.2349691809823;3974.28462876685;955.5795450001976;960.6157536985262;979.4221409368364;999.0209594597335;1000.1099021870541;20280.79719202789;21607.783922160892;21696.78303216979;21775.455613609785;21812.89093554554;986.2827909110355;997.436448406648;997.4663554998041;1005.2410430125209;1008.7679833638305;11574;11927.403629818475;11980.64058078259;12031.157818952765;12036.879631203576;635585;636051;644895;648444;649715;110022.44988775004;110454.89545104608;111763.44118279357;112125.43937280262;112569.43715281536;1226.9509219631293;1233.8272641830151;1260.136806287696;1270.9110362274553;1273.9681507962189;14553.345099470338;19491.51271218231;19565.70651440258;19566.902165489082;19573.314933977243;48498;48688;48960.51039489702;49324;49412.50587494079;58066.70966645309;58768;59453;59781.40218597932;60048;12954.80567791465;13077.673058173621;13176;13249.706389464927;13498.52755153565;13122.475100995853;13924.443022278996;14268.928655356656;14364.784528232294;14561.199134047305;12751.234925904475;12807.743845123232;12841.93579032099;12872.356382180666;13045.608631741063;12253.571125010581;12412.317322546985;12428.56500022495;12493.812592810933;12626.810597840857;12441.315727635067;12664.87335126637;12763.170393924365;12798.040146988827;12892.935535322264;12798.808017879925;12809.423575939292;12892.226466412045;13049.673758156123;13071.869281307065;12038.277703337828;12505.749885002431;12878.162919410208;13246.536371226961;13413.195208287143 09:20:33 INFO - PROCESS | 9054 | |3;mootools.html;1521.6348076461652;1550.6123469132717;1576.2591581956478;1591.793066901303;1594.553525012996;10375;10975.341479511226;10978.725531861697;10990.615328463506;11005.119590432747;10566.682999510027;10878.891211087886;11193;11198.38408887511;11211.775764484726;2448.3756642056296;2489.6638953741285;2491.700995880497;2494.675692160026;2494.887730052152;2364.255259593231;2418.842775219614;2420.104561312317;2420.7942324902406;2423.503181847717;2339.3800642829665;2348.6242201247805;2363.1374548289837;2363.917262895799;2371.039728909794;2315.9305220843403;2341.7658234176533;2343.6718859359703;2344.824138189643;2345.8827058647084;2273.3861857298602;2283.6069997301634;2303.37808791627;2308.3998160478227;2320.396696858829;11465.828012579817;11655.475503602358;11668.299902005821;11671.591494297743;11679.7080072998;5726.255586773693;5882.499987501067;5897.764089436418;5898.8820223595285;5899.882002359972;3576.535050443452;3622.166901612644;3672.779633222015;3696.2977034363385;3711.832967516468;1222.49877550204;1261.4071386448354;1263.4882872436679;1315.907886447949;1371.8422381426165;15102.848971510253;15462.536123916301;15931.522054338388;17028.40400585986;17158.914205428893;4608.2166031774;4681.157391669532;4685.01614660925;4692.296155576691;4714.434267887876;10517.894821051692;12205.572804951784;12211.633650990485;12225.510979560719;12260.203086799329;4897.706137631753;5537.224788529609;5659.858503537444;5678.318601767732;5679.77280908759;5223;5343.957928203963;5389.568834493231;5451.836444906659;5457.2359869618285;4040.515138183378;4056.553779084298;4107.67138628909;4130.979345103256;4155.3766934959995;1022.7596514819012;1022.9028242316969;1023.2990401574796;1036.300497164411;1039.5010395010438;981.3964411886781;990.1830989433746;990.8018396320765;995.7311525887969;996.4071377530358;6825.69284382204;6865.759698410631;6876.243613202544;6986.545874518241;7042.647867606599;1052.0325605561986;1060.2843080920502;1069.1607088435542;1090.798202332571;1096.276457538037;4456.22016147173;4459.554044595579;4469.754163521037;4487.214737420938;4546.431696037996;13471.797923031163;13892.86107138936;14133.929330353283;14224.359903804354;14814.259287035606;13984.790228146587;14199.929000354932;14426.422943082369;14457;14606.269686515632;10558.683239502827;10737.409442480739;10755.516001779783;10851.78296434067;10875;6917.515773895779;7022.613756243251;7100.467464940047;7131.8573628528175;7196.712131514681;10578.259521833397;12753.744925101631;13001.414936328078;13026.54407095747;13034.348282586023;13207.801882971571;13326.133801302884;13567.79648305296;13578.117422367515;13690.589282321545;9599.856002159833;9603.951980240054;9774.071463210983;9804.313698041069;9960.501974901372;11173.162012849232;11244.10047196206;11359.943200284277;11362;11369.772604548029;9459.716208513755;9508.477033762932;9556.85664715016;9655.710328690151;9687.32188746781;9594.136472797021;9608.95195524018;9631.325807193429;9739.318247722591;9953.303268771406;8807.383483156118;8858.64565417376;8918.73243802687;8924;8929.374943753875;6266.561340706106;6372.6495042773095;6373.968130159319;6406.391392817675;6428.935710643021;6357.237131544244;6390.169277993831;6451.000094985285;6499.447546958372;6625.436837868835 09:20:33 INFO - PROCESS | 9054 | |4;prototype.html;418.43093392985514;433.18561105122365;433.3196880896991;439.74055307368667;442.4425224217483;5183.2225166225035;5236.476352364762;5290.201331547273;5309.548688361489;5329.733513324338;4935.629827762914;5184.377874655037;5213.608979326556;5236.73816309184;5252.606054545915;4334.43652325198;4346.369776382423;4352.477702675684;4356.912861742763;4359.803808828595;4353.325234588644;4377.7592232427205;4398.208322501949;4420;4425.181341451826;4383.912321753563;4420.734755914639;4424.867253982386;4427.601515863572;4436.268015777393;4212.178625168078;4345.217860785057;4357.629601483878;4362.345648152771;4404.757738324391;4082.7142100053006;4133.627973482401;4139.21354942563;4144.896377590554;4156.937645935313;5049.863780649362;5062.797488100471;5094.61790365724;5096.643234973553;5099.388073431212;5050.469700681412;5067.543921047123;5129.9227162295965;5135.152699804527;5197.298364720752;5509.063459211943;5532.6680399175775;5542.667439953575;5543.944560554423;5550.667839718479;4619.676622636417;4626.537346265347;4639.76801159944;4691.272852707836;4691.390119284505;5428.022955867942;5556.611037227396;5562.888742225174;5587.273654424939;5643.604947653625;4645.581897629229;4664.976675116671;4693.812247510062;4770.928436073462;4796.616270698336;4831.855044348676;4832.975835120802;4847.854564363075;4865.70805751656;4886.706797592155;4694.624430045588;4822.469528351879;4870.196417591058;5049.267856160836;5136;5428;5436.782528698808;5437.71615921314;5439.5376393006245;5458.727063646802;1637.025969548117;1640.409452597064;1648.983510164883;1659.7427398753211;1663.9184530055318;1230.4094034863315;1276.6658841510643;1295.7019885426405;1307.843058832927;1317.617890811654;5306.391653675538;5463.453654634504;5493.148561972901;5509.228707980886;5531.889362212733;5613.316005198424;5623.690697011703;5632.464915832989;5663.461971112738;5678.750674851526;5486.725663716798;5492.47821456961;5503.724813759296;5521.254630624894;5530.170474428868;2859;2981.659397373052;2982.6569944456664;2995.445842519141;3014.14096982359;5936.495397891142;5946.1972633693895;5952.9107063394085;5957.702114894238;5984.910226346608;5543.445655434424;5847.415258474203;5855.619384739978;5858;5861.472467477947;5749.8275051748515;5867.031939729897;5915.497182739516;5944.2254168602385;5971.895199388127;5659.717014149359;5691.8292451226525;5752.33848107473;5818.34177259479;5823.8657644385285;5363.704996225245;5456.972715136399;5498.80754173618;5646.971765141148;5677.063284558001;5786.94213057864;5907.438793314628;5943.762249510144;5961.880762384815;5966.791162309299;4723.27600425849;4727.983483551053;4753.287006948847;4785.521447855187;4812.614990800797;5457.690154363004;5513.3108361454815;5612.579056570692;5614.803481878278;5701.743421545957;5487.862803429946;5491.7254137292175;5513.393526712139;5516.806911758069;5525.834224973257;5330.866728331823;5519.668819870821;5537.172732998181;5538.1786567268455;5564.888702226014;5421.728913554228;5432.972835135799;5473.06957817164;5485.177223416519;5493.533049690821;5527.668339899458;5542.722863856871;5592.27300450955;5617.74170980822;5618.325800903917;5327.387350454747;5429.294191755047;5473.223475801684;5491.560675146058;5511.614187006871 09:20:33 INFO - PROCESS | 9054 | |5;yui.html;826.6817275348989;872.698918872989;896.565165894541;910.5765818894215;930.0838673906201;15684;16494.67010659786;16497.257623406946;16517.999999999985;16572.917135414322;16253.593660158502;17002.659946801057;17378.47864564062;17483.300667973264;17513.211905464254;869.3653632848009;888.1207604471559;890.5502721125855;895.2837729816154;915.6154415145655;910.0808183734442;913.0549880873298;913.1781396742919;913.2602591900549;913.5751875377948;955.4076472586971;957.1337939165032;957.2198658093631;958.8178246133248;961.8893827209855;956.0726095687172;957.8754761880981;959.3859929644963;959.3955807841015;959.596969272907;694.038756322497;699.867025265198;700.6076597105637;702.6732569355274;705.2453874354443;16899.662006759918;17315.913420432942;17428.302867885268;17492.300307987665;17515.5621109472;16071.116088615121;16261.837381626268;16325.26536305869;16471.91764041172;16642.83357166425;13520.864791352058;13777.793333099911;13855.515056973058;13987.580372588838;14128.788068178985;4005.459262999487;4007.6393124618635;4051.6353528182603;4070.1859628074208;4175.060611362419;44647.33029004535;55184;78268.60865695692;80984.59507702423;83220.58389708074;11657.533698652129;12023.458944347525;12166;12320.322382268881;12591.622251332476;22560.420770545905;22596.88701556482;22606.886965565394;22784;22807.657885131404;8216.548089854996;8231.42380033392;8495.957520212483;8647.697330593399;8670.653173873101;4953.752312384367;5181.119209734355;5192.636515443958;5199.532042116228;5234.241035049897;3688.8708895189075;3775.301569209705;3777.1690228149764;3782.6217378261954;3782.659560639556;631.1164369882201;641.7048157847349;641.8138739765509;642.408983734965;647.889858724018;668.6426554095098;677.552815142004;685.8662560800695;700.9228984811666;703.4583370804554;11307.49116289769;11704.414779261004;11907.821382679267;11989;12313.815292770616;701.4809041309496;706.9293070692889;717.5156769180886;725.6879541796973;734.930181632744;5310.9734451327495;5343.625946183807;5396.892062158735;5486.341639003345;5487.862803429866;80915;81515;82994.58502707448;85004;85269.57365213259;62311.688441557504;71770.64114679393;73101;73591.26408735951;74837.62581187168;63626;64140.679296604154;64505.67747161234;65158;65853.01220481697;10167.7458063549;10721.839172412265;10728;10733.624323148651;10776.946115269373;37663.81168094142;37880.62119378771;39854.202915940936;40372.16464435874;42664;51157.48842511527;54705.45294547004;55097.17354239609;55418.16872746831;55603;13620.795688064885;13778;14269.571912842632;14276.14343139415;14528.346224420138;16719.164041798103;17026.404075857285;17154.65690686204;17155.485335439957;17727.73408398901;15231.390744370101;16522.09128497896;16680.49958501247;17403.47789566315;17418.21618027217;15491.922540387677;15727;15949.282282297556;15953.840461595235;16412.671746564763;14395.352209150822;14744.189069601274;14939.477118300807;15588.84411155874;15857.365705371656;11562.19064665499;11968.640940771442;12320.75358492843;12325.753484930072;12332.691682708004;11597.245258170524;11645.88354116482;11753.823692644788;11854.466549005143;11916.52333906634 09:20:33 INFO - PROCESS | 9054 | __end_tp_report 09:20:33 INFO - PROCESS | 9054 | __start_cc_report 09:20:33 INFO - PROCESS | 9054 | _x_x_mozilla_cycle_collect,1546 09:20:33 INFO - PROCESS | 9054 | __end_cc_report 09:20:33 INFO - PROCESS | 9054 | __startTimestamp1490286033487__endTimestamp 09:20:33 INFO - PROCESS | 9054 | 09:20:33 INFO - PROCESS | 9054 | ------- Summary: start ------- 09:20:33 INFO - PROCESS | 9054 | Number of tests: 6 09:20:33 INFO - PROCESS | 9054 | 09:20:33 INFO - PROCESS | 9054 | [#0] dojo.html Cycles:165 Average:5760.47 Median:6028.25 stddev:678.06 (11.2%) stddev-sans-first:653.50 09:20:33 INFO - PROCESS | 9054 | Values: 3361.3 3401.4 3403.7 3422.6 3455.6 5695.8 5783.1 5790.5 5792.7 5804.3 5774.8 5814.4 5817.7 5819.1 5829.7 5151.9 5191.3 5194.8 5197.6 5250.3 5043.5 5087.7 5253.1 5262.5 5264.8 5085.2 5097.5 5181.6 5204.2 5215.6 5207.8 5213.9 5221.2 5224.1 5238.6 4978.6 5072.7 5140.1 5180.9 5201.0 5642.7 5652.2 5718.8 5730.9 5732.9 6193.8 6219.1 6229.4 6231.5 6244.8 6271.7 6303.5 6307.2 6313.4 6321.3 5607.7 5643.2 5741.4 5797.9 5797.9 6382.6 6383.9 6385.3 6388.1 6391.1 6107.4 6152.4 6162.2 6173.9 6176.9 5979.0 6031.4 6117.9 6157.4 6236.9 6202.7 6226.6 6239.9 6242.7 6245.1 5979.8 6016.4 6093.8 6125.8 6221.3 4647.1 4739.6 4743.2 4764.6 4765.2 4145.2 4159.8 4196.8 4234.1 4250.1 6011.5 6062.2 6067.5 6092.6 6100.3 6246.8 6272.1 6278.5 6284.2 6290.1 5881.9 5894.3 6062.7 6063.3 6065.5 5224.4 5248.1 5299.9 5321.8 5337.2 6485.2 6512.7 6516.7 6518.3 6520.5 5977.0 6078.8 6254.4 6265.0 6269.4 6395.9 6442.1 6527.2 6552.2 6574.6 6189.3 6190.6 6190.8 6198.1 6204.1 6014.1 6268.2 6281.4 6281.6 6285.8 5907.1 6019.2 6036.5 6113.1 6129.3 6053.9 6097.9 6105.6 6111.7 6127.6 5765.6 6038.1 6039.6 6043.1 6044.1 6023.1 6025.2 6026.7 6028.2 6053.2 6003.0 6003.7 6005.8 6035.5 6046.9 09:20:33 INFO - PROCESS | 9054 | 09:20:33 INFO - PROCESS | 9054 | [#1] ext.html Cycles:180 Average:45588.71 Median:31401.11 stddev:75559.68 (240.6%) stddev-sans-first:75696.50 09:20:33 INFO - PROCESS | 9054 | Values: 709.7 798.9 816.8 834.0 852.2 31904.7 44112.6 46018.3 46185.5 46263.5 42444.2 42674.6 42692.4 47549.8 47902.5 7658.5 9172.8 9297.3 9310.0 9319.4 7822.0 10203.7 10448.2 10765.5 10773.4 10532.8 10553.5 10560.5 10560.6 10564.6 10484.7 10543.8 10572.7 10575.7 10584.5 10665.6 10728.9 10735.6 10742.6 10744.9 43883.3 43992.8 44019.8 44029.0 44029.3 4173.4 4178.7 4231.1 4307.5 4341.2 29887.0 30493.7 30535.5 31211.8 31909.0 4371.5 4435.6 4444.3 4447.2 4474.8 233819.0 234653.0 234897.0 235186.0 235618.0 54298.7 54317.5 54349.5 54396.7 54404.0 56703.4 57066.4 57120.0 57295.7 57387.7 16878.9 17159.1 17189.1 17201.5 17221.0 12936.5 13362.5 15170.2 15192.0 15210.2 13159.3 13351.0 13423.9 13534.1 13781.2 5162.7 5234.0 5234.8 5290.0 5310.2 984.6 1002.8 1008.8 1011.3 1027.2 28988.7 29066.1 29444.7 29485.9 29747.3 1078.8 1080.4 1088.5 1089.1 1094.3 14832.5 15620.6 15638.1 15736.9 16003.2 327462.0 328711.0 330684.0 330886.0 332322.0 52204.2 52310.0 52322.5 52347.0 52382.7 1445.4 1445.7 1475.4 1483.3 1493.6 27869.3 29094.0 29519.3 29780.7 29810.3 37787.2 37863.4 37877.4 37888.4 37961.4 294303.0 294640.0 295287.0 295406.0 296039.0 25065.5 25720.0 30066.2 30074.2 30088.2 38361.8 39284.2 42652.8 43034.8 43416.3 32879.0 34212.8 34379.5 34398.0 34454.3 33925.3 34089.5 34169.5 34179.3 34287.0 34748.8 35350.1 35411.0 35527.3 36016.0 29305.4 30856.7 31316.2 31368.8 31433.4 24849.5 24877.6 24971.1 25152.1 25321.7 09:20:33 INFO - PROCESS | 9054 | 09:20:33 INFO - PROCESS | 9054 | [#2] jquery.html Cycles:180 Average:36961.55 Median:12369.62 stddev:105963.05 (856.6%) stddev-sans-first:106224.78 09:20:33 INFO - PROCESS | 9054 | Values: 421.9 459.7 462.8 474.8 486.2 18936.3 19852.0 20669.9 20738.7 20744.2 20760.6 21212.0 22255.6 22259.1 22467.3 6727.7 6731.8 6856.4 6988.1 6989.4 6789.7 6866.6 6868.7 6875.5 6877.3 6703.9 6836.4 6843.2 6857.4 6884.6 6683.3 6839.4 6870.0 6928.7 6929.2 6629.0 6726.5 6726.6 6735.3 6739.9 25070.4 25422.6 25724.5 25845.7 25894.0 3083.2 3121.6 3137.5 3165.1 3217.4 16037.3 16967.4 17215.3 17233.8 17521.0 2179.4 2229.9 2246.2 2271.9 2337.9 113431.4 116777.4 116919.0 117662.0 118110.0 14707.7 16269.4 18477.6 18493.8 18957.6 32331.2 32342.8 32414.0 32438.2 32919.5 9594.7 9650.7 9667.2 9751.7 9973.2 7908.2 7949.4 7957.7 8119.8 8253.5 9257.6 9307.7 9406.9 9408.3 9460.2 3749.3 3750.3 3882.5 3923.2 3974.3 955.6 960.6 979.4 999.0 1000.1 20280.8 21607.8 21696.8 21775.5 21812.9 986.3 997.4 997.5 1005.2 1008.8 11574.0 11927.4 11980.6 12031.2 12036.9 635585.0 636051.0 644895.0 648444.0 649715.0 110022.4 110454.9 111763.4 112125.4 112569.4 1227.0 1233.8 1260.1 1270.9 1274.0 14553.3 19491.5 19565.7 19566.9 19573.3 48498.0 48688.0 48960.5 49324.0 49412.5 58066.7 58768.0 59453.0 59781.4 60048.0 12954.8 13077.7 13176.0 13249.7 13498.5 13122.5 13924.4 14268.9 14364.8 14561.2 12751.2 12807.7 12841.9 12872.4 13045.6 12253.6 12412.3 12428.6 12493.8 12626.8 12441.3 12664.9 12763.2 12798.0 12892.9 12798.8 12809.4 12892.2 13049.7 13071.9 12038.3 12505.7 12878.2 13246.5 13413.2 09:20:33 INFO - PROCESS | 9054 | 09:20:33 INFO - PROCESS | 9054 | [#3] mootools.html Cycles:180 Average:7060.91 Median:2394.94 stddev:4454.57 (186.0%) stddev-sans-first:4447.62 09:20:33 INFO - PROCESS | 9054 | Values: 1521.6 1550.6 1576.3 1591.8 1594.6 10375.0 10975.3 10978.7 10990.6 11005.1 10566.7 10878.9 11193.0 11198.4 11211.8 2448.4 2489.7 2491.7 2494.7 2494.9 2364.3 2418.8 2420.1 2420.8 2423.5 2339.4 2348.6 2363.1 2363.9 2371.0 2315.9 2341.8 2343.7 2344.8 2345.9 2273.4 2283.6 2303.4 2308.4 2320.4 11465.8 11655.5 11668.3 11671.6 11679.7 5726.3 5882.5 5897.8 5898.9 5899.9 3576.5 3622.2 3672.8 3696.3 3711.8 1222.5 1261.4 1263.5 1315.9 1371.8 15102.8 15462.5 15931.5 17028.4 17158.9 4608.2 4681.2 4685.0 4692.3 4714.4 10517.9 12205.6 12211.6 12225.5 12260.2 4897.7 5537.2 5659.9 5678.3 5679.8 5223.0 5344.0 5389.6 5451.8 5457.2 4040.5 4056.6 4107.7 4131.0 4155.4 1022.8 1022.9 1023.3 1036.3 1039.5 981.4 990.2 990.8 995.7 996.4 6825.7 6865.8 6876.2 6986.5 7042.6 1052.0 1060.3 1069.2 1090.8 1096.3 4456.2 4459.6 4469.8 4487.2 4546.4 13471.8 13892.9 14133.9 14224.4 14814.3 13984.8 14199.9 14426.4 14457.0 14606.3 10558.7 10737.4 10755.5 10851.8 10875.0 6917.5 7022.6 7100.5 7131.9 7196.7 10578.3 12753.7 13001.4 13026.5 13034.3 13207.8 13326.1 13567.8 13578.1 13690.6 9599.9 9604.0 9774.1 9804.3 9960.5 11173.2 11244.1 11359.9 11362.0 11369.8 9459.7 9508.5 9556.9 9655.7 9687.3 9594.1 9609.0 9631.3 9739.3 9953.3 8807.4 8858.6 8918.7 8924.0 8929.4 6266.6 6372.6 6374.0 6406.4 6428.9 6357.2 6390.2 6451.0 6499.4 6625.4 09:20:33 INFO - PROCESS | 9054 | 09:20:33 INFO - PROCESS | 9054 | [#4] prototype.html Cycles:180 Average:4820.53 Median:5328.56 stddev:1283.62 (24.1%) stddev-sans-first:1243.97 09:20:33 INFO - PROCESS | 9054 | Values: 418.4 433.2 433.3 439.7 442.4 5183.2 5236.5 5290.2 5309.5 5329.7 4935.6 5184.4 5213.6 5236.7 5252.6 4334.4 4346.4 4352.5 4356.9 4359.8 4353.3 4377.8 4398.2 4420.0 4425.2 4383.9 4420.7 4424.9 4427.6 4436.3 4212.2 4345.2 4357.6 4362.3 4404.8 4082.7 4133.6 4139.2 4144.9 4156.9 5049.9 5062.8 5094.6 5096.6 5099.4 5050.5 5067.5 5129.9 5135.2 5197.3 5509.1 5532.7 5542.7 5543.9 5550.7 4619.7 4626.5 4639.8 4691.3 4691.4 5428.0 5556.6 5562.9 5587.3 5643.6 4645.6 4665.0 4693.8 4770.9 4796.6 4831.9 4833.0 4847.9 4865.7 4886.7 4694.6 4822.5 4870.2 5049.3 5136.0 5428.0 5436.8 5437.7 5439.5 5458.7 1637.0 1640.4 1649.0 1659.7 1663.9 1230.4 1276.7 1295.7 1307.8 1317.6 5306.4 5463.5 5493.1 5509.2 5531.9 5613.3 5623.7 5632.5 5663.5 5678.8 5486.7 5492.5 5503.7 5521.3 5530.2 2859.0 2981.7 2982.7 2995.4 3014.1 5936.5 5946.2 5952.9 5957.7 5984.9 5543.4 5847.4 5855.6 5858.0 5861.5 5749.8 5867.0 5915.5 5944.2 5971.9 5659.7 5691.8 5752.3 5818.3 5823.9 5363.7 5457.0 5498.8 5647.0 5677.1 5786.9 5907.4 5943.8 5961.9 5966.8 4723.3 4728.0 4753.3 4785.5 4812.6 5457.7 5513.3 5612.6 5614.8 5701.7 5487.9 5491.7 5513.4 5516.8 5525.8 5330.9 5519.7 5537.2 5538.2 5564.9 5421.7 5433.0 5473.1 5485.2 5493.5 5527.7 5542.7 5592.3 5617.7 5618.3 5327.4 5429.3 5473.2 5491.6 5511.6 09:20:33 INFO - PROCESS | 9054 | 09:20:33 INFO - PROCESS | 9054 | [#5] yui.html Cycles:180 Average:18242.56 Median:22211.90 stddev:22173.82 (99.8%) stddev-sans-first:22197.45 09:20:33 INFO - PROCESS | 9054 | Values: 826.7 872.7 896.6 910.6 930.1 15684.0 16494.7 16497.3 16518.0 16572.9 16253.6 17002.7 17378.5 17483.3 17513.2 869.4 888.1 890.6 895.3 915.6 910.1 913.1 913.2 913.3 913.6 955.4 957.1 957.2 958.8 961.9 956.1 957.9 959.4 959.4 959.6 694.0 699.9 700.6 702.7 705.2 16899.7 17315.9 17428.3 17492.3 17515.6 16071.1 16261.8 16325.3 16471.9 16642.8 13520.9 13777.8 13855.5 13987.6 14128.8 4005.5 4007.6 4051.6 4070.2 4175.1 44647.3 55184.0 78268.6 80984.6 83220.6 11657.5 12023.5 12166.0 12320.3 12591.6 22560.4 22596.9 22606.9 22784.0 22807.7 8216.5 8231.4 8496.0 8647.7 8670.7 4953.8 5181.1 5192.6 5199.5 5234.2 3688.9 3775.3 3777.2 3782.6 3782.7 631.1 641.7 641.8 642.4 647.9 668.6 677.6 685.9 700.9 703.5 11307.5 11704.4 11907.8 11989.0 12313.8 701.5 706.9 717.5 725.7 734.9 5311.0 5343.6 5396.9 5486.3 5487.9 80915.0 81515.0 82994.6 85004.0 85269.6 62311.7 71770.6 73101.0 73591.3 74837.6 63626.0 64140.7 64505.7 65158.0 65853.0 10167.7 10721.8 10728.0 10733.6 10776.9 37663.8 37880.6 39854.2 40372.2 42664.0 51157.5 54705.5 55097.2 55418.2 55603.0 13620.8 13778.0 14269.6 14276.1 14528.3 16719.2 17026.4 17154.7 17155.5 17727.7 15231.4 16522.1 16680.5 17403.5 17418.2 15491.9 15727.0 15949.3 15953.8 16412.7 14395.4 14744.2 14939.5 15588.8 15857.4 11562.2 11968.6 12320.8 12325.8 12332.7 11597.2 11645.9 11753.8 11854.5 11916.5 09:20:33 INFO - PROCESS | 9054 | -------- Summary: end -------- 09:20:33 INFO - PROCESS | 9054 | 09:20:34 INFO - TEST-INFO | 9054: exit 0 09:20:34 INFO - TEST-OK | dromaeo_css | took 1115563ms 09:20:34 INFO - TEST-START | kraken 09:20:34 INFO - operating with platform_type : linux_ 09:20:34 INFO - Initialising browser for kraken test... 09:20:34 INFO - TEST-INFO | started process 9382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCkHvmY/profile http://localhost:55194/getInfo.html) 09:20:38 INFO - PROCESS | 9382 | __metrics Screen width/height:1600/1200 09:20:38 INFO - PROCESS | 9382 | colorDepth:24 09:20:38 INFO - PROCESS | 9382 | Browser inner width/height: 1024/697 09:20:38 INFO - PROCESS | 9382 | __metrics 09:20:39 INFO - PROCESS | 9382 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:20:39 INFO - PROCESS | 9382 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:20:40 INFO - TEST-INFO | 9382: exit 0 09:20:40 INFO - Browser initialized. 09:20:40 INFO - Running cycle 1/1 for kraken test... 09:20:40 INFO - TEST-INFO | started process 9473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCkHvmY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:52 INFO - PROCESS | 9473 | RSS: Main: 139730944 09:20:52 INFO - PROCESS | 9473 | 09:20:54 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55194/tests/kraken/driver.html?testName=audio-beat-detection) 09:20:55 INFO - PROCESS | 9473 | RSS: Main: 183255040 09:20:55 INFO - PROCESS | 9473 | 09:20:58 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55194/tests/kraken/driver.html?testName=audio-dft) 09:20:58 INFO - PROCESS | 9473 | RSS: Main: 174178304 09:20:58 INFO - PROCESS | 9473 | 09:21:01 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55194/tests/kraken/driver.html?testName=audio-fft) 09:21:02 INFO - PROCESS | 9473 | RSS: Main: 266362880 09:21:02 INFO - PROCESS | 9473 | 09:21:04 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55194/tests/kraken/driver.html?testName=audio-oscillator) 09:21:04 INFO - PROCESS | 9473 | RSS: Main: 171331584 09:21:04 INFO - PROCESS | 9473 | 09:21:06 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55194/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:07 INFO - PROCESS | 9473 | RSS: Main: 174272512 09:21:07 INFO - PROCESS | 9473 | 09:21:10 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55194/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:10 INFO - PROCESS | 9473 | RSS: Main: 213516288 09:21:10 INFO - PROCESS | 9473 | 09:21:14 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55194/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:14 INFO - PROCESS | 9473 | RSS: Main: 211718144 09:21:14 INFO - PROCESS | 9473 | 09:21:17 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55194/tests/kraken/driver.html?testName=json-parse-financial) 09:21:18 INFO - PROCESS | 9473 | RSS: Main: 210026496 09:21:18 INFO - PROCESS | 9473 | 09:21:19 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55194/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:20 INFO - PROCESS | 9473 | RSS: Main: 172896256 09:21:20 INFO - PROCESS | 9473 | 09:21:22 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55194/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:22 INFO - PROCESS | 9473 | RSS: Main: 179879936 09:21:22 INFO - PROCESS | 9473 | 09:21:24 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55194/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:25 INFO - PROCESS | 9473 | RSS: Main: 190046208 09:21:25 INFO - PROCESS | 9473 | 09:21:27 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:28 INFO - PROCESS | 9473 | RSS: Main: 198389760 09:21:28 INFO - PROCESS | 9473 | 09:21:31 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:21:31 INFO - PROCESS | 9473 | RSS: Main: 194691072 09:21:31 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | Cycle 1(1): loaded http://localhost:55194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55194/tests/kraken/driver.html?testName=ai-astar) 09:21:33 INFO - PROCESS | 9473 | RSS: Main: 246538240 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | __start_tp_report 09:21:33 INFO - PROCESS | 9473 | _x_x_mozilla_page_load 09:21:33 INFO - PROCESS | 9473 | _x_x_mozilla_page_load_details 09:21:33 INFO - PROCESS | 9473 | |i|pagename|runs| 09:21:33 INFO - PROCESS | 9473 | |0;ai-astar;102;112;112;112;113;112;112;114;112;112 09:21:33 INFO - PROCESS | 9473 | |1;audio-beat-detection;145;118;115;159;122;116;129;116;131;117 09:21:33 INFO - PROCESS | 9473 | |2;audio-dft;162;159;161;162;161;162;159;158;160;159 09:21:33 INFO - PROCESS | 9473 | |3;audio-fft;74;75;74;110;75;75;76;75;91;75 09:21:33 INFO - PROCESS | 9473 | |4;audio-oscillator;81;81;103;81;81;81;105;81;81;108 09:21:33 INFO - PROCESS | 9473 | |5;imaging-gaussian-blur;114;114;114;112;113;113;113;113;113;113 09:21:33 INFO - PROCESS | 9473 | |6;imaging-darkroom;147;146;147;146;147;146;148;147;146;146 09:21:33 INFO - PROCESS | 9473 | |7;imaging-desaturate;94;94;94;93;94;95;93;94;94;94 09:21:33 INFO - PROCESS | 9473 | |8;json-parse-financial;55;55;54;54;53;55;60;54;54;54 09:21:33 INFO - PROCESS | 9473 | |9;json-stringify-tinderbox;54;56;55;54;54;55;54;54;54;54 09:21:33 INFO - PROCESS | 9473 | |10;stanford-crypto-aes;80;76;76;81;82;75;75;76;74;74 09:21:33 INFO - PROCESS | 9473 | |11;stanford-crypto-ccm;123;121;122;126;120;131;120;121;176;129 09:21:33 INFO - PROCESS | 9473 | |12;stanford-crypto-pbkdf2;158;161;159;157;164;158;157;159;163;156 09:21:33 INFO - PROCESS | 9473 | |13;stanford-crypto-sha256-iterative;61;64;60;61;64;59;60;60;60;59 09:21:33 INFO - PROCESS | 9473 | __end_tp_report 09:21:33 INFO - PROCESS | 9473 | __start_cc_report 09:21:33 INFO - PROCESS | 9473 | _x_x_mozilla_cycle_collect,1662 09:21:33 INFO - PROCESS | 9473 | __end_cc_report 09:21:33 INFO - PROCESS | 9473 | __startTimestamp1490286093645__endTimestamp 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | ------- Summary: start ------- 09:21:33 INFO - PROCESS | 9473 | Number of tests: 14 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.33 (3.0%) stddev-sans-first:0.71 09:21:33 INFO - PROCESS | 9473 | Values: 102.0 112.0 112.0 112.0 113.0 112.0 112.0 114.0 112.0 112.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:125.50 stddev:14.76 (11.8%) stddev-sans-first:14.10 09:21:33 INFO - PROCESS | 9473 | Values: 145.0 118.0 115.0 159.0 122.0 116.0 129.0 116.0 131.0 117.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.45 09:21:33 INFO - PROCESS | 9473 | Values: 162.0 159.0 161.0 162.0 161.0 162.0 159.0 158.0 160.0 159.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.00 stddev:11.71 (15.6%) stddev-sans-first:12.22 09:21:33 INFO - PROCESS | 9473 | Values: 74.0 75.0 74.0 110.0 75.0 75.0 76.0 75.0 91.0 75.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:81.00 stddev:11.81 (14.6%) stddev-sans-first:12.23 09:21:33 INFO - PROCESS | 9473 | Values: 81.0 81.0 103.0 81.0 81.0 81.0 105.0 81.0 81.0 108.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 09:21:33 INFO - PROCESS | 9473 | Values: 114.0 114.0 114.0 112.0 113.0 113.0 113.0 113.0 113.0 113.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:21:33 INFO - PROCESS | 9473 | Values: 147.0 146.0 147.0 146.0 147.0 146.0 148.0 147.0 146.0 146.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:21:33 INFO - PROCESS | 9473 | Values: 94.0 94.0 94.0 93.0 94.0 95.0 93.0 94.0 94.0 94.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:1.93 (3.5%) stddev-sans-first:2.05 09:21:33 INFO - PROCESS | 9473 | Values: 55.0 55.0 54.0 54.0 53.0 55.0 60.0 54.0 54.0 54.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 09:21:33 INFO - PROCESS | 9473 | Values: 54.0 56.0 55.0 54.0 54.0 55.0 54.0 54.0 54.0 54.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.00 stddev:2.96 (3.9%) stddev-sans-first:2.92 09:21:33 INFO - PROCESS | 9473 | Values: 80.0 76.0 76.0 81.0 82.0 75.0 75.0 76.0 74.0 74.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:124.50 stddev:16.99 (13.6%) stddev-sans-first:17.88 09:21:33 INFO - PROCESS | 9473 | Values: 123.0 121.0 122.0 126.0 120.0 131.0 120.0 121.0 176.0 129.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:2.66 (1.7%) stddev-sans-first:2.78 09:21:33 INFO - PROCESS | 9473 | Values: 158.0 161.0 159.0 157.0 164.0 158.0 157.0 159.0 163.0 156.0 09:21:33 INFO - PROCESS | 9473 | 09:21:33 INFO - PROCESS | 9473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:60.50 stddev:1.81 (3.0%) stddev-sans-first:1.92 09:21:33 INFO - PROCESS | 9473 | Values: 61.0 64.0 60.0 61.0 64.0 59.0 60.0 60.0 60.0 59.0 09:21:33 INFO - PROCESS | 9473 | -------- Summary: end -------- 09:21:33 INFO - PROCESS | 9473 | 09:21:34 INFO - TEST-INFO | 9473: exit 0 09:21:34 INFO - TEST-OK | kraken | took 60454ms 09:21:34 INFO - SUITE-END | took 1176s 09:21:34 INFO - Completed test suite (00:19:36) 09:21:34 INFO - javascript benchmark 09:21:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7828.436985281812, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3361.3109312590905, 3401.370746411914, 3403.693667569919, 3422.640622734614, 3455.5507783988087, 5695.829125126248, 5783.103618939066, 5790.507806836414, 5792.68140252286, 5804.303483581965, 5774.797882074128, 5814.447627475393, 5817.650940943547, 5819.098039803837, 5829.679367634779, 5151.871203219921, 5191.299174611436, 5194.792208311663, 5197.558207552363, 5250.264962905197, 5043.495650434964, 5087.694738315695, 5253.133233016567, 5262.500062494057, 5264.815731449381, 5085.160948443502, 5097.541221290083, 5181.559567436772, 5204.167333226685, 5215.608829337796, 5207.843764687046, 5213.921791173136, 5221.190715439113, 5224.111900976843, 5238.60710446718, 4978.5768209701855, 5072.746362681888, 5140.074786538422, 5180.896382072375, 5201.0, 5642.6614403135945, 5652.236948012048, 5718.79984200551, 5730.914036289459, 5732.856678583027, 6193.783217587408, 6219.067139929001, 6229.439350458435, 6231.501479881644, 6244.812655620339, 6271.749130034838, 6303.495720342362, 6307.211598550181, 6313.368663133696, 6321.336259692712, 5607.663540187602, 5643.209950606918, 5741.368449470513, 5797.855053623609, 5797.913031304533, 6382.553221274559, 6383.872322553616, 6385.2656944451055, 6388.105665206875, 6391.07329437229, 6107.4197951194565, 6152.446279834837, 6162.168107305546, 6173.938260617426, 6176.938230617726, 5979.043353063489, 6031.396860314021, 6117.888303246575, 6157.415045570664, 6236.906446403307, 6202.658853763086, 6226.59527130735, 6239.937600624026, 6242.719077641517, 6245.094461303085, 5979.79070732531, 6016.368281330485, 6093.817185484442, 6125.816225513242, 6221.346758590283, 4647.117047760915, 4739.597134243559, 4743.193657078305, 4764.6426518011285, 4765.189917713997, 4145.150244199932, 4159.792010399528, 4196.832126714959, 4234.13200293939, 4250.149970006011, 6011.48902343297, 6062.181605483203, 6067.484263837535, 6092.573519853568, 6100.298465676416, 6246.798776697545, 6272.090546870678, 6278.497720182374, 6284.151639528696, 6290.0879372491645, 5881.882362352729, 5894.263217097863, 6062.696865156725, 6063.272407311151, 6065.5450841187085, 5224.399194092652, 5248.081585722483, 5299.947000529945, 5321.760520776497, 5337.172738225581, 6485.189351331083, 6512.674366281667, 6516.706748196248, 6518.315576864456, 6520.543561950618, 5976.97011514957, 6078.848028799315, 6254.405831446005, 6264.968675156595, 6269.435750782452, 6395.904061438989, 6442.065900444503, 6527.249366322933, 6552.246491653521, 6574.638394888327, 6189.257289125334, 6190.566660333733, 6190.783322583688, 6198.132261483486, 6204.13142160089, 6014.0678194879865, 6268.2478102626155, 6281.371862813682, 6281.560290779602, 6285.842853928505, 5907.084401917709, 6019.18740969981, 6036.486898613667, 6113.141862489121, 6129.328227221949, 6053.9091913622215, 6097.908531372122, 6105.633661980295, 6111.7249723763425, 6127.632342059491, 5765.596408251382, 6038.064100064497, 6039.63762174271, 6043.123747056564, 6044.063170208625, 6023.066424704178, 6025.1564780931585, 6026.668533230539, 6028.246469191351, 6053.243344581927, 6003.0, 6003.699815009145, 6005.819825405245, 6035.547333949883, 6046.939530604637], "value": 5713.899434563672, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.6700034483964, 798.8761741930001, 816.7672213419173, 833.9833203335937, 852.2117041736392, 31904.680953190462, 44112.55887441125, 46018.309725354105, 46185.459799711, 46263.53736462635, 42444.15111697764, 42674.573254267445, 42692.35961460573, 47549.762251188695, 47902.52097479024, 7658.540487570764, 9172.770680732969, 9297.30270229732, 9310.044890572988, 9319.394239374453, 7822.0, 10203.6938891833, 10448.216383771209, 10765.515551800148, 10773.407462589554, 10532.842007369896, 10553.472326383688, 10560.471976401188, 10560.630377936774, 10564.630237941674, 10484.685459436152, 10543.789124217512, 10572.682819515427, 10575.682729518127, 10584.470776461185, 10665.626703065356, 10728.892711072946, 10735.604371431742, 10742.570297188104, 10744.946275268652, 43883.341749873776, 43992.78003609993, 44019.77990110061, 44029.0, 44029.33955990663, 4173.4157217989505, 4178.707490475668, 4231.090315582134, 4307.547707490731, 4341.240282950471, 29887.0, 30493.69506304953, 30535.541966870514, 31211.843940780152, 31909.0, 4371.540988196225, 4435.60079592835, 4444.266695995157, 4447.246658855773, 4474.82100715971, 233819.0, 234653.0, 234897.0, 235186.0, 235618.0, 54298.728506358006, 54317.45682543124, 54349.45650543523, 54396.72801636046, 54404.0, 56703.43296567064, 57066.42933570694, 57120.0, 57295.71352143296, 57387.71306143443, 16878.915605421895, 17159.142042898056, 17189.05460199676, 17201.483955481355, 17221.0, 12936.482540698455, 13362.53231136925, 15170.165640889636, 15192.0, 15210.163441010629, 13159.342032898317, 13351.0, 13423.932880335731, 13534.120282181626, 13781.242031688153, 5162.66442681232, 5233.973830130825, 5234.790608375699, 5290.0, 5310.150375939908, 984.5864736810556, 1002.754325190333, 1008.8284991551454, 1011.3325205364424, 1027.2039169643585, 28988.7101128986, 29066.082906008436, 29444.705552944626, 29485.85257073701, 29747.256318591775, 1078.800421921947, 1080.4327727942893, 1088.5264909764278, 1089.0742868561658, 1094.2559059839227, 14832.480863169952, 15620.609484762745, 15638.139902305482, 15736.921315393578, 16003.199840007954, 327462.0, 328711.0, 330684.0, 330886.0, 332322.0, 52204.21693674598, 52310.0, 52322.47677523252, 52347.0, 52382.738086310084, 1445.4218312675014, 1445.6916490575836, 1475.4024620028906, 1483.3028476615973, 1493.596728883217, 27869.303267417665, 29094.0, 29519.26201844971, 29780.70219297779, 29810.254743631584, 37787.24425511529, 37863.43204851985, 37877.43183852299, 37888.43167352547, 37961.43057854079, 294303.0, 294640.0, 295287.0, 295406.0, 296039.0, 25065.498690026463, 25720.0, 30066.24834379158, 30074.24814379658, 30088.24779380533, 38361.808190958865, 39284.214315714096, 42652.78673606612, 43034.78482607567, 43416.34875476934, 32879.0, 34212.82893585516, 34379.48430773491, 34398.0, 34454.31091378209, 33925.32149357048, 34089.48865766966, 34169.48745768766, 34179.31641367209, 34287.0, 34748.82625586856, 35350.07365012014, 35411.0, 35527.289454211284, 36016.0, 29305.413891722474, 30856.691433085383, 31316.217094571908, 31368.843155784074, 31433.37133257368, 24849.50300994006, 24877.62683559712, 24971.12601058954, 25152.11967581126, 25321.746782532675], "value": 18852.03050655352, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.91350773091517, 459.7153339390058, 462.80099557190414, 474.8124490826124, 486.2244719672123, 18936.337228196997, 19852.0, 20669.896650516745, 20738.688919666216, 20744.170233190693, 20760.584788304262, 21212.0, 22255.554888902214, 22259.109635614597, 22467.32598022058, 6727.6636168191635, 6731.8317042074095, 6856.382925536701, 6988.056612357317, 6989.440844732435, 6789.694463749119, 6866.588004719708, 6868.7252509899545, 6875.518713690044, 6877.312268773133, 6703.9329606703795, 6836.418904393133, 6843.247242803288, 6857.3828355448, 6884.5525040872435, 6683.2648408675, 6839.350261725178, 6869.965650171742, 6928.72285108595, 6929.1684997800085, 6628.966855165693, 6726.529142959995, 6726.562773419761, 6735.29279425663, 6739.932600673979, 25070.373240668945, 25422.618660720105, 25724.48551028969, 25845.74154258452, 25894.0, 3083.213780485984, 3121.5941927549275, 3137.4980003199607, 3165.129589362921, 3217.4369485340208, 16037.278322475517, 16967.406140785013, 17215.311387544483, 17233.827661723473, 17521.03634300113, 2179.400664817188, 2229.888505574731, 2246.2025980776752, 2271.909123635069, 2337.94155146121, 113431.43284283526, 116777.41611291889, 116919.0, 117662.0, 118110.0, 14707.749841263612, 16269.430569929995, 18477.630447391246, 18493.81506184948, 18957.62084758297, 32331.191720206712, 32342.83828580889, 32414.0, 32438.189045273586, 32919.50620740691, 9594.712158635251, 9650.71047868565, 9667.178289845302, 9751.65869194589, 9973.202143828476, 7908.2091790821605, 7949.443538952218, 7957.681692732226, 8119.79700507492, 8253.463524870864, 9257.583408746623, 9307.720768376825, 9406.90593094074, 9408.294377921546, 9460.249853776935, 3749.3251214781058, 3750.3057043177796, 3882.475865758143, 3923.2349691809823, 3974.28462876685, 955.5795450001976, 960.6157536985262, 979.4221409368364, 999.0209594597335, 1000.1099021870541, 20280.79719202789, 21607.783922160892, 21696.78303216979, 21775.455613609785, 21812.89093554554, 986.2827909110355, 997.436448406648, 997.4663554998041, 1005.2410430125209, 1008.7679833638305, 11574.0, 11927.403629818475, 11980.64058078259, 12031.157818952765, 12036.879631203576, 635585.0, 636051.0, 644895.0, 648444.0, 649715.0, 110022.44988775004, 110454.89545104608, 111763.44118279357, 112125.43937280262, 112569.43715281536, 1226.9509219631293, 1233.8272641830151, 1260.136806287696, 1270.9110362274553, 1273.9681507962189, 14553.345099470338, 19491.51271218231, 19565.70651440258, 19566.902165489082, 19573.314933977243, 48498.0, 48688.0, 48960.51039489702, 49324.0, 49412.50587494079, 58066.70966645309, 58768.0, 59453.0, 59781.40218597932, 60048.0, 12954.80567791465, 13077.673058173621, 13176.0, 13249.706389464927, 13498.52755153565, 13122.475100995853, 13924.443022278996, 14268.928655356656, 14364.784528232294, 14561.199134047305, 12751.234925904475, 12807.743845123232, 12841.93579032099, 12872.356382180666, 13045.608631741063, 12253.571125010581, 12412.317322546985, 12428.56500022495, 12493.812592810933, 12626.810597840857, 12441.315727635067, 12664.87335126637, 12763.170393924365, 12798.040146988827, 12892.935535322264, 12798.808017879925, 12809.423575939292, 12892.226466412045, 13049.673758156123, 13071.869281307065, 12038.277703337828, 12505.749885002431, 12878.162919410208, 13246.536371226961, 13413.195208287143], "value": 11447.231460657245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.6348076461652, 1550.6123469132717, 1576.2591581956478, 1591.793066901303, 1594.553525012996, 10375.0, 10975.341479511226, 10978.725531861697, 10990.615328463506, 11005.119590432747, 10566.682999510027, 10878.891211087886, 11193.0, 11198.38408887511, 11211.775764484726, 2448.3756642056296, 2489.6638953741285, 2491.700995880497, 2494.675692160026, 2494.887730052152, 2364.255259593231, 2418.842775219614, 2420.104561312317, 2420.7942324902406, 2423.503181847717, 2339.3800642829665, 2348.6242201247805, 2363.1374548289837, 2363.917262895799, 2371.039728909794, 2315.9305220843403, 2341.7658234176533, 2343.6718859359703, 2344.824138189643, 2345.8827058647084, 2273.3861857298602, 2283.6069997301634, 2303.37808791627, 2308.3998160478227, 2320.396696858829, 11465.828012579817, 11655.475503602358, 11668.299902005821, 11671.591494297743, 11679.7080072998, 5726.255586773693, 5882.499987501067, 5897.764089436418, 5898.8820223595285, 5899.882002359972, 3576.535050443452, 3622.166901612644, 3672.779633222015, 3696.2977034363385, 3711.832967516468, 1222.49877550204, 1261.4071386448354, 1263.4882872436679, 1315.907886447949, 1371.8422381426165, 15102.848971510253, 15462.536123916301, 15931.522054338388, 17028.40400585986, 17158.914205428893, 4608.2166031774, 4681.157391669532, 4685.01614660925, 4692.296155576691, 4714.434267887876, 10517.894821051692, 12205.572804951784, 12211.633650990485, 12225.510979560719, 12260.203086799329, 4897.706137631753, 5537.224788529609, 5659.858503537444, 5678.318601767732, 5679.77280908759, 5223.0, 5343.957928203963, 5389.568834493231, 5451.836444906659, 5457.2359869618285, 4040.515138183378, 4056.553779084298, 4107.67138628909, 4130.979345103256, 4155.3766934959995, 1022.7596514819012, 1022.9028242316969, 1023.2990401574796, 1036.300497164411, 1039.5010395010438, 981.3964411886781, 990.1830989433746, 990.8018396320765, 995.7311525887969, 996.4071377530358, 6825.69284382204, 6865.759698410631, 6876.243613202544, 6986.545874518241, 7042.647867606599, 1052.0325605561986, 1060.2843080920502, 1069.1607088435542, 1090.798202332571, 1096.276457538037, 4456.22016147173, 4459.554044595579, 4469.754163521037, 4487.214737420938, 4546.431696037996, 13471.797923031163, 13892.86107138936, 14133.929330353283, 14224.359903804354, 14814.259287035606, 13984.790228146587, 14199.929000354932, 14426.422943082369, 14457.0, 14606.269686515632, 10558.683239502827, 10737.409442480739, 10755.516001779783, 10851.78296434067, 10875.0, 6917.515773895779, 7022.613756243251, 7100.467464940047, 7131.8573628528175, 7196.712131514681, 10578.259521833397, 12753.744925101631, 13001.414936328078, 13026.54407095747, 13034.348282586023, 13207.801882971571, 13326.133801302884, 13567.79648305296, 13578.117422367515, 13690.589282321545, 9599.856002159833, 9603.951980240054, 9774.071463210983, 9804.313698041069, 9960.501974901372, 11173.162012849232, 11244.10047196206, 11359.943200284277, 11362.0, 11369.772604548029, 9459.716208513755, 9508.477033762932, 9556.85664715016, 9655.710328690151, 9687.32188746781, 9594.136472797021, 9608.95195524018, 9631.325807193429, 9739.318247722591, 9953.303268771406, 8807.383483156118, 8858.64565417376, 8918.73243802687, 8924.0, 8929.374943753875, 6266.561340706106, 6372.6495042773095, 6373.968130159319, 6406.391392817675, 6428.935710643021, 6357.237131544244, 6390.169277993831, 6451.000094985285, 6499.447546958372, 6625.436837868835], "value": 5347.206599487768, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.43093392985514, 433.18561105122365, 433.3196880896991, 439.74055307368667, 442.4425224217483, 5183.2225166225035, 5236.476352364762, 5290.201331547273, 5309.548688361489, 5329.733513324338, 4935.629827762914, 5184.377874655037, 5213.608979326556, 5236.73816309184, 5252.606054545915, 4334.43652325198, 4346.369776382423, 4352.477702675684, 4356.912861742763, 4359.803808828595, 4353.325234588644, 4377.7592232427205, 4398.208322501949, 4420.0, 4425.181341451826, 4383.912321753563, 4420.734755914639, 4424.867253982386, 4427.601515863572, 4436.268015777393, 4212.178625168078, 4345.217860785057, 4357.629601483878, 4362.345648152771, 4404.757738324391, 4082.7142100053006, 4133.627973482401, 4139.21354942563, 4144.896377590554, 4156.937645935313, 5049.863780649362, 5062.797488100471, 5094.61790365724, 5096.643234973553, 5099.388073431212, 5050.469700681412, 5067.543921047123, 5129.9227162295965, 5135.152699804527, 5197.298364720752, 5509.063459211943, 5532.6680399175775, 5542.667439953575, 5543.944560554423, 5550.667839718479, 4619.676622636417, 4626.537346265347, 4639.76801159944, 4691.272852707836, 4691.390119284505, 5428.022955867942, 5556.611037227396, 5562.888742225174, 5587.273654424939, 5643.604947653625, 4645.581897629229, 4664.976675116671, 4693.812247510062, 4770.928436073462, 4796.616270698336, 4831.855044348676, 4832.975835120802, 4847.854564363075, 4865.70805751656, 4886.706797592155, 4694.624430045588, 4822.469528351879, 4870.196417591058, 5049.267856160836, 5136.0, 5428.0, 5436.782528698808, 5437.71615921314, 5439.5376393006245, 5458.727063646802, 1637.025969548117, 1640.409452597064, 1648.983510164883, 1659.7427398753211, 1663.9184530055318, 1230.4094034863315, 1276.6658841510643, 1295.7019885426405, 1307.843058832927, 1317.617890811654, 5306.391653675538, 5463.453654634504, 5493.148561972901, 5509.228707980886, 5531.889362212733, 5613.316005198424, 5623.690697011703, 5632.464915832989, 5663.461971112738, 5678.750674851526, 5486.725663716798, 5492.47821456961, 5503.724813759296, 5521.254630624894, 5530.170474428868, 2859.0, 2981.659397373052, 2982.6569944456664, 2995.445842519141, 3014.14096982359, 5936.495397891142, 5946.1972633693895, 5952.9107063394085, 5957.702114894238, 5984.910226346608, 5543.445655434424, 5847.415258474203, 5855.619384739978, 5858.0, 5861.472467477947, 5749.8275051748515, 5867.031939729897, 5915.497182739516, 5944.2254168602385, 5971.895199388127, 5659.717014149359, 5691.8292451226525, 5752.33848107473, 5818.34177259479, 5823.8657644385285, 5363.704996225245, 5456.972715136399, 5498.80754173618, 5646.971765141148, 5677.063284558001, 5786.94213057864, 5907.438793314628, 5943.762249510144, 5961.880762384815, 5966.791162309299, 4723.27600425849, 4727.983483551053, 4753.287006948847, 4785.521447855187, 4812.614990800797, 5457.690154363004, 5513.3108361454815, 5612.579056570692, 5614.803481878278, 5701.743421545957, 5487.862803429946, 5491.7254137292175, 5513.393526712139, 5516.806911758069, 5525.834224973257, 5330.866728331823, 5519.668819870821, 5537.172732998181, 5538.1786567268455, 5564.888702226014, 5421.728913554228, 5432.972835135799, 5473.06957817164, 5485.177223416519, 5493.533049690821, 5527.668339899458, 5542.722863856871, 5592.27300450955, 5617.74170980822, 5618.325800903917, 5327.387350454747, 5429.294191755047, 5473.223475801684, 5491.560675146058, 5511.614187006871], "value": 4451.351050662181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.6817275348989, 872.698918872989, 896.565165894541, 910.5765818894215, 930.0838673906201, 15684.0, 16494.67010659786, 16497.257623406946, 16517.999999999985, 16572.917135414322, 16253.593660158502, 17002.659946801057, 17378.47864564062, 17483.300667973264, 17513.211905464254, 869.3653632848009, 888.1207604471559, 890.5502721125855, 895.2837729816154, 915.6154415145655, 910.0808183734442, 913.0549880873298, 913.1781396742919, 913.2602591900549, 913.5751875377948, 955.4076472586971, 957.1337939165032, 957.2198658093631, 958.8178246133248, 961.8893827209855, 956.0726095687172, 957.8754761880981, 959.3859929644963, 959.3955807841015, 959.596969272907, 694.038756322497, 699.867025265198, 700.6076597105637, 702.6732569355274, 705.2453874354443, 16899.662006759918, 17315.913420432942, 17428.302867885268, 17492.300307987665, 17515.5621109472, 16071.116088615121, 16261.837381626268, 16325.26536305869, 16471.91764041172, 16642.83357166425, 13520.864791352058, 13777.793333099911, 13855.515056973058, 13987.580372588838, 14128.788068178985, 4005.459262999487, 4007.6393124618635, 4051.6353528182603, 4070.1859628074208, 4175.060611362419, 44647.33029004535, 55184.0, 78268.60865695692, 80984.59507702423, 83220.58389708074, 11657.533698652129, 12023.458944347525, 12166.0, 12320.322382268881, 12591.622251332476, 22560.420770545905, 22596.88701556482, 22606.886965565394, 22784.0, 22807.657885131404, 8216.548089854996, 8231.42380033392, 8495.957520212483, 8647.697330593399, 8670.653173873101, 4953.752312384367, 5181.119209734355, 5192.636515443958, 5199.532042116228, 5234.241035049897, 3688.8708895189075, 3775.301569209705, 3777.1690228149764, 3782.6217378261954, 3782.659560639556, 631.1164369882201, 641.7048157847349, 641.8138739765509, 642.408983734965, 647.889858724018, 668.6426554095098, 677.552815142004, 685.8662560800695, 700.9228984811666, 703.4583370804554, 11307.49116289769, 11704.414779261004, 11907.821382679267, 11989.0, 12313.815292770616, 701.4809041309496, 706.9293070692889, 717.5156769180886, 725.6879541796973, 734.930181632744, 5310.9734451327495, 5343.625946183807, 5396.892062158735, 5486.341639003345, 5487.862803429866, 80915.0, 81515.0, 82994.58502707448, 85004.0, 85269.57365213259, 62311.688441557504, 71770.64114679393, 73101.0, 73591.26408735951, 74837.62581187168, 63626.0, 64140.679296604154, 64505.67747161234, 65158.0, 65853.01220481697, 10167.7458063549, 10721.839172412265, 10728.0, 10733.624323148651, 10776.946115269373, 37663.81168094142, 37880.62119378771, 39854.202915940936, 40372.16464435874, 42664.0, 51157.48842511527, 54705.45294547004, 55097.17354239609, 55418.16872746831, 55603.0, 13620.795688064885, 13778.0, 14269.571912842632, 14276.14343139415, 14528.346224420138, 16719.164041798103, 17026.404075857285, 17154.65690686204, 17155.485335439957, 17727.73408398901, 15231.390744370101, 16522.09128497896, 16680.49958501247, 17403.47789566315, 17418.21618027217, 15491.922540387677, 15727.0, 15949.282282297556, 15953.840461595235, 16412.671746564763, 14395.352209150822, 14744.189069601274, 14939.477118300807, 15588.84411155874, 15857.365705371656, 11562.19064665499, 11968.640940771442, 12320.75358492843, 12325.753484930072, 12332.691682708004, 11597.245258170524, 11645.88354116482, 11753.823692644788, 11854.466549005143, 11916.52333906634], "value": 7841.552943533039, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0, 114.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 115.0, 159.0, 122.0, 116.0, 129.0, 116.0, 131.0, 117.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 162.0, 161.0, 162.0, 159.0, 158.0, 160.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 110.0, 75.0, 75.0, 76.0, 75.0, 91.0, 75.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 103.0, 81.0, 81.0, 81.0, 105.0, 81.0, 81.0, 108.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 53.0, 55.0, 60.0, 54.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 76.0, 81.0, 82.0, 75.0, 75.0, 76.0, 74.0, 74.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 122.0, 126.0, 120.0, 131.0, 120.0, 121.0, 176.0, 129.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 159.0, 157.0, 164.0, 158.0, 157.0, 159.0, 163.0, 156.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 60.0, 61.0, 64.0, 59.0, 60.0, 60.0, 60.0, 59.0], "value": 60.8, "unit": "score"}]}]} 09:21:34 INFO - Return code: 0 09:21:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:21:34 ERROR - # TBPL SUCCESS # 09:21:34 INFO - Running post-action listener: _resource_record_post_action 09:21:34 INFO - [mozharness: 2017-03-23 16:21:34.967942Z] Finished run-tests step (success) 09:21:34 INFO - Running post-run listener: _resource_record_post_run 09:21:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 365039616; Read time: 0; Write time: 278952 09:21:35 INFO - TinderboxPrint: CPU usage
13.1% 09:21:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:21:35 INFO - TinderboxPrint: I/O write bytes / time
365,039,616 / 278,952 09:21:35 INFO - TinderboxPrint: CPU idle
8,272.0 (86.9%) 09:21:35 INFO - TinderboxPrint: CPU user
1,201.5 (12.6%) 09:21:35 INFO - TinderboxPrint: Swap in / out
0 / 0 09:21:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110870528; Read time: 0; Write time: 131164 09:21:35 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 254169088; Read time: 0; Write time: 147788 09:21:35 INFO - Running post-run listener: _upload_blobber_files 09:21:35 INFO - Blob upload gear active. 09:21:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:21:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:21:35 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:21:35 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:21:36 INFO - (blobuploader) - INFO - Open directory for files ... 09:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:36 INFO - (blobuploader) - INFO - Done attempting. 09:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:39 INFO - (blobuploader) - INFO - Done attempting. 09:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:40 INFO - (blobuploader) - INFO - Done attempting. 09:21:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:21:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:41 INFO - (blobuploader) - INFO - Done attempting. 09:21:41 INFO - (blobuploader) - INFO - Iteration through files over. 09:21:41 INFO - Return code: 0 09:21:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:21:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:21:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c0047fdd9bb24e5520b561da3d2be0d83bb31e835f0850aed623bc09a45f4f9cfdbb1ef66a3f70b9abe7571504f00ca3c956b650c0972294b1c5812fc1fb4224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/44caee957fccc0da8960d2c28e1939cd8f285c0f085e3c34f8a46a47235b7207dbfbcd361d110bb125cfb4f95e37bf89b8b085ab2915ce63f2c0bd6ba6380a4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4a260b431ccdc1a75ce39e0903ca93f8c2760697349fad5eed492f0bd1ba123b6584eefe5c6c38954cd035d78eead3d77e4b9aca2a9e5b0e28b49bd1d34b81bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/755165d90651fe756ffdf94b011cce46435c0b0a29db00118e7e2d730c1e3438eed997fa9fd007c7aefdd5646931a04032d9a127ea798d5aadaac9f676919660"} 09:21:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:21:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:21:41 INFO - Contents: 09:21:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c0047fdd9bb24e5520b561da3d2be0d83bb31e835f0850aed623bc09a45f4f9cfdbb1ef66a3f70b9abe7571504f00ca3c956b650c0972294b1c5812fc1fb4224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/44caee957fccc0da8960d2c28e1939cd8f285c0f085e3c34f8a46a47235b7207dbfbcd361d110bb125cfb4f95e37bf89b8b085ab2915ce63f2c0bd6ba6380a4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4a260b431ccdc1a75ce39e0903ca93f8c2760697349fad5eed492f0bd1ba123b6584eefe5c6c38954cd035d78eead3d77e4b9aca2a9e5b0e28b49bd1d34b81bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/755165d90651fe756ffdf94b011cce46435c0b0a29db00118e7e2d730c1e3438eed997fa9fd007c7aefdd5646931a04032d9a127ea798d5aadaac9f676919660"} 09:21:41 INFO - Running post-run listener: copy_logs_to_upload_dir 09:21:41 INFO - Copying logs to upload dir... 09:21:41 INFO - mkdir: /builds/slave/test/build/upload/logs 09:21:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.781847 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-23 09:21:41.657063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 09:21:41.660852) ========= 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=4300f881736b422476174874000001bc-1490284848.16097-2009590757 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-Non-PGO/sha512/c0047fdd9bb24e5520b561da3d2be0d83bb31e835f0850aed623bc09a45f4f9cfdbb1ef66a3f70b9abe7571504f00ca3c956b650c0972294b1c5812fc1fb4224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/44caee957fccc0da8960d2c28e1939cd8f285c0f085e3c34f8a46a47235b7207dbfbcd361d110bb125cfb4f95e37bf89b8b085ab2915ce63f2c0bd6ba6380a4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4a260b431ccdc1a75ce39e0903ca93f8c2760697349fad5eed492f0bd1ba123b6584eefe5c6c38954cd035d78eead3d77e4b9aca2a9e5b0e28b49bd1d34b81bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/755165d90651fe756ffdf94b011cce46435c0b0a29db00118e7e2d730c1e3438eed997fa9fd007c7aefdd5646931a04032d9a127ea798d5aadaac9f676919660"} build_url:https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/XZ0YVrU2T_eUbdZ6LJcDPg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c0047fdd9bb24e5520b561da3d2be0d83bb31e835f0850aed623bc09a45f4f9cfdbb1ef66a3f70b9abe7571504f00ca3c956b650c0972294b1c5812fc1fb4224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/44caee957fccc0da8960d2c28e1939cd8f285c0f085e3c34f8a46a47235b7207dbfbcd361d110bb125cfb4f95e37bf89b8b085ab2915ce63f2c0bd6ba6380a4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4a260b431ccdc1a75ce39e0903ca93f8c2760697349fad5eed492f0bd1ba123b6584eefe5c6c38954cd035d78eead3d77e4b9aca2a9e5b0e28b49bd1d34b81bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/755165d90651fe756ffdf94b011cce46435c0b0a29db00118e7e2d730c1e3438eed997fa9fd007c7aefdd5646931a04032d9a127ea798d5aadaac9f676919660"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 09:21:41.685832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:21:41.686124) ========= 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=4300f881736b422476174874000001bc-1490284848.16097-2009590757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:21:41.738599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 09:21:41.738942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 09:21:41.739244) ========= ========= Total master_lag: 0.13 =========