builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1486698724.8 results: success (0) revision: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:04.804287) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:04.805247) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:04.805965) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:04.823399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:04.823694) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 19:52:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2017-02-09 19:52:05 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113229 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:04.952347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:04.952671) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014903 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:05.002503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:05.002847) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 --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 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 --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=a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 19:52:05,446 truncating revision to first 12 chars 2017-02-09 19:52:05,446 Setting DEBUG logging. 2017-02-09 19:52:05,446 attempt 1/10 2017-02-09 19:52:05,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6b063631a7d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 19:52:05,885 unpacking tar archive at: mozilla-aurora-6b063631a7d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756662 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:05.772901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:05.773261) ========= script_repo_revision: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:05.773750) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:05.774070) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 19:52:05.783559) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-09 19:52:05.784111) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:52:06 INFO - MultiFileLogger online at 20170209 19:52:06 in /builds/slave/test 19:52:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:52:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:52:06 INFO - {'append_to_log': False, 19:52:06 INFO - 'base_work_dir': '/builds/slave/test', 19:52:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:52:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:52:06 INFO - 'branch': 'Mozilla-Aurora', 19:52:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:52:06 INFO - 'config_files': ('talos/linux_config.py',), 19:52:06 INFO - 'default_actions': ('clobber', 19:52:06 INFO - 'read-buildbot-config', 19:52:06 INFO - 'download-and-extract', 19:52:06 INFO - 'populate-webroot', 19:52:06 INFO - 'create-virtualenv', 19:52:06 INFO - 'install', 19:52:06 INFO - 'run-tests'), 19:52:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:52:06 INFO - 'download_minidump_stackwalk': True, 19:52:06 INFO - 'download_symbols': 'ondemand', 19:52:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:52:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:52:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:52:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:52:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:52:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:52:06 INFO - 'installer_path': 'installer.exe', 19:52:06 INFO - 'log_level': 'info', 19:52:06 INFO - 'log_name': 'talos', 19:52:06 INFO - 'log_to_console': True, 19:52:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:52:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:52:06 INFO - 'opt_config_files': (), 19:52:06 INFO - 'pip_index': False, 19:52:06 INFO - 'sps_profile': False, 19:52:06 INFO - 'sps_profile_interval': 0, 19:52:06 INFO - 'suite': 'dromaeojs', 19:52:06 INFO - 'system_bits': '32', 19:52:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:52:06 INFO - 'title': 'talos-linux64-ix-062', 19:52:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:52:06 INFO - 'use_talos_json': True, 19:52:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:52:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:52:06 INFO - 'work_dir': 'build'} 19:52:06 INFO - [mozharness: 2017-02-10 03:52:06.328615Z] Running clobber step. 19:52:06 INFO - Running pre-action listener: _resource_record_pre_action 19:52:06 INFO - Running main action method: clobber 19:52:06 INFO - rmtree: /builds/slave/test/build 19:52:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:52:07 INFO - Running post-action listener: _resource_record_post_action 19:52:07 INFO - [mozharness: 2017-02-10 03:52:07.332445Z] Finished clobber step (success) 19:52:07 INFO - [mozharness: 2017-02-10 03:52:07.332544Z] Running read-buildbot-config step. 19:52:07 INFO - Running pre-action listener: _resource_record_pre_action 19:52:07 INFO - Running main action method: read_buildbot_config 19:52:07 INFO - Using buildbot properties: 19:52:07 INFO - { 19:52:07 INFO - "project": "", 19:52:07 INFO - "product": "firefox", 19:52:07 INFO - "who": "ryanvm@gmail.com", 19:52:07 INFO - "installer_path": "public/build/target.tar.bz2", 19:52:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 19:52:07 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 19:52:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 19:52:07 INFO - "stage_platform": "linux64-pgo", 19:52:07 INFO - "basedir": "/builds/slave/test", 19:52:07 INFO - "buildnumber": 1049, 19:52:07 INFO - "platform": "ubuntu64_hw", 19:52:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:52:07 INFO - "slavebuilddir": "test", 19:52:07 INFO - "taskId": "fpG54vEtT4qEbClr0IUTKQ", 19:52:07 INFO - "branch": "mozilla-aurora", 19:52:07 INFO - "script_repo_revision": "production", 19:52:07 INFO - "revision": "6b063631a7d3ffd5dc2b621852e4d8ac8758ef99", 19:52:07 INFO - "slavename": "talos-linux64-ix-062", 19:52:07 INFO - "repo_path": "releases/mozilla-aurora" 19:52:07 INFO - } 19:52:07 INFO - Finding installer, test and symbols from parent task. 19:52:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fpG54vEtT4qEbClr0IUTKQ'}, attempt #1 19:52:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fpG54vEtT4qEbClr0IUTKQ'}, attempt #1 19:52:08 INFO - Task dependencies: ZzdwFyNnSGG9B6WoJ2cGww 19:52:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww'}, attempt #1 19:52:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.tar.bz2 19:52:08 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/test_packages.json 19:52:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.crashreporter-symbols.zip 19:52:08 INFO - Running post-action listener: _resource_record_post_action 19:52:08 INFO - [mozharness: 2017-02-10 03:52:08.725471Z] Finished read-buildbot-config step (success) 19:52:08 INFO - [mozharness: 2017-02-10 03:52:08.725686Z] Running download-and-extract step. 19:52:08 INFO - Running pre-action listener: _resource_record_pre_action 19:52:08 INFO - Running main action method: download_and_extract 19:52:08 INFO - mkdir: /builds/slave/test/build/tests 19:52:08 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')]} 19:52:08 INFO - trying https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.test_packages.json 19:52:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:52:09 INFO - Downloaded 896 bytes. 19:52:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:52:09 INFO - Using the following test package requirements: 19:52:09 INFO - {u'common': [u'target.common.tests.zip'], 19:52:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:52:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:52:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:52:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:52:09 INFO - u'mozbase': [u'target.common.tests.zip'], 19:52:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:52:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:52:09 INFO - u'web-platform': [u'target.common.tests.zip', 19:52:09 INFO - u'target.web-platform.tests.zip'], 19:52:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:52:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:52:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.common.tests.zip 19:52:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:52:09 INFO - Fetch https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.common.tests.zip into memory 19:52:10 INFO - Expected file size: 21856021 19:52:10 INFO - Obtained file size: 21856021 19:52:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:52:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.common.tests.zip 19:52:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:52:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.common.tests.zip into memory 19:52:15 INFO - Expected file size: 21856021 19:52:15 INFO - Obtained file size: 21856021 19:52:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.talos.tests.zip 19:52:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:52:19 INFO - Fetch https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.talos.tests.zip into memory 19:52:20 INFO - Expected file size: 14403485 19:52:20 INFO - Obtained file size: 14403485 19:52: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')]} 19:52:20 INFO - trying https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.tar.bz2 19:52:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:52:21 INFO - Downloaded 66054239 bytes. 19:52:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.tar.bz2 19:52:21 INFO - mkdir: /builds/slave/test/properties 19:52:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:52:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:52:21 INFO - Contents: 19:52:21 INFO - build_url:https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.tar.bz2 19:52:21 INFO - Running post-action listener: _resource_record_post_action 19:52:21 INFO - Running post-action listener: set_extra_try_arguments 19:52:21 INFO - [mozharness: 2017-02-10 03:52:21.909284Z] Finished download-and-extract step (success) 19:52:21 INFO - [mozharness: 2017-02-10 03:52:21.909380Z] Running populate-webroot step. 19:52:21 INFO - Running pre-action listener: _resource_record_pre_action 19:52:21 INFO - Running main action method: populate_webroot 19:52:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:52:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:52:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:52:21 INFO - '--tppagecycles', 19:52:21 INFO - '7'], 19:52:21 INFO - 'tests': ['tsvgm']}}, 19:52:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:52:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:52:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:52:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:52:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:52:21 INFO - 'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:52:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:52:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:52:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:52:21 INFO - 'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['damp', 'tps']}, 19:52:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:52:21 INFO - 'tests': ['damp', 'tps']}, 19:52:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['dromaeo_dom']}, 19:52:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:52:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['basic_compositor_video']}, 19:52:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:52:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['a11yr', 19:52:21 INFO - 'ts_paint', 19:52:21 INFO - 'tpaint', 19:52:21 INFO - 'sessionrestore', 19:52:21 INFO - 'sessionrestore_no_auto_restore', 19:52:21 INFO - 'tabpaint']}, 19:52:21 INFO - 'other-e10s': {'tests': ['a11yr', 19:52:21 INFO - 'ts_paint', 19:52:21 INFO - 'tpaint', 19:52:21 INFO - 'sessionrestore', 19:52:21 INFO - 'sessionrestore_no_auto_restore', 19:52:21 INFO - 'tabpaint']}, 19:52:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:52:21 INFO - 'ts_paint', 19:52:21 INFO - 'tpaint', 19:52:21 INFO - 'sessionrestore', 19:52:21 INFO - 'sessionrestore_no_auto_restore', 19:52:21 INFO - 'tabpaint']}, 19:52:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:52:21 INFO - 'ts_paint', 19:52:21 INFO - 'tpaint', 19:52:21 INFO - 'sessionrestore', 19:52:21 INFO - 'sessionrestore_no_auto_restore', 19:52:21 INFO - 'tabpaint']}, 19:52:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['a11yr', 19:52:21 INFO - 'ts_paint', 19:52:21 INFO - 'tpaint', 19:52:21 INFO - 'sessionrestore', 19:52:21 INFO - 'sessionrestore_no_auto_restore', 19:52:21 INFO - 'tabpaint']}, 19:52:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['a11yr', 19:52:21 INFO - 'ts_paint', 19:52:21 INFO - 'tpaint', 19:52:21 INFO - 'sessionrestore', 19:52:21 INFO - 'sessionrestore_no_auto_restore', 19:52:21 INFO - 'tabpaint']}, 19:52:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['tsvgx', 19:52:21 INFO - 'tsvgr_opacity', 19:52:21 INFO - 'tart', 19:52:21 INFO - 'tscrollx', 19:52:21 INFO - 'cart', 19:52:21 INFO - 'tsvg_static']}, 19:52:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:52:21 INFO - 'tsvgr_opacity', 19:52:21 INFO - 'tart', 19:52:21 INFO - 'tscrollx', 19:52:21 INFO - 'cart', 19:52:21 INFO - 'tsvg_static']}, 19:52:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:52:21 INFO - 'talos_options': ['--disable-e10s'], 19:52:21 INFO - 'tests': ['tp5o']}, 19:52:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:52:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:52:21 INFO - 'talos_options': ['--disable-e10s', 19:52:21 INFO - '--xperf_path', 19:52:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:52:21 INFO - 'tests': ['tp5n']}, 19:52:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:52:21 INFO - 'talos_options': ['--xperf_path', 19:52:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:52:21 INFO - 'tests': ['tp5n']}}, 19:52:21 INFO - 'talos.zip': {'path': '', 19:52:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:52:21 INFO - Running post-action listener: _resource_record_post_action 19:52:21 INFO - [mozharness: 2017-02-10 03:52:21.922445Z] Finished populate-webroot step (success) 19:52:21 INFO - [mozharness: 2017-02-10 03:52:21.922533Z] Running create-virtualenv step. 19:52:21 INFO - Running pre-action listener: _resource_record_pre_action 19:52:21 INFO - Running main action method: create_virtualenv 19:52:21 INFO - Creating virtualenv /builds/slave/test/build/venv 19:52:21 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 19:52:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:52:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:52:22 INFO - Using real prefix '/usr' 19:52:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:52:22 INFO - Installing distribute.............................................................................................................................................................................................done. 19:52:24 INFO - Installing pip.................done. 19:52:24 INFO - Return code: 0 19:52:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:52:24 INFO - Reading from file tmpfile_stdout 19:52:24 INFO - Output received: 19:52:24 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) 19:52:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:52: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')]} 19:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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')]} 19:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52: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', 'pip>=1.5'] in /builds/slave/test/build 19:52: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 pip>=1.5 19:52:24 INFO - Using env: {'DISPLAY': ':0', 19:52:24 INFO - 'HOME': '/home/cltbld', 19:52:24 INFO - 'LANG': 'en_US.UTF-8', 19:52:24 INFO - 'LANGUAGE': 'en_US:en', 19:52:24 INFO - 'LOGNAME': 'cltbld', 19:52:24 INFO - 'MAIL': '/var/mail/cltbld', 19:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:24 INFO - 'MOZ_NO_REMOTE': '1', 19:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:24 INFO - 'NO_EM_RESTART': '1', 19:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:24 INFO - 'PWD': '/builds/slave/test', 19:52:24 INFO - 'SHELL': '/bin/bash', 19:52:24 INFO - 'SHLVL': '1', 19:52:24 INFO - 'TERM': 'linux', 19:52:24 INFO - 'TMOUT': '86400', 19:52:24 INFO - 'USER': 'cltbld', 19:52:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:24 INFO - '_': '/tools/buildbot/bin/python'} 19:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:24 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 19:52:24 INFO - Cleaning up... 19:52:24 INFO - Return code: 0 19:52:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:52: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')]} 19:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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')]} 19:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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', '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 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:52: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 psutil>=3.1.1 19:52:24 INFO - Using env: {'DISPLAY': ':0', 19:52:24 INFO - 'HOME': '/home/cltbld', 19:52:24 INFO - 'LANG': 'en_US.UTF-8', 19:52:24 INFO - 'LANGUAGE': 'en_US:en', 19:52:24 INFO - 'LOGNAME': 'cltbld', 19:52:24 INFO - 'MAIL': '/var/mail/cltbld', 19:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:24 INFO - 'MOZ_NO_REMOTE': '1', 19:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:24 INFO - 'NO_EM_RESTART': '1', 19:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:24 INFO - 'PWD': '/builds/slave/test', 19:52:24 INFO - 'SHELL': '/bin/bash', 19:52:24 INFO - 'SHLVL': '1', 19:52:24 INFO - 'TERM': 'linux', 19:52:24 INFO - 'TMOUT': '86400', 19:52:24 INFO - 'USER': 'cltbld', 19:52:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:24 INFO - '_': '/tools/buildbot/bin/python'} 19:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:25 INFO - Downloading/unpacking psutil>=3.1.1 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:52:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:52:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:52:27 INFO - Installing collected packages: psutil 19:52:27 INFO - Running setup.py install for psutil 19:52:27 INFO - building 'psutil._psutil_linux' extension 19:52:27 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 19:52:27 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 19:52:27 INFO - building 'psutil._psutil_posix' extension 19:52:27 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 19:52:27 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 19:52:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:52:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:52:27 INFO - Successfully installed psutil 19:52:27 INFO - Cleaning up... 19:52:27 INFO - Return code: 0 19:52:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:52: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')]} 19:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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')]} 19:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:52: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 mozsystemmonitor==0.3 19:52:27 INFO - Using env: {'DISPLAY': ':0', 19:52:27 INFO - 'HOME': '/home/cltbld', 19:52:27 INFO - 'LANG': 'en_US.UTF-8', 19:52:27 INFO - 'LANGUAGE': 'en_US:en', 19:52:27 INFO - 'LOGNAME': 'cltbld', 19:52:27 INFO - 'MAIL': '/var/mail/cltbld', 19:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:27 INFO - 'MOZ_NO_REMOTE': '1', 19:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:27 INFO - 'NO_EM_RESTART': '1', 19:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:27 INFO - 'PWD': '/builds/slave/test', 19:52:27 INFO - 'SHELL': '/bin/bash', 19:52:27 INFO - 'SHLVL': '1', 19:52:27 INFO - 'TERM': 'linux', 19:52:27 INFO - 'TMOUT': '86400', 19:52:27 INFO - 'USER': 'cltbld', 19:52:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:27 INFO - '_': '/tools/buildbot/bin/python'} 19:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:52:28 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 19:52:28 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 19:52:28 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 19:52:28 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 19:52:28 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 19:52:28 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 19:52:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:52:30 INFO - Installing collected packages: mozsystemmonitor 19:52:30 INFO - Running setup.py install for mozsystemmonitor 19:52:30 INFO - Successfully installed mozsystemmonitor 19:52:30 INFO - Cleaning up... 19:52:30 INFO - Return code: 0 19:52:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:52: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')]} 19:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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')]} 19:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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', '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 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:52: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 jsonschema==2.5.1 19:52:30 INFO - Using env: {'DISPLAY': ':0', 19:52:30 INFO - 'HOME': '/home/cltbld', 19:52:30 INFO - 'LANG': 'en_US.UTF-8', 19:52:30 INFO - 'LANGUAGE': 'en_US:en', 19:52:30 INFO - 'LOGNAME': 'cltbld', 19:52:30 INFO - 'MAIL': '/var/mail/cltbld', 19:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:30 INFO - 'MOZ_NO_REMOTE': '1', 19:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:30 INFO - 'NO_EM_RESTART': '1', 19:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:30 INFO - 'PWD': '/builds/slave/test', 19:52:30 INFO - 'SHELL': '/bin/bash', 19:52:30 INFO - 'SHLVL': '1', 19:52:30 INFO - 'TERM': 'linux', 19:52:30 INFO - 'TMOUT': '86400', 19:52:30 INFO - 'USER': 'cltbld', 19:52:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:30 INFO - '_': '/tools/buildbot/bin/python'} 19:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:30 INFO - Downloading/unpacking jsonschema==2.5.1 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:52:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52: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 19:52:32 INFO - Downloading functools32-3.2.3-2.tar.gz 19:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:52:32 INFO - warning: no files found matching '*.txt' 19:52:32 INFO - no previously-included directories found matching 'build' 19:52:32 INFO - no previously-included directories found matching 'dist' 19:52:32 INFO - no previously-included directories found matching '.git*' 19:52:32 INFO - Installing collected packages: jsonschema, functools32 19:52:32 INFO - Running setup.py install for functools32 19:52:32 INFO - warning: no files found matching '*.txt' 19:52:32 INFO - no previously-included directories found matching 'build' 19:52:32 INFO - no previously-included directories found matching 'dist' 19:52:32 INFO - no previously-included directories found matching '.git*' 19:52:32 INFO - Successfully installed jsonschema functools32 19:52:32 INFO - Cleaning up... 19:52:33 INFO - Return code: 0 19:52:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:52: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')]} 19:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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')]} 19:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:33 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 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52:33 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 19:52:33 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 19:52:33 INFO - Using env: {'DISPLAY': ':0', 19:52:33 INFO - 'HOME': '/home/cltbld', 19:52:33 INFO - 'LANG': 'en_US.UTF-8', 19:52:33 INFO - 'LANGUAGE': 'en_US:en', 19:52:33 INFO - 'LOGNAME': 'cltbld', 19:52:33 INFO - 'MAIL': '/var/mail/cltbld', 19:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:33 INFO - 'MOZ_NO_REMOTE': '1', 19:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:33 INFO - 'NO_EM_RESTART': '1', 19:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:33 INFO - 'PWD': '/builds/slave/test', 19:52:33 INFO - 'SHELL': '/bin/bash', 19:52:33 INFO - 'SHLVL': '1', 19:52:33 INFO - 'TERM': 'linux', 19:52:33 INFO - 'TMOUT': '86400', 19:52:33 INFO - 'USER': 'cltbld', 19:52:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:33 INFO - '_': '/tools/buildbot/bin/python'} 19:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:52:33 INFO - Cleaning up... 19:52:33 INFO - Return code: 0 19:52:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:52: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')]} 19:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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')]} 19:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:33 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 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52:33 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 19:52:33 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 19:52:33 INFO - Using env: {'DISPLAY': ':0', 19:52:33 INFO - 'HOME': '/home/cltbld', 19:52:33 INFO - 'LANG': 'en_US.UTF-8', 19:52:33 INFO - 'LANGUAGE': 'en_US:en', 19:52:33 INFO - 'LOGNAME': 'cltbld', 19:52:33 INFO - 'MAIL': '/var/mail/cltbld', 19:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:33 INFO - 'MOZ_NO_REMOTE': '1', 19:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:33 INFO - 'NO_EM_RESTART': '1', 19:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:33 INFO - 'PWD': '/builds/slave/test', 19:52:33 INFO - 'SHELL': '/bin/bash', 19:52:33 INFO - 'SHLVL': '1', 19:52:33 INFO - 'TERM': 'linux', 19:52:33 INFO - 'TMOUT': '86400', 19:52:33 INFO - 'USER': 'cltbld', 19:52:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:33 INFO - '_': '/tools/buildbot/bin/python'} 19:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:33 INFO - Downloading/unpacking blobuploader==1.2.4 19:52:33 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 19:52:33 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 19:52:33 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 19:52:33 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 19:52:33 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 19:52:33 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 19:52:35 INFO - Downloading blobuploader-1.2.4.tar.gz 19:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:52:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:52:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:36 INFO - Downloading docopt-0.6.1.tar.gz 19:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:52:36 INFO - Installing collected packages: blobuploader, requests, docopt 19:52:36 INFO - Running setup.py install for blobuploader 19:52:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:52:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:52:36 INFO - Running setup.py install for requests 19:52:36 INFO - Running setup.py install for docopt 19:52:36 INFO - Successfully installed blobuploader requests docopt 19:52:36 INFO - Cleaning up... 19:52:36 INFO - Return code: 0 19:52:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:52:36 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')]} 19:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:36 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')]} 19:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:36 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 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52:36 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 19:52:36 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 19:52:36 INFO - Using env: {'DISPLAY': ':0', 19:52:36 INFO - 'HOME': '/home/cltbld', 19:52:36 INFO - 'LANG': 'en_US.UTF-8', 19:52:36 INFO - 'LANGUAGE': 'en_US:en', 19:52:36 INFO - 'LOGNAME': 'cltbld', 19:52:36 INFO - 'MAIL': '/var/mail/cltbld', 19:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:36 INFO - 'MOZ_NO_REMOTE': '1', 19:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:36 INFO - 'NO_EM_RESTART': '1', 19:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:36 INFO - 'PWD': '/builds/slave/test', 19:52:36 INFO - 'SHELL': '/bin/bash', 19:52:36 INFO - 'SHLVL': '1', 19:52:36 INFO - 'TERM': 'linux', 19:52:36 INFO - 'TMOUT': '86400', 19:52:36 INFO - 'USER': 'cltbld', 19:52:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:36 INFO - '_': '/tools/buildbot/bin/python'} 19:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:52:37 INFO - Running setup.py (path:/tmp/pip-xTM_ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:52:37 INFO - Running setup.py (path:/tmp/pip-yn7heN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:52:37 INFO - Running setup.py (path:/tmp/pip-mfAGuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:52:37 INFO - Running setup.py (path:/tmp/pip-zQlA4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:52:37 INFO - Running setup.py (path:/tmp/pip-TbJwf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:52:37 INFO - Running setup.py (path:/tmp/pip-KRovcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:52:37 INFO - Running setup.py (path:/tmp/pip-gixgdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:52:37 INFO - Running setup.py (path:/tmp/pip-UxkKY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:52:37 INFO - Running setup.py (path:/tmp/pip-avx_aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:52:37 INFO - Running setup.py (path:/tmp/pip-ti5KRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:52:37 INFO - Running setup.py (path:/tmp/pip-1mzZSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:52:37 INFO - Running setup.py (path:/tmp/pip-fJuPs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:52:37 INFO - Running setup.py (path:/tmp/pip-PHKt7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:52:38 INFO - Running setup.py (path:/tmp/pip-whY5fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:52:38 INFO - Running setup.py (path:/tmp/pip-BQ0uUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:52:38 INFO - Running setup.py (path:/tmp/pip-vYxOv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:52:38 INFO - Running setup.py (path:/tmp/pip-IAHfCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:52:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:52:38 INFO - Running setup.py install for manifestparser 19:52:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:52:38 INFO - Running setup.py install for mozcrash 19:52:38 INFO - Running setup.py install for mozdebug 19:52:38 INFO - Running setup.py install for mozdevice 19:52:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:52:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:52:38 INFO - Running setup.py install for mozfile 19:52:38 INFO - Running setup.py install for mozhttpd 19:52:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:52:38 INFO - Running setup.py install for mozinfo 19:52:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Running setup.py install for mozInstall 19:52:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Running setup.py install for mozleak 19:52:39 INFO - Running setup.py install for mozlog 19:52:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Running setup.py install for moznetwork 19:52:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Running setup.py install for mozprocess 19:52:39 INFO - Running setup.py install for mozprofile 19:52:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Running setup.py install for mozrunner 19:52:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:52:39 INFO - Running setup.py install for mozscreenshot 19:52:39 INFO - Running setup.py install for moztest 19:52:40 INFO - Running setup.py install for mozversion 19:52:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:52:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:52:40 INFO - Cleaning up... 19:52:40 INFO - Return code: 0 19:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:40 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 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52:40 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 19:52:40 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 19:52:40 INFO - Using env: {'DISPLAY': ':0', 19:52:40 INFO - 'HOME': '/home/cltbld', 19:52:40 INFO - 'LANG': 'en_US.UTF-8', 19:52:40 INFO - 'LANGUAGE': 'en_US:en', 19:52:40 INFO - 'LOGNAME': 'cltbld', 19:52:40 INFO - 'MAIL': '/var/mail/cltbld', 19:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:40 INFO - 'MOZ_NO_REMOTE': '1', 19:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:40 INFO - 'NO_EM_RESTART': '1', 19:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:40 INFO - 'PWD': '/builds/slave/test', 19:52:40 INFO - 'SHELL': '/bin/bash', 19:52:40 INFO - 'SHLVL': '1', 19:52:40 INFO - 'TERM': 'linux', 19:52:40 INFO - 'TMOUT': '86400', 19:52:40 INFO - 'USER': 'cltbld', 19:52:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:40 INFO - '_': '/tools/buildbot/bin/python'} 19:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:52:40 INFO - Running setup.py (path:/tmp/pip-oa0BcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:52:40 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)) 19:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:52:40 INFO - Running setup.py (path:/tmp/pip-sBMCv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:52:40 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)) 19:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:52:40 INFO - Running setup.py (path:/tmp/pip-AC7gyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:52:40 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)) 19:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:52:40 INFO - Running setup.py (path:/tmp/pip-loSFZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:52:40 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)) 19:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:52:40 INFO - Running setup.py (path:/tmp/pip-HNT0Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:52:40 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)) 19:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:52:40 INFO - Running setup.py (path:/tmp/pip-d2dKim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:52:40 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)) 19:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:52:40 INFO - Running setup.py (path:/tmp/pip-TYUGec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:52:40 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)) 19:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:52:40 INFO - Running setup.py (path:/tmp/pip-MS7hAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:52:40 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)) 19:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:52:40 INFO - Running setup.py (path:/tmp/pip-gCt3J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:52:41 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)) 19:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:52:41 INFO - Running setup.py (path:/tmp/pip-8dUerH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:52:41 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)) 19:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:52:41 INFO - Running setup.py (path:/tmp/pip-2odzue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:52:41 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)) 19:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:52:41 INFO - Running setup.py (path:/tmp/pip-Mm0SfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:52:41 INFO - Running setup.py (path:/tmp/pip-_ERJQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:52:41 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)) 19:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:52:41 INFO - Running setup.py (path:/tmp/pip-k8d9au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:52:41 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)) 19:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:52:41 INFO - Running setup.py (path:/tmp/pip-_pVXcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:52:41 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)) 19:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:52:41 INFO - Running setup.py (path:/tmp/pip-U6Kq0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:52:41 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)) 19:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:52:41 INFO - Running setup.py (path:/tmp/pip-_9GFg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:52:41 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)) 19:52:41 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)) 19:52:41 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)) 19:52:41 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)) 19:52:41 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)) 19:52:41 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)) 19:52:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:43 INFO - Downloading blessings-1.6.tar.gz 19:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:52:43 INFO - Installing collected packages: blessings 19:52:43 INFO - Running setup.py install for blessings 19:52:43 INFO - Successfully installed blessings 19:52:43 INFO - Cleaning up... 19:52:43 INFO - Return code: 0 19:52:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:52:44 INFO - Reading from file tmpfile_stdout 19:52:44 INFO - Current package versions: 19:52:44 INFO - argparse == 1.2.1 19:52:44 INFO - blessings == 1.6 19:52:44 INFO - blobuploader == 1.2.4 19:52:44 INFO - docopt == 0.6.1 19:52:44 INFO - functools32 == 3.2.3-2 19:52:44 INFO - jsonschema == 2.5.1 19:52:44 INFO - manifestparser == 1.1 19:52:44 INFO - mozInstall == 1.12 19:52:44 INFO - mozcrash == 1.0 19:52:44 INFO - mozdebug == 0.1 19:52:44 INFO - mozdevice == 0.49 19:52:44 INFO - mozfile == 1.2 19:52:44 INFO - mozhttpd == 0.7 19:52:44 INFO - mozinfo == 0.9 19:52:44 INFO - mozleak == 0.1 19:52:44 INFO - mozlog == 3.4 19:52:44 INFO - moznetwork == 0.27 19:52:44 INFO - mozprocess == 0.24 19:52:44 INFO - mozprofile == 0.28 19:52:44 INFO - mozrunner == 6.13 19:52:44 INFO - mozscreenshot == 0.1 19:52:44 INFO - mozsystemmonitor == 0.3 19:52:44 INFO - moztest == 0.8 19:52:44 INFO - mozversion == 1.4 19:52:44 INFO - psutil == 3.1.1 19:52:44 INFO - requests == 1.2.3 19:52:44 INFO - wsgiref == 0.1.2 19:52:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:52:44 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')]} 19:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:44 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')]} 19:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:44 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 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52:44 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 19:52:44 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 19:52:44 INFO - Using env: {'DISPLAY': ':0', 19:52:44 INFO - 'HOME': '/home/cltbld', 19:52:44 INFO - 'LANG': 'en_US.UTF-8', 19:52:44 INFO - 'LANGUAGE': 'en_US:en', 19:52:44 INFO - 'LOGNAME': 'cltbld', 19:52:44 INFO - 'MAIL': '/var/mail/cltbld', 19:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:44 INFO - 'MOZ_NO_REMOTE': '1', 19:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:44 INFO - 'NO_EM_RESTART': '1', 19:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:44 INFO - 'PWD': '/builds/slave/test', 19:52:44 INFO - 'SHELL': '/bin/bash', 19:52:44 INFO - 'SHLVL': '1', 19:52:44 INFO - 'TERM': 'linux', 19:52:44 INFO - 'TMOUT': '86400', 19:52:44 INFO - 'USER': 'cltbld', 19:52:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:44 INFO - '_': '/tools/buildbot/bin/python'} 19:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:44 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)) 19:52:44 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)) 19:52:44 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)) 19:52:44 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)) 19:52:44 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)) 19:52:44 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)) 19:52:44 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)) 19:52:44 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)) 19:52:44 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)) 19:52:44 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)) 19:52:44 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)) 19:52:44 INFO - Cleaning up... 19:52:44 INFO - Return code: 0 19:52:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:52:44 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')]} 19:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:44 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')]} 19:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:44 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 0x264a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bc630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', '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 19:52:44 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 19:52:44 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 19:52:44 INFO - Using env: {'DISPLAY': ':0', 19:52:44 INFO - 'HOME': '/home/cltbld', 19:52:44 INFO - 'LANG': 'en_US.UTF-8', 19:52:44 INFO - 'LANGUAGE': 'en_US:en', 19:52:44 INFO - 'LOGNAME': 'cltbld', 19:52:44 INFO - 'MAIL': '/var/mail/cltbld', 19:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:44 INFO - 'MOZ_NO_REMOTE': '1', 19:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:44 INFO - 'NO_EM_RESTART': '1', 19:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:44 INFO - 'PWD': '/builds/slave/test', 19:52:44 INFO - 'SHELL': '/bin/bash', 19:52:44 INFO - 'SHLVL': '1', 19:52:44 INFO - 'TERM': 'linux', 19:52:44 INFO - 'TMOUT': '86400', 19:52:44 INFO - 'USER': 'cltbld', 19:52:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:44 INFO - '_': '/tools/buildbot/bin/python'} 19:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:52:44 INFO - Cleaning up... 19:52:44 INFO - Return code: 0 19:52:44 INFO - Running post-action listener: _resource_record_post_action 19:52:44 INFO - Running post-action listener: _start_resource_monitoring 19:52:44 INFO - Starting resource monitoring. 19:52:44 INFO - [mozharness: 2017-02-10 03:52:44.602359Z] Finished create-virtualenv step (success) 19:52:44 INFO - [mozharness: 2017-02-10 03:52:44.602938Z] Running install step. 19:52:44 INFO - Running pre-action listener: _resource_record_pre_action 19:52:44 INFO - Running main action method: install 19:52:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:52:44 INFO - Reading from file tmpfile_stdout 19:52:44 INFO - Detecting whether we're running mozinstall >=1.0... 19:52:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:52:44 INFO - Reading from file tmpfile_stdout 19:52:44 INFO - Output received: 19:52:44 INFO - Usage: mozinstall [options] installer 19:52:44 INFO - Options: 19:52:44 INFO - -h, --help show this help message and exit 19:52:44 INFO - -d DEST, --destination=DEST 19:52:44 INFO - Directory to install application into. [default: 19:52:44 INFO - "/builds/slave/test"] 19:52:44 INFO - --app=APP Application being installed. [default: firefox] 19:52:44 INFO - mkdir: /builds/slave/test/build/application 19:52:44 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'] 19:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:53:01 INFO - Reading from file tmpfile_stdout 19:53:01 INFO - Output received: 19:53:01 INFO - /builds/slave/test/build/application/firefox/firefox 19:53:01 INFO - Running post-action listener: _resource_record_post_action 19:53:01 INFO - [mozharness: 2017-02-10 03:53:01.380093Z] Finished install step (success) 19:53:01 INFO - [mozharness: 2017-02-10 03:53:01.380229Z] Running run-tests step. 19:53:01 INFO - Running pre-action listener: _resource_record_pre_action 19:53:01 INFO - Running main action method: run_tests 19:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:53:01 INFO - Python 2.7.3 19:53:01 INFO - Return code: 0 19:53:01 INFO - grabbing minidump binary from tooltool 19:53:01 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')]} 19:53:01 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 0x2a45850>, '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 0x29ba6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bab60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:53:01 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 19:53:01 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 19:53:01 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 19:53:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:53:01 INFO - Return code: 0 19:53:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:53:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:53:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:53:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:53:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 19:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 19:53:01 INFO - Using env: {'DISPLAY': ':0', 19:53:01 INFO - 'HOME': '/home/cltbld', 19:53:01 INFO - 'LANG': 'en_US.UTF-8', 19:53:01 INFO - 'LANGUAGE': 'en_US:en', 19:53:01 INFO - 'LOGNAME': 'cltbld', 19:53:01 INFO - 'MAIL': '/var/mail/cltbld', 19:53:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:53:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:53:01 INFO - 'MOZ_NO_REMOTE': '1', 19:53:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:53:01 INFO - 'NO_EM_RESTART': '1', 19:53:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:53:01 INFO - 'PWD': '/builds/slave/test', 19:53:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:53:01 INFO - 'SHELL': '/bin/bash', 19:53:01 INFO - 'SHLVL': '1', 19:53:01 INFO - 'TERM': 'linux', 19:53:01 INFO - 'TMOUT': '86400', 19:53:01 INFO - 'USER': 'cltbld', 19:53:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906', 19:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:53:01 INFO - '_': '/tools/buildbot/bin/python'} 19:53:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 19:53:01 INFO - mozversion application_buildid: 20170210024921 19:53:01 INFO - mozversion application_changeset: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 19:53:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:53:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:53:01 INFO - mozversion application_name: Firefox 19:53:01 INFO - mozversion application_remotingname: firefox-dev 19:53:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:53:01 INFO - mozversion application_vendor: Mozilla 19:53:01 INFO - mozversion application_version: 53.0a2 19:53:01 INFO - mozversion platform_buildid: 20170210024921 19:53:01 INFO - mozversion platform_changeset: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 19:53:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:53:01 INFO - mozversion platform_version: 53.0a2 19:53:01 INFO - using testdate: 1486698781 19:53:01 INFO - actual date: 1486698781 19:53:01 INFO - starting webserver on 'localhost:44780' 19:53:01 INFO - SUITE-START | Running 2 tests 19:53:01 INFO - TEST-START | dromaeo_css 19:53:01 INFO - operating with platform_type : linux_ 19:53:01 INFO - Initialising browser for dromaeo_css test... 19:53:01 INFO - TEST-INFO | started process 21932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5EPiF7/profile http://localhost:44780/getInfo.html) 19:53:05 INFO - PROCESS | 21932 | __metrics Screen width/height:1600/1200 19:53:05 INFO - PROCESS | 21932 | colorDepth:24 19:53:05 INFO - PROCESS | 21932 | Browser inner width/height: 1024/697 19:53:05 INFO - PROCESS | 21932 | __metrics 19:53:06 INFO - PROCESS | 21932 | 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" 19:53:06 INFO - PROCESS | 21932 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:53:06 INFO - TEST-INFO | 21932: exit 0 19:53:06 INFO - Browser initialized. 19:53:06 INFO - Running cycle 1/1 for dromaeo_css test... 19:53:06 INFO - TEST-INFO | started process 22023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5EPiF7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:53:18 INFO - PROCESS | 22023 | RSS: Main: 138432512 19:53:18 INFO - PROCESS | 22023 | 19:56:18 INFO - PROCESS | 22023 | Cycle 1(1): loaded http://localhost:44780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44780/tests/dromaeo/cssquery-ext.html) 19:56:20 INFO - PROCESS | 22023 | RSS: Main: 247341056 19:56:20 INFO - PROCESS | 22023 | 19:58:08 INFO - PROCESS | 22023 | ************************* 19:58:08 INFO - PROCESS | 22023 | A coding exception was thrown and uncaught in a Task. 19:58:08 INFO - PROCESS | 22023 | 19:58:08 ERROR - PROCESS | 22023 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:58:08 INFO - PROCESS | 22023 | Full stack: 19:58:08 INFO - PROCESS | 22023 | ************************* 19:59:22 INFO - PROCESS | 22023 | Cycle 1(1): loaded http://localhost:44780/tests/dromaeo/cssquery-ext.html (next: http://localhost:44780/tests/dromaeo/cssquery-jquery.html) 19:59:22 INFO - PROCESS | 22023 | RSS: Main: 220934144 19:59:22 INFO - PROCESS | 22023 | 20:02:24 INFO - PROCESS | 22023 | Cycle 1(1): loaded http://localhost:44780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44780/tests/dromaeo/cssquery-mootools.html) 20:02:25 INFO - PROCESS | 22023 | RSS: Main: 174669824 20:02:25 INFO - PROCESS | 22023 | 20:05:27 INFO - PROCESS | 22023 | Cycle 1(1): loaded http://localhost:44780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44780/tests/dromaeo/cssquery-prototype.html) 20:05:27 INFO - PROCESS | 22023 | RSS: Main: 213504000 20:05:27 INFO - PROCESS | 22023 | 20:08:30 INFO - PROCESS | 22023 | Cycle 1(1): loaded http://localhost:44780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44780/tests/dromaeo/cssquery-yui.html) 20:08:31 INFO - PROCESS | 22023 | RSS: Main: 171778048 20:08:31 INFO - PROCESS | 22023 | 20:11:33 INFO - PROCESS | 22023 | Cycle 1(1): loaded http://localhost:44780/tests/dromaeo/cssquery-yui.html (next: http://localhost:44780/tests/dromaeo/cssquery-dojo.html) 20:11:33 INFO - PROCESS | 22023 | RSS: Main: 262275072 20:11:33 INFO - PROCESS | 22023 | 20:11:33 INFO - PROCESS | 22023 | __start_tp_report 20:11:33 INFO - PROCESS | 22023 | _x_x_mozilla_page_load 20:11:33 INFO - PROCESS | 22023 | _x_x_mozilla_page_load_details 20:11:33 INFO - PROCESS | 22023 | |i|pagename|runs| 20:11:33 INFO - PROCESS | 22023 | |0;dojo.html;3214.6946040126186;3236.514522821578;3261.59230096238;3265.7224135948445;3274.132354925945;5328.786848526064;5333.653312534682;5354.464553544649;5367.677939323634;5427.294451721271;5400.054990376678;5430.348358197012;5446.591505637083;5447;5447.046766815811;4962.181240095389;5017.573506251954;5017.974910125445;5037.219231019198;5071.847844564669;4902.0931127741305;4993.675411098285;5045.722485263309;5051.166557518005;5088.720120393377;4878.780454879521;4893.755312234392;4938.333325001133;4982.302477653131;5022.17134172861;5025.798968041274;5061.873453163664;5070.5690016348835;5074.720890351029;5104.4640312767;4818.180909245437;4872.756362181876;4968.329275547827;4989.301497790312;5055.823046193365;5292.126799078147;5360.544353729938;5375.3280839895015;5390.272313237741;5440.129579267338;5835.299764028344;5848.122781582797;5848.912266316009;5852.736626851802;5861.2087368205175;5659.122835960433;5818.766445479683;5883.029300165467;5885.823425297248;5886.911696324559;5341.305630268041;5370.7046112463795;5408.215808707715;5423.376311724123;5489.204065410573;5897.557683173779;5901.0558310670085;5911.231539899785;5912.674802885883;5918.408159184047;5708.229389032511;5710;5718.7426565804635;5725.055365864669;5728.77084916607;5648.689322087324;5681.630694004876;5753.626014309057;5757.884842303214;5785.4214578541805;5824.592278540546;5826.388229235869;5827.79602713903;5830.883382332329;5858.091995740667;5781.103928891029;5827.679477628686;5839.386864379264;5843.970780146072;5849.707514624251;4413.801378937956;4468.50846406895;4482.327650852333;4486.327050942385;4515.096980603892;4022.3162062449455;4028.4762980812307;4047.777372244496;4055.7160998730396;4066.2274167908004;5683.204351390808;5688.146777983336;5690.658560486384;5695;5696.11710184922;5715.942840571541;5758.625689330264;5781.71091445426;5824.737886795105;5825.24271844666;5648.124540696199;5676.403977582377;5679.148127780866;5679.346875109415;5701.600887937888;4982.377202849644;4991.201407774739;4993.325901003318;4994.150994330972;5026.09530284545;5876.500497457679;5919.378465261172;5929.881402371929;5963.135345374983;6032.879342413127;5830;5832.854178645568;5847.678377689268;5853.64878107315;5871;5968.910466342922;6014.6391216527145;6021.126936594257;6021.337652858269;6029.57792954489;5638.351589567088;5683.77264909399;5705.2297939779255;5744.3681195067675;5745.511631511368;5790.478856902899;5857.619254748428;5860.09168578871;5886.911696324473;5907.2911250650195;5719.542436604978;5720.027595308724;5730.369659337386;5732.598718089694;5733.71331433435;5545.694986775766;5558.499735023867;5682.176084467812;5700.030994730989;5707.771689132388;5589.832305030855;5632.943670563406;5642.069058605284;5675.943240567542;5704.344000440003;5622.409646987171;5673.007223735913;5703.914441283301;5707.229524014205;5711.400302968129;5474.2609747683555;5590;5590.86022849432;5592.944070559242;5598.272224610774 20:11:33 INFO - PROCESS | 22023 | |1;ext.html;543.1105944678944;586.6802592587039;607.3926073926075;631.712570780295;632.1686981619167;48149.51850481494;48990;49004.50995490044;49020.509794902086;53693.46306536933;49387.75306123473;49579.25631115536;49920.251196232086;49951.750241248745;50019.99960000798;8517;9388.155066044055;9593.520323983808;9595.136437720605;9596.32825702201;8546.05993340732;11140.944295278512;11469;11483.885161148366;11850.407479626027;11514.942425287862;11566.132540059487;11578.884211157907;11590.478428470697;11592.710182245428;11319.151063670217;11392.886071139306;11394.54421823126;11407.372594507298;11419.885801142049;11297.209195356329;11359.943200283946;11364.261323013978;11372.601958931398;11377.829332560019;46671.53328466706;46815.531844681456;46923;46968.5303146971;47025.29462058072;4419.292913133883;4482.798274077674;4531.977340113312;4624.907501849944;4668.346431499593;34173;34321.828390858136;34434.311313773585;34703.132421689406;36461.81769091164;4600.079984003212;4642.466116396624;4698.859034228979;4723.433188017426;4752.738599377033;349803;483487;487147;487323.99999999645;489272;62464.68767656224;63194;63196;63272.36727632757;63311.6834415825;65642.34357656362;66282;66314.33685663178;66441.6677916617;66443;18861.52846178829;19210.231590736494;19211.231550737815;19237.326693565657;19347.12937917797;12926.547570834975;13341.19952802835;13489.932550337186;13498.122622029732;14572.489962851248;19445.805541944683;19895.80625162495;20215.797842021686;20256.29102981418;20282.29011984603;7500.36246919007;7506.211847756016;7534.171241163468;7562.281583249583;7669.38644908406;965.5027660754716;979.8285300072602;983.0513554420019;984.3798407003685;1010.8989101089979;33061.17347066342;33915.66084339174;34414.139646508534;34742.47886281708;34797.652023479444;1096.6326280695896;1150.5167829511458;1163.03468121459;1174.8061569840881;1180.6635108993896;17844.107794610216;17904.91047544754;17967.910160449115;18080.457586272434;18160;546533;548601;550764;550922;551846;68917.65541172362;69449;69508;69613;69677.65161174162;1492.5671555249073;1517.7192219439219;1547.636305468214;1549.4189678870423;1556.5096994446712;32375.190620234684;33668.83165584156;34046.48930266098;34306;34561;58825.70587147037;59593.70203148956;59711.701441492514;59758;59793.402065978786;406218;407215;408015;408037;408927;28498.715012850436;29584.112476625734;29885.103446896628;31111.688883111783;31963.680363197;51793.482065180375;52167.47832521778;52176.47823521868;52305.47694523158;53083.95702408265;43075;43219.78390108155;43563;43691;45390.54609453863;41441;42213.78893105515;42413.78793106015;43206.783966081224;44758.77620611876;41932.161356772085;42257.78871105625;42864;43122.353164703185;43577.78211108924;35180.472292916136;37574.62425375821;37784;37843.432348514245;38409.807950960065;27968.160955171377;28188.577171342036;28329.71670283353;28532.42935141327;28541.143765687062 20:11:33 INFO - PROCESS | 22023 | |2;jquery.html;435.95858393452653;441.81664609187186;444.6131865277209;446.6761597841563;455.3238440915242;20493.077811498482;21286.787132128673;22389.55220895581;22523.887380563094;22593.774062259374;22548.88725556374;22783.31650050497;23112;23113;23288.534229315446;6009.909851352233;6020.187274717911;6216.906746398785;6284.622922624657;6292.056191571278;6060.363661815512;6270.3729627037155;6284.5600807943465;6285;6321.178246827906;6150.969245153768;6266.592671476339;6335.11308416822;6338.176037115169;6440.259370172444;6375.011873159668;6412.903806442907;6418.326075762047;6427.646479443629;6429.742810287583;5583.05088135018;5807.506361959238;5851.297844258716;5899.793507227227;5921.881562368729;15304.464343748026;15306.923465382713;15384.846151538453;15474.767878481833;15525.534233973;2776.9166924992282;2777.8611069446647;2782.833030018185;2793.2178989882864;2793.7345952134515;10832.295900766425;11077.556897724082;11287.548498060069;12912.935435322857;15190.544283671508;1929.1962015515537;2034.6947957806299;2037.3073155127329;2061.2167376397024;2079.511314841011;94004;94452.52773736087;94708;95838.52080739621;98757.55590998351;12364.814527782091;12407.689807754878;12643.367831608382;12944.870551294554;12986.935065324802;18465.81534184641;18468.076596170136;18470.630587388176;18482.630347392977;18489.81510184881;8911.50986695738;8992.100789920956;9011.098890110936;9057.230135438429;9183.908160918305;8329.08380078191;8346.8330633387;8362.79093022667;8542.658293668184;8553;5482.725863706799;5527.917081243784;5565.582581306418;5593.133064375028;5648.039833228361;2200.2519143490968;2219.7003404540505;2222.7443843958154;2334.2763743239652;2343.55472460232;1119.972000699989;1136;1141.2068612314363;1147.2829481574017;1170.0990237517065;20526.178952841718;20674.58650826975;21015.264465743625;21045.368638940858;21203.15187392487;1115.760111576015;1126.7408496045955;1131.688785583971;1134.4724703012973;1146.031603295231;11637.825432618349;11784.469698863571;11825.822612660817;11854.88145118555;11884;601358;650603;671090;684065;687773;97649.51175244221;99732.50133749285;102200;105582.47208763906;107541;1144.7653231087606;1175.1538891997577;1189.084405008139;1194.5580135349803;1199.3763243113533;19140.617187656448;19496.31762888292;19498;19660.115294811483;19694.31069912546;45635.54364456313;45704.54295457003;45846;47317.29024064573;48426.01085851616;62629;66270.66864665646;66448.66775666284;67768.6611566939;69266;9521;9709.854352184582;9729.881063677485;9781.559829807818;9848.458334791369;11488.770224595628;14384.712305753617;14399.856001439852;14413.927930360282;14463;10626.203034772578;11498.94250528742;11961.564612246586;12112.091593130726;12776.10567260283;7648.235176482307;7978.521288722695;12360.25838449696;12513.687157821127;12714.427850746924;12174.513019479122;12320.876791231973;12518.061145413949;12699.174553653984;13068.346582671018;9299.76750581241;9568.904310956801;9644.565994530123;9659.565319560777;9702;10647.733806654896;11696.70758231051;11759.529618815493;11781.352025638673;12046.156769026084 20:11:33 INFO - PROCESS | 22023 | |3;mootools.html;1359.9320033998297;1500.137420982935;1500.2798656644804;1500.5348342013976;1516.5071351810664;7780.221977802217;8420.873686894694;8706.912930870689;8707.608157632905;8795.91204087959;8494.660213591449;8638.265747411462;8639.092895246004;8823.647054117828;8846.380753347268;2076.3978446250644;2136.8824714640687;2434.111549284516;2484.689413823272;2485.9129930452436;2424.35754525051;2508.5484612769787;2508.623706444039;2519.59686450168;2522.8990840366364;2445.364205306615;2458.1150785717127;2458.43456005118;2461.913833015845;2476.9968162893965;2469.715982661999;2511.3847107458605;2526.1916186820226;2528.7471252874657;2536.5307418127704;2493.875306234699;2509.1218073674067;2511.660925775015;2517.5720127578356;2517.6097704855592;8635;8695.130486951255;8744.344174186897;8843.823123537493;8954.41796283246;5410.783568657249;5549.112142057252;5550.91673624896;5553.527950124244;5554.444555544454;3160.5417214504;3300.85146168423;3412.795232286046;3445.3453843769603;3454.6372630873648;1341.6377578053969;1380.5168191133123;1405.4659229492727;1410.7672234081365;1424.9643758906006;11413.942930285295;11447.656570302905;11505.654830355103;11523.59667411645;11556;4443.2224360736745;4742.596879265232;4757.690750101232;4852.2479015752615;4856.247281671346;10421.895781042243;10449.791004179873;10450.529726162342;10489.790204195873;10555.47222638865;5412.729363531807;5455.945440545624;5456.672599644034;5461.453854614507;5467.097928841776;4882.633802464829;4888.9755551222015;5031.723255220998;5042.924356134661;5100.566451851634;4244.469441319835;4286.61420472159;4301.591348821857;4354.804033818486;4395.868123956287;1368.3910659756314;1405.086693649116;1405.5853523210678;1413.6819215676392;1424.7577911755027;985.2561316206219;1006.174936552035;1020.0666390252984;1023.8873723890366;1028.5217373921162;5716.342620598684;5905.084711869667;5919.852003699942;6078.848028799227;6109.694515274218;647.5402464250341;661.5137873662854;664.7839452178061;670.8389986403325;672.4721093941232;4007.4189242560246;4102.835886564504;4160.251154792106;4189.392538082022;4217.641500472433;10205.285630005828;10741.570337186426;10752.354858708346;10757.731056723644;10760.300580462244;10493.317934334244;10604.575816967235;10605.522751476203;10627.628033018807;10637.202209834293;8047.919520804717;8184.2224988625985;8252.752417427366;8270.172982701682;8280.296174825207;5836.678982655994;5881.411858814085;5993.790217342372;6004.939950600613;6063.72713227897;9212.677556285498;9227.3079519035;9231.676891308773;9462.858057129011;9470.052994700474;8671.783205419915;9542.522873856418;9685.128338449573;9727.367721098106;9798.363106398061;7083.795754721813;7463.701451941862;7635;7753.612319384121;7875.960620196863;8288;8316.126806685212;8365.832683346422;8458.281046110904;8498.74503764888;7495.213002634863;7574.886376704464;7580.658870350737;7590.39276857839;7637.083549974039;7384.37232835215;7421.925780742339;7487.6630551626395;7594.848103038019;7652.61736913141;6580.868382632225;6713.261541230363;6840.452763778985;6850.0409942607075;6914.792556223321;5106.4893510648635;5182.263941579613;5221.537969368583;5308;5327.9467205329;5039.722815245197;5049.394072711299;5050.141475949024;5110.97444512775;5202 20:11:33 INFO - PROCESS | 22023 | |4;prototype.html;405.5356616673907;410.2695916087511;417.3864419303624;427.67496702506094;432.23494414885675;5179.896402071956;5228.29418028566;5262.394969534291;5274.077036518613;5276.788928442863;4950.480199579038;5049.636598118505;5068.8225912093085;5157.896842063156;5185.833187532803;4249.383839343293;4254.383114448396;4257.467816522934;4260.850870219543;4273.850415235467;4284.378765079062;4285.44289242398;4290;4296.226679197744;4303.7848107594655;3965.286248475273;4089.5092588889224;4246.617804397603;4249.745015299092;4293.076988447483;4197.538270790211;4221.831126754926;4249.6387807036435;4266.210751011057;4270.295401258789;3858.4791053207737;3861.4787003754413;3872.1539668343744;3884.3008258513455;3906.226579128822;4997.925031124536;5010.624203184776;5038.420581633122;5084.389873215201;5166.767495462713;4766.928496072562;4792.832250871203;4810.186041165922;4815;4833.7583120844165;5460.071787796084;5463.617546771728;5483.7806487740445;5506.229127922094;5532.834014979517;4191.811368488426;4235.49174099107;4269.231538323101;4276.657867370603;4306.784660766949;5462.508374246337;5616.269884914935;5643.802466913679;5666.971665141689;5667.489925906688;4334.739915605074;4354.716943398669;4372.453443319585;4393.890152746143;4404.295312750009;4323.7621930793475;4361.669690744354;4390.209762242827;4428.889277768081;4435.469762931783;4822.132016237111;4837.637177211653;4841;4853.733044682576;4876.853694389174;5530.529904958124;5535.391106978229;5548.55611551075;5592.120058170046;5596;1466.633341664584;1471.3599584180915;1485.576610665955;1500.6173425776576;1505.3903169216485;1038.8441733739999;1049.7952899184586;1068.8557044799009;1099.4063205868902;1100.6863044032411;5241.554467870197;5247.291615631917;5247.501487358695;5251.264822924793;5258.947410525846;5428.37573679032;5462.562994960394;5466.262054622654;5469.371022332482;5480.972595136999;4991.201407774739;5150.381954165449;5178.326817513699;5228.901930594541;5230.8169214077325;2856.643094530123;2871.535516886403;2882.2506148401567;2887.870045847942;2891.3638999420095;5475.479829416199;5615.0454422748235;5645.9717701412055;5646.322441307069;5675.914861277084;5480.561555075585;5492.340919089655;5505.642133261325;5505.6696598204235;5512.200730894078;5608.85977850557;5610.438956104357;5619.381867994517;5652.378238393856;5676.574256930664;5244.76398562058;5342.679439233659;5427.48438898304;5443.149329228081;5485.753141108739;5427.565794736491;5433.239346491573;5433.293671822637;5447.863803404946;5448.373437054631;5512.476314750093;5670.319561652628;5701.344345400332;5702.8024114936325;5712.200291959046;4186.413902053776;4219.915601688011;4228.5388914695295;4231.746095234173;4234.703570750018;5373.570114390917;5411.729413529387;5416.160495123262;5424.830067972843;5510.228568000563;5063.885006987334;5300.867478313073;5334.826338205588;5358.097875254384;5364.678119312854;5270.075108314922;5282.709450980233;5293.867653308698;5294.655847369909;5300.9133127707955;5172.922406163986;5287.656302340336;5293.311869456946;5309.389420216725;5328.374845672107;5319.813806516753;5473.507384335429;5488.231647569423;5509.146082357241;5524.58565607573;5320.707361095022;5324;5354.678719276856;5369.48989845964;5390.326209223847 20:11:33 INFO - PROCESS | 22023 | |5;yui.html;817.3910436724641;838.6561509780984;852.7868032991752;911.2205193361393;920.9769755756105;14429.567112986613;15169.696606067871;15180.31688574014;15191.088534687913;16290.26693798779;15882.444114455997;16049;16069.437569685064;16093.517194484155;16096.356145754156;682.1473158551822;702;787.8857565653005;809.550699361854;810.3800592546706;816.995915020424;817.9468334558235;818.5825229133155;818.7748369198488;818.8526065308242;845.5983407881268;861.8190180062195;862.288611895189;862.7325529085972;863.2791618998144;716.9498135130543;734.5996431944576;810.3922058456158;829.0424559633573;850.9361797865154;620.4509009526556;620.6772478311298;620.8913440147955;621.1056079245872;622.6730966242759;14473.986820922539;14479.05886117399;14492.927535362362;14537;14949.551513454506;14590.197539135343;15095.32071056805;15245.771313430307;15428.537143885702;15654.45209417665;13964.162150271017;14037.508687196001;14058.859411405858;14202.573922782332;14409.71180576393;4530.229860923618;4590.08198360326;4591.4260717410325;4630.189716799547;4672.766361681936;72716.27283727148;73454;74474;74621;74679.62660186719;11907.226030308002;11930.3438310892;11956.461959211856;12004.939975300067;12077.154599177973;23167.768322316897;23304.184353547884;23378.883105584362;23591.646125308132;23755.643665345033;8442.62008209632;8527.786805329917;8535.061143274235;8546.13686097062;8661.13388661129;4689.60138388234;4733.881652958635;4747.430308362949;4816.253480710496;4857;3643.4534819776713;3680.0431887709387;3725.161838586296;3725.4784330193793;3748.2878253131817;583.5652438933022;583.5944018906819;584.400988986284;594.4501336263938;595.76765061626;725.3045190528488;739.1684355100512;759.1156302907161;790.4585359029084;797.57728403946;10685.732856678645;10848.349099054081;10972.670819875417;10999.450027498593;11349.148813838996;749.966251518672;752.3078767533773;758.332667252825;776.2121446731572;801.8436404900988;4704.270838020112;4808.663393562417;4813.28378774993;4845.806167753321;4901.705897646153;78440.60779696179;78521.60739196268;80723.19276807274;81978;84537;70932.2906770936;70985.64507177535;71297.64351178211;73151.26848731551;73719.26280737232;61955.38044619496;62036.68981655063;62065.37934620596;62276.688616557534;62807.37192628015;9176.908230917605;9243.815123697623;9290.72127836166;9375.249980001447;9470.14768670823;37475.25049499049;37502.81248593739;45036;45394.31908521309;46084.30873536967;52353;53396.1990570134;53539.464605353445;55871.441285586625;57705.422945770006;14213.857861421253;14545.200013999332;14638.341274642453;14652.340644671229;14794.852051479347;16241.59396015109;16258.593535161715;16320.755188671941;16332.428365007643;16498.25757840876;15202.239888005777;15608.687826243638;15646.452374166849;16139.1930403477;16608.086555239577;14690.192039437934;14722.55832325032;14897.702045958804;14938.925305373403;15033.924830375778;14711.190884501455;14738.215852996358;14780.778288325899;14938.925305373403;14941.252937353307;12539.24764514132;12709.17390369623;12943.482260709843;13271.137376070525;13448.055450132708;11437.199396042197;11527.596534121602;11619.709507262387;11653.242539234923;11893.524259029888 20:11:33 INFO - PROCESS | 22023 | __end_tp_report 20:11:33 INFO - PROCESS | 22023 | __start_cc_report 20:11:33 INFO - PROCESS | 22023 | _x_x_mozilla_cycle_collect,1049 20:11:33 INFO - PROCESS | 22023 | __end_cc_report 20:11:33 INFO - PROCESS | 22023 | __startTimestamp1486699893745__endTimestamp 20:11:33 INFO - PROCESS | 22023 | 20:11:33 INFO - PROCESS | 22023 | ------- Summary: start ------- 20:11:33 INFO - PROCESS | 22023 | Number of tests: 6 20:11:33 INFO - PROCESS | 22023 | 20:11:33 INFO - PROCESS | 22023 | [#0] dojo.html Cycles:165 Average:5418.24 Median:5676.40 stddev:589.12 (10.4%) stddev-sans-first:565.00 20:11:33 INFO - PROCESS | 22023 | Values: 3214.7 3236.5 3261.6 3265.7 3274.1 5328.8 5333.7 5354.5 5367.7 5427.3 5400.1 5430.3 5446.6 5447.0 5447.0 4962.2 5017.6 5018.0 5037.2 5071.8 4902.1 4993.7 5045.7 5051.2 5088.7 4878.8 4893.8 4938.3 4982.3 5022.2 5025.8 5061.9 5070.6 5074.7 5104.5 4818.2 4872.8 4968.3 4989.3 5055.8 5292.1 5360.5 5375.3 5390.3 5440.1 5835.3 5848.1 5848.9 5852.7 5861.2 5659.1 5818.8 5883.0 5885.8 5886.9 5341.3 5370.7 5408.2 5423.4 5489.2 5897.6 5901.1 5911.2 5912.7 5918.4 5708.2 5710.0 5718.7 5725.1 5728.8 5648.7 5681.6 5753.6 5757.9 5785.4 5824.6 5826.4 5827.8 5830.9 5858.1 5781.1 5827.7 5839.4 5844.0 5849.7 4413.8 4468.5 4482.3 4486.3 4515.1 4022.3 4028.5 4047.8 4055.7 4066.2 5683.2 5688.1 5690.7 5695.0 5696.1 5715.9 5758.6 5781.7 5824.7 5825.2 5648.1 5676.4 5679.1 5679.3 5701.6 4982.4 4991.2 4993.3 4994.2 5026.1 5876.5 5919.4 5929.9 5963.1 6032.9 5830.0 5832.9 5847.7 5853.6 5871.0 5968.9 6014.6 6021.1 6021.3 6029.6 5638.4 5683.8 5705.2 5744.4 5745.5 5790.5 5857.6 5860.1 5886.9 5907.3 5719.5 5720.0 5730.4 5732.6 5733.7 5545.7 5558.5 5682.2 5700.0 5707.8 5589.8 5632.9 5642.1 5675.9 5704.3 5622.4 5673.0 5703.9 5707.2 5711.4 5474.3 5590.0 5590.9 5592.9 5598.3 20:11:33 INFO - PROCESS | 22023 | 20:11:33 INFO - PROCESS | 22023 | [#1] ext.html Cycles:180 Average:65227.91 Median:42638.89 stddev:126196.05 (296.0%) stddev-sans-first:126456.61 20:11:33 INFO - PROCESS | 22023 | Values: 543.1 586.7 607.4 631.7 632.2 48149.5 48990.0 49004.5 49020.5 53693.5 49387.8 49579.3 49920.3 49951.8 50020.0 8517.0 9388.2 9593.5 9595.1 9596.3 8546.1 11140.9 11469.0 11483.9 11850.4 11514.9 11566.1 11578.9 11590.5 11592.7 11319.2 11392.9 11394.5 11407.4 11419.9 11297.2 11359.9 11364.3 11372.6 11377.8 46671.5 46815.5 46923.0 46968.5 47025.3 4419.3 4482.8 4532.0 4624.9 4668.3 34173.0 34321.8 34434.3 34703.1 36461.8 4600.1 4642.5 4698.9 4723.4 4752.7 349803.0 483487.0 487147.0 487324.0 489272.0 62464.7 63194.0 63196.0 63272.4 63311.7 65642.3 66282.0 66314.3 66441.7 66443.0 18861.5 19210.2 19211.2 19237.3 19347.1 12926.5 13341.2 13489.9 13498.1 14572.5 19445.8 19895.8 20215.8 20256.3 20282.3 7500.4 7506.2 7534.2 7562.3 7669.4 965.5 979.8 983.1 984.4 1010.9 33061.2 33915.7 34414.1 34742.5 34797.7 1096.6 1150.5 1163.0 1174.8 1180.7 17844.1 17904.9 17967.9 18080.5 18160.0 546533.0 548601.0 550764.0 550922.0 551846.0 68917.7 69449.0 69508.0 69613.0 69677.7 1492.6 1517.7 1547.6 1549.4 1556.5 32375.2 33668.8 34046.5 34306.0 34561.0 58825.7 59593.7 59711.7 59758.0 59793.4 406218.0 407215.0 408015.0 408037.0 408927.0 28498.7 29584.1 29885.1 31111.7 31963.7 51793.5 52167.5 52176.5 52305.5 53084.0 43075.0 43219.8 43563.0 43691.0 45390.5 41441.0 42213.8 42413.8 43206.8 44758.8 41932.2 42257.8 42864.0 43122.4 43577.8 35180.5 37574.6 37784.0 37843.4 38409.8 27968.2 28188.6 28329.7 28532.4 28541.1 20:11:33 INFO - PROCESS | 22023 | 20:11:33 INFO - PROCESS | 22023 | [#2] jquery.html Cycles:180 Average:35294.31 Median:22947.66 stddev:108422.21 (472.5%) stddev-sans-first:108694.77 20:11:33 INFO - PROCESS | 22023 | Values: 436.0 441.8 444.6 446.7 455.3 20493.1 21286.8 22389.6 22523.9 22593.8 22548.9 22783.3 23112.0 23113.0 23288.5 6009.9 6020.2 6216.9 6284.6 6292.1 6060.4 6270.4 6284.6 6285.0 6321.2 6151.0 6266.6 6335.1 6338.2 6440.3 6375.0 6412.9 6418.3 6427.6 6429.7 5583.1 5807.5 5851.3 5899.8 5921.9 15304.5 15306.9 15384.8 15474.8 15525.5 2776.9 2777.9 2782.8 2793.2 2793.7 10832.3 11077.6 11287.5 12912.9 15190.5 1929.2 2034.7 2037.3 2061.2 2079.5 94004.0 94452.5 94708.0 95838.5 98757.6 12364.8 12407.7 12643.4 12944.9 12986.9 18465.8 18468.1 18470.6 18482.6 18489.8 8911.5 8992.1 9011.1 9057.2 9183.9 8329.1 8346.8 8362.8 8542.7 8553.0 5482.7 5527.9 5565.6 5593.1 5648.0 2200.3 2219.7 2222.7 2334.3 2343.6 1120.0 1136.0 1141.2 1147.3 1170.1 20526.2 20674.6 21015.3 21045.4 21203.2 1115.8 1126.7 1131.7 1134.5 1146.0 11637.8 11784.5 11825.8 11854.9 11884.0 601358.0 650603.0 671090.0 684065.0 687773.0 97649.5 99732.5 102200.0 105582.5 107541.0 1144.8 1175.2 1189.1 1194.6 1199.4 19140.6 19496.3 19498.0 19660.1 19694.3 45635.5 45704.5 45846.0 47317.3 48426.0 62629.0 66270.7 66448.7 67768.7 69266.0 9521.0 9709.9 9729.9 9781.6 9848.5 11488.8 14384.7 14399.9 14413.9 14463.0 10626.2 11498.9 11961.6 12112.1 12776.1 7648.2 7978.5 12360.3 12513.7 12714.4 12174.5 12320.9 12518.1 12699.2 13068.3 9299.8 9568.9 9644.6 9659.6 9702.0 10647.7 11696.7 11759.5 11781.4 12046.2 20:11:33 INFO - PROCESS | 22023 | 20:11:33 INFO - PROCESS | 22023 | [#3] mootools.html Cycles:180 Average:5748.50 Median:5075.35 stddev:3129.16 (61.7%) stddev-sans-first:3120.55 20:11:33 INFO - PROCESS | 22023 | Values: 1359.9 1500.1 1500.3 1500.5 1516.5 7780.2 8420.9 8706.9 8707.6 8795.9 8494.7 8638.3 8639.1 8823.6 8846.4 2076.4 2136.9 2434.1 2484.7 2485.9 2424.4 2508.5 2508.6 2519.6 2522.9 2445.4 2458.1 2458.4 2461.9 2477.0 2469.7 2511.4 2526.2 2528.7 2536.5 2493.9 2509.1 2511.7 2517.6 2517.6 8635.0 8695.1 8744.3 8843.8 8954.4 5410.8 5549.1 5550.9 5553.5 5554.4 3160.5 3300.9 3412.8 3445.3 3454.6 1341.6 1380.5 1405.5 1410.8 1425.0 11413.9 11447.7 11505.7 11523.6 11556.0 4443.2 4742.6 4757.7 4852.2 4856.2 10421.9 10449.8 10450.5 10489.8 10555.5 5412.7 5455.9 5456.7 5461.5 5467.1 4882.6 4889.0 5031.7 5042.9 5100.6 4244.5 4286.6 4301.6 4354.8 4395.9 1368.4 1405.1 1405.6 1413.7 1424.8 985.3 1006.2 1020.1 1023.9 1028.5 5716.3 5905.1 5919.9 6078.8 6109.7 647.5 661.5 664.8 670.8 672.5 4007.4 4102.8 4160.3 4189.4 4217.6 10205.3 10741.6 10752.4 10757.7 10760.3 10493.3 10604.6 10605.5 10627.6 10637.2 8047.9 8184.2 8252.8 8270.2 8280.3 5836.7 5881.4 5993.8 6004.9 6063.7 9212.7 9227.3 9231.7 9462.9 9470.1 8671.8 9542.5 9685.1 9727.4 9798.4 7083.8 7463.7 7635.0 7753.6 7876.0 8288.0 8316.1 8365.8 8458.3 8498.7 7495.2 7574.9 7580.7 7590.4 7637.1 7384.4 7421.9 7487.7 7594.8 7652.6 6580.9 6713.3 6840.5 6850.0 6914.8 5106.5 5182.3 5221.5 5308.0 5327.9 5039.7 5049.4 5050.1 5111.0 5202.0 20:11:33 INFO - PROCESS | 22023 | 20:11:33 INFO - PROCESS | 22023 | [#4] prototype.html Cycles:180 Average:4633.81 Median:5207.06 stddev:1272.55 (24.4%) stddev-sans-first:1235.91 20:11:33 INFO - PROCESS | 22023 | Values: 405.5 410.3 417.4 427.7 432.2 5179.9 5228.3 5262.4 5274.1 5276.8 4950.5 5049.6 5068.8 5157.9 5185.8 4249.4 4254.4 4257.5 4260.9 4273.9 4284.4 4285.4 4290.0 4296.2 4303.8 3965.3 4089.5 4246.6 4249.7 4293.1 4197.5 4221.8 4249.6 4266.2 4270.3 3858.5 3861.5 3872.2 3884.3 3906.2 4997.9 5010.6 5038.4 5084.4 5166.8 4766.9 4792.8 4810.2 4815.0 4833.8 5460.1 5463.6 5483.8 5506.2 5532.8 4191.8 4235.5 4269.2 4276.7 4306.8 5462.5 5616.3 5643.8 5667.0 5667.5 4334.7 4354.7 4372.5 4393.9 4404.3 4323.8 4361.7 4390.2 4428.9 4435.5 4822.1 4837.6 4841.0 4853.7 4876.9 5530.5 5535.4 5548.6 5592.1 5596.0 1466.6 1471.4 1485.6 1500.6 1505.4 1038.8 1049.8 1068.9 1099.4 1100.7 5241.6 5247.3 5247.5 5251.3 5258.9 5428.4 5462.6 5466.3 5469.4 5481.0 4991.2 5150.4 5178.3 5228.9 5230.8 2856.6 2871.5 2882.3 2887.9 2891.4 5475.5 5615.0 5646.0 5646.3 5675.9 5480.6 5492.3 5505.6 5505.7 5512.2 5608.9 5610.4 5619.4 5652.4 5676.6 5244.8 5342.7 5427.5 5443.1 5485.8 5427.6 5433.2 5433.3 5447.9 5448.4 5512.5 5670.3 5701.3 5702.8 5712.2 4186.4 4219.9 4228.5 4231.7 4234.7 5373.6 5411.7 5416.2 5424.8 5510.2 5063.9 5300.9 5334.8 5358.1 5364.7 5270.1 5282.7 5293.9 5294.7 5300.9 5172.9 5287.7 5293.3 5309.4 5328.4 5319.8 5473.5 5488.2 5509.1 5524.6 5320.7 5324.0 5354.7 5369.5 5390.3 20:11:33 INFO - PROCESS | 22023 | 20:11:33 INFO - PROCESS | 22023 | [#5] yui.html Cycles:180 Average:18087.52 Median:4696.94 stddev:22268.20 (474.1%) stddev-sans-first:22292.90 20:11:33 INFO - PROCESS | 22023 | Values: 817.4 838.7 852.8 911.2 921.0 14429.6 15169.7 15180.3 15191.1 16290.3 15882.4 16049.0 16069.4 16093.5 16096.4 682.1 702.0 787.9 809.6 810.4 817.0 817.9 818.6 818.8 818.9 845.6 861.8 862.3 862.7 863.3 716.9 734.6 810.4 829.0 850.9 620.5 620.7 620.9 621.1 622.7 14474.0 14479.1 14492.9 14537.0 14949.6 14590.2 15095.3 15245.8 15428.5 15654.5 13964.2 14037.5 14058.9 14202.6 14409.7 4530.2 4590.1 4591.4 4630.2 4672.8 72716.3 73454.0 74474.0 74621.0 74679.6 11907.2 11930.3 11956.5 12004.9 12077.2 23167.8 23304.2 23378.9 23591.6 23755.6 8442.6 8527.8 8535.1 8546.1 8661.1 4689.6 4733.9 4747.4 4816.3 4857.0 3643.5 3680.0 3725.2 3725.5 3748.3 583.6 583.6 584.4 594.5 595.8 725.3 739.2 759.1 790.5 797.6 10685.7 10848.3 10972.7 10999.5 11349.1 750.0 752.3 758.3 776.2 801.8 4704.3 4808.7 4813.3 4845.8 4901.7 78440.6 78521.6 80723.2 81978.0 84537.0 70932.3 70985.6 71297.6 73151.3 73719.3 61955.4 62036.7 62065.4 62276.7 62807.4 9176.9 9243.8 9290.7 9375.2 9470.1 37475.3 37502.8 45036.0 45394.3 46084.3 52353.0 53396.2 53539.5 55871.4 57705.4 14213.9 14545.2 14638.3 14652.3 14794.9 16241.6 16258.6 16320.8 16332.4 16498.3 15202.2 15608.7 15646.5 16139.2 16608.1 14690.2 14722.6 14897.7 14938.9 15033.9 14711.2 14738.2 14780.8 14938.9 14941.3 12539.2 12709.2 12943.5 13271.1 13448.1 11437.2 11527.6 11619.7 11653.2 11893.5 20:11:33 INFO - PROCESS | 22023 | -------- Summary: end -------- 20:11:33 INFO - PROCESS | 22023 | 20:11:34 INFO - TEST-INFO | 22023: exit 0 20:11:34 INFO - TEST-OK | dromaeo_css | took 1112899ms 20:11:34 INFO - TEST-START | kraken 20:11:34 INFO - operating with platform_type : linux_ 20:11:34 INFO - Initialising browser for kraken test... 20:11:34 INFO - TEST-INFO | started process 22339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnuMaYy/profile http://localhost:44780/getInfo.html) 20:11:38 INFO - PROCESS | 22339 | __metrics Screen width/height:1600/1200 20:11:38 INFO - PROCESS | 22339 | colorDepth:24 20:11:38 INFO - PROCESS | 22339 | Browser inner width/height: 1024/697 20:11:38 INFO - PROCESS | 22339 | __metrics 20:11:38 INFO - PROCESS | 22339 | 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" 20:11:38 INFO - PROCESS | 22339 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:11:39 INFO - TEST-INFO | 22339: exit 0 20:11:39 INFO - Browser initialized. 20:11:39 INFO - Running cycle 1/1 for kraken test... 20:11:39 INFO - TEST-INFO | started process 22432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnuMaYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:51 INFO - PROCESS | 22432 | RSS: Main: 137900032 20:11:51 INFO - PROCESS | 22432 | 20:11:54 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44780/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:55 INFO - PROCESS | 22432 | RSS: Main: 181850112 20:11:55 INFO - PROCESS | 22432 | 20:11:57 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44780/tests/kraken/driver.html?testName=audio-dft) 20:11:58 INFO - PROCESS | 22432 | RSS: Main: 172249088 20:11:58 INFO - PROCESS | 22432 | 20:12:01 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44780/tests/kraken/driver.html?testName=audio-fft) 20:12:01 INFO - PROCESS | 22432 | RSS: Main: 263663616 20:12:01 INFO - PROCESS | 22432 | 20:12:03 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44780/tests/kraken/driver.html?testName=audio-oscillator) 20:12:04 INFO - PROCESS | 22432 | RSS: Main: 169848832 20:12:04 INFO - PROCESS | 22432 | 20:12:06 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:12:07 INFO - PROCESS | 22432 | RSS: Main: 172130304 20:12:07 INFO - PROCESS | 22432 | 20:12:10 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44780/tests/kraken/driver.html?testName=imaging-darkroom) 20:12:10 INFO - PROCESS | 22432 | RSS: Main: 211349504 20:12:10 INFO - PROCESS | 22432 | 20:12:14 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44780/tests/kraken/driver.html?testName=imaging-desaturate) 20:12:14 INFO - PROCESS | 22432 | RSS: Main: 209903616 20:12:14 INFO - PROCESS | 22432 | 20:12:17 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44780/tests/kraken/driver.html?testName=json-parse-financial) 20:12:18 INFO - PROCESS | 22432 | RSS: Main: 208252928 20:12:18 INFO - PROCESS | 22432 | 20:12:19 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:12:20 INFO - PROCESS | 22432 | RSS: Main: 170872832 20:12:20 INFO - PROCESS | 22432 | 20:12:21 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44780/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:12:22 INFO - PROCESS | 22432 | RSS: Main: 177479680 20:12:22 INFO - PROCESS | 22432 | 20:12:24 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:12:25 INFO - PROCESS | 22432 | RSS: Main: 186257408 20:12:25 INFO - PROCESS | 22432 | 20:12:27 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:12:28 INFO - PROCESS | 22432 | RSS: Main: 195883008 20:12:28 INFO - PROCESS | 22432 | 20:12:31 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:12:31 INFO - PROCESS | 22432 | RSS: Main: 192319488 20:12:31 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | Cycle 1(1): loaded http://localhost:44780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44780/tests/kraken/driver.html?testName=ai-astar) 20:12:33 INFO - PROCESS | 22432 | RSS: Main: 244490240 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | __start_tp_report 20:12:33 INFO - PROCESS | 22432 | _x_x_mozilla_page_load 20:12:33 INFO - PROCESS | 22432 | _x_x_mozilla_page_load_details 20:12:33 INFO - PROCESS | 22432 | |i|pagename|runs| 20:12:33 INFO - PROCESS | 22432 | |0;ai-astar;110;113;114;113;114;113;113;113;112;111 20:12:33 INFO - PROCESS | 22432 | |1;audio-beat-detection;154;118;119;152;121;120;118;119;135;121 20:12:33 INFO - PROCESS | 22432 | |2;audio-dft;161;161;162;161;161;163;161;162;160;161 20:12:33 INFO - PROCESS | 22432 | |3;audio-fft;76;75;78;115;76;76;75;76;93;77 20:12:33 INFO - PROCESS | 22432 | |4;audio-oscillator;84;83;98;83;83;83;97;83;82;108 20:12:33 INFO - PROCESS | 22432 | |5;imaging-gaussian-blur;118;118;118;118;117;116;118;116;117;117 20:12:33 INFO - PROCESS | 22432 | |6;imaging-darkroom;147;148;147;147;147;148;147;147;148;147 20:12:33 INFO - PROCESS | 22432 | |7;imaging-desaturate;97;96;96;96;95;96;96;96;96;96 20:12:33 INFO - PROCESS | 22432 | |8;json-parse-financial;49;50;50;49;50;49;51;50;51;50 20:12:33 INFO - PROCESS | 22432 | |9;json-stringify-tinderbox;66;65;64;66;66;65;65;66;64;65 20:12:33 INFO - PROCESS | 22432 | |10;stanford-crypto-aes;77;78;76;79;78;77;82;76;76;76 20:12:33 INFO - PROCESS | 22432 | |11;stanford-crypto-ccm;124;133;123;123;127;121;121;130;174;121 20:12:33 INFO - PROCESS | 22432 | |12;stanford-crypto-pbkdf2;161;161;160;162;162;165;161;164;159;165 20:12:33 INFO - PROCESS | 22432 | |13;stanford-crypto-sha256-iterative;62;62;61;71;61;63;64;64;61;59 20:12:33 INFO - PROCESS | 22432 | __end_tp_report 20:12:33 INFO - PROCESS | 22432 | __start_cc_report 20:12:33 INFO - PROCESS | 22432 | _x_x_mozilla_cycle_collect,1565 20:12:33 INFO - PROCESS | 22432 | __end_cc_report 20:12:33 INFO - PROCESS | 22432 | __startTimestamp1486699953632__endTimestamp 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | ------- Summary: start ------- 20:12:33 INFO - PROCESS | 22432 | Number of tests: 14 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.26 (1.1%) stddev-sans-first:0.93 20:12:33 INFO - PROCESS | 22432 | Values: 110.0 113.0 114.0 113.0 114.0 113.0 113.0 113.0 112.0 111.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:121.00 stddev:14.24 (11.8%) stddev-sans-first:11.49 20:12:33 INFO - PROCESS | 22432 | Values: 154.0 118.0 119.0 152.0 121.0 120.0 118.0 119.0 135.0 121.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 20:12:33 INFO - PROCESS | 22432 | Values: 161.0 161.0 162.0 161.0 161.0 163.0 161.0 162.0 160.0 161.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.88 (16.9%) stddev-sans-first:13.49 20:12:33 INFO - PROCESS | 22432 | Values: 76.0 75.0 78.0 115.0 76.0 76.0 75.0 76.0 93.0 77.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:83.00 stddev:9.17 (11.0%) stddev-sans-first:9.58 20:12:33 INFO - PROCESS | 22432 | Values: 84.0 83.0 98.0 83.0 83.0 83.0 97.0 83.0 82.0 108.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 20:12:33 INFO - PROCESS | 22432 | Values: 118.0 118.0 118.0 118.0 117.0 116.0 118.0 116.0 117.0 117.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:12:33 INFO - PROCESS | 22432 | Values: 147.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 20:12:33 INFO - PROCESS | 22432 | Values: 97.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.74 (1.5%) stddev-sans-first:0.71 20:12:33 INFO - PROCESS | 22432 | Values: 49.0 50.0 50.0 49.0 50.0 49.0 51.0 50.0 51.0 50.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 20:12:33 INFO - PROCESS | 22432 | Values: 66.0 65.0 64.0 66.0 66.0 65.0 65.0 66.0 64.0 65.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.50 stddev:1.90 (2.5%) stddev-sans-first:2.01 20:12:33 INFO - PROCESS | 22432 | Values: 77.0 78.0 76.0 79.0 78.0 77.0 82.0 76.0 76.0 76.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:125.50 stddev:16.09 (12.8%) stddev-sans-first:16.93 20:12:33 INFO - PROCESS | 22432 | Values: 124.0 133.0 123.0 123.0 127.0 121.0 121.0 130.0 174.0 121.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.00 stddev:2.05 (1.3%) stddev-sans-first:2.15 20:12:33 INFO - PROCESS | 22432 | Values: 161.0 161.0 160.0 162.0 162.0 165.0 161.0 164.0 159.0 165.0 20:12:33 INFO - PROCESS | 22432 | 20:12:33 INFO - PROCESS | 22432 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:3.26 (5.2%) stddev-sans-first:3.44 20:12:33 INFO - PROCESS | 22432 | Values: 62.0 62.0 61.0 71.0 61.0 63.0 64.0 64.0 61.0 59.0 20:12:33 INFO - PROCESS | 22432 | -------- Summary: end -------- 20:12:33 INFO - PROCESS | 22432 | 20:12:34 INFO - TEST-INFO | 22432: exit 0 20:12:34 INFO - TEST-OK | kraken | took 60119ms 20:12:34 INFO - SUITE-END | took 1173s 20:12:34 INFO - Completed test suite (00:19:33) 20:12:34 INFO - javascript benchmark 20:12:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.6946040126186, 3236.514522821578, 3261.59230096238, 3265.7224135948445, 3274.132354925945, 5328.786848526064, 5333.653312534682, 5354.464553544649, 5367.677939323634, 5427.294451721271, 5400.054990376678, 5430.348358197012, 5446.591505637083, 5447.0, 5447.046766815811, 4962.181240095389, 5017.573506251954, 5017.974910125445, 5037.219231019198, 5071.847844564669, 4902.0931127741305, 4993.675411098285, 5045.722485263309, 5051.166557518005, 5088.720120393377, 4878.780454879521, 4893.755312234392, 4938.333325001133, 4982.302477653131, 5022.17134172861, 5025.798968041274, 5061.873453163664, 5070.5690016348835, 5074.720890351029, 5104.4640312767, 4818.180909245437, 4872.756362181876, 4968.329275547827, 4989.301497790312, 5055.823046193365, 5292.126799078147, 5360.544353729938, 5375.3280839895015, 5390.272313237741, 5440.129579267338, 5835.299764028344, 5848.122781582797, 5848.912266316009, 5852.736626851802, 5861.2087368205175, 5659.122835960433, 5818.766445479683, 5883.029300165467, 5885.823425297248, 5886.911696324559, 5341.305630268041, 5370.7046112463795, 5408.215808707715, 5423.376311724123, 5489.204065410573, 5897.557683173779, 5901.0558310670085, 5911.231539899785, 5912.674802885883, 5918.408159184047, 5708.229389032511, 5710.0, 5718.7426565804635, 5725.055365864669, 5728.77084916607, 5648.689322087324, 5681.630694004876, 5753.626014309057, 5757.884842303214, 5785.4214578541805, 5824.592278540546, 5826.388229235869, 5827.79602713903, 5830.883382332329, 5858.091995740667, 5781.103928891029, 5827.679477628686, 5839.386864379264, 5843.970780146072, 5849.707514624251, 4413.801378937956, 4468.50846406895, 4482.327650852333, 4486.327050942385, 4515.096980603892, 4022.3162062449455, 4028.4762980812307, 4047.777372244496, 4055.7160998730396, 4066.2274167908004, 5683.204351390808, 5688.146777983336, 5690.658560486384, 5695.0, 5696.11710184922, 5715.942840571541, 5758.625689330264, 5781.71091445426, 5824.737886795105, 5825.24271844666, 5648.124540696199, 5676.403977582377, 5679.148127780866, 5679.346875109415, 5701.600887937888, 4982.377202849644, 4991.201407774739, 4993.325901003318, 4994.150994330972, 5026.09530284545, 5876.500497457679, 5919.378465261172, 5929.881402371929, 5963.135345374983, 6032.879342413127, 5830.0, 5832.854178645568, 5847.678377689268, 5853.64878107315, 5871.0, 5968.910466342922, 6014.6391216527145, 6021.126936594257, 6021.337652858269, 6029.57792954489, 5638.351589567088, 5683.77264909399, 5705.2297939779255, 5744.3681195067675, 5745.511631511368, 5790.478856902899, 5857.619254748428, 5860.09168578871, 5886.911696324473, 5907.2911250650195, 5719.542436604978, 5720.027595308724, 5730.369659337386, 5732.598718089694, 5733.71331433435, 5545.694986775766, 5558.499735023867, 5682.176084467812, 5700.030994730989, 5707.771689132388, 5589.832305030855, 5632.943670563406, 5642.069058605284, 5675.943240567542, 5704.344000440003, 5622.409646987171, 5673.007223735913, 5703.914441283301, 5707.229524014205, 5711.400302968129, 5474.2609747683555, 5590.0, 5590.86022849432, 5592.944070559242, 5598.272224610774], "value": 5380.408597090183, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.1105944678944, 586.6802592587039, 607.3926073926075, 631.712570780295, 632.1686981619167, 48149.51850481494, 48990.0, 49004.50995490044, 49020.509794902086, 53693.46306536933, 49387.75306123473, 49579.25631115536, 49920.251196232086, 49951.750241248745, 50019.99960000798, 8517.0, 9388.155066044055, 9593.520323983808, 9595.136437720605, 9596.32825702201, 8546.05993340732, 11140.944295278512, 11469.0, 11483.885161148366, 11850.407479626027, 11514.942425287862, 11566.132540059487, 11578.884211157907, 11590.478428470697, 11592.710182245428, 11319.151063670217, 11392.886071139306, 11394.54421823126, 11407.372594507298, 11419.885801142049, 11297.209195356329, 11359.943200283946, 11364.261323013978, 11372.601958931398, 11377.829332560019, 46671.53328466706, 46815.531844681456, 46923.0, 46968.5303146971, 47025.29462058072, 4419.292913133883, 4482.798274077674, 4531.977340113312, 4624.907501849944, 4668.346431499593, 34173.0, 34321.828390858136, 34434.311313773585, 34703.132421689406, 36461.81769091164, 4600.079984003212, 4642.466116396624, 4698.859034228979, 4723.433188017426, 4752.738599377033, 349803.0, 483487.0, 487147.0, 487323.99999999645, 489272.0, 62464.68767656224, 63194.0, 63196.0, 63272.36727632757, 63311.6834415825, 65642.34357656362, 66282.0, 66314.33685663178, 66441.6677916617, 66443.0, 18861.52846178829, 19210.231590736494, 19211.231550737815, 19237.326693565657, 19347.12937917797, 12926.547570834975, 13341.19952802835, 13489.932550337186, 13498.122622029732, 14572.489962851248, 19445.805541944683, 19895.80625162495, 20215.797842021686, 20256.29102981418, 20282.29011984603, 7500.36246919007, 7506.211847756016, 7534.171241163468, 7562.281583249583, 7669.38644908406, 965.5027660754716, 979.8285300072602, 983.0513554420019, 984.3798407003685, 1010.8989101089979, 33061.17347066342, 33915.66084339174, 34414.139646508534, 34742.47886281708, 34797.652023479444, 1096.6326280695896, 1150.5167829511458, 1163.03468121459, 1174.8061569840881, 1180.6635108993896, 17844.107794610216, 17904.91047544754, 17967.910160449115, 18080.457586272434, 18160.0, 546533.0, 548601.0, 550764.0, 550922.0, 551846.0, 68917.65541172362, 69449.0, 69508.0, 69613.0, 69677.65161174162, 1492.5671555249073, 1517.7192219439219, 1547.636305468214, 1549.4189678870423, 1556.5096994446712, 32375.190620234684, 33668.83165584156, 34046.48930266098, 34306.0, 34561.0, 58825.70587147037, 59593.70203148956, 59711.701441492514, 59758.0, 59793.402065978786, 406218.0, 407215.0, 408015.0, 408037.0, 408927.0, 28498.715012850436, 29584.112476625734, 29885.103446896628, 31111.688883111783, 31963.680363197, 51793.482065180375, 52167.47832521778, 52176.47823521868, 52305.47694523158, 53083.95702408265, 43075.0, 43219.78390108155, 43563.0, 43691.0, 45390.54609453863, 41441.0, 42213.78893105515, 42413.78793106015, 43206.783966081224, 44758.77620611876, 41932.161356772085, 42257.78871105625, 42864.0, 43122.353164703185, 43577.78211108924, 35180.472292916136, 37574.62425375821, 37784.0, 37843.432348514245, 38409.807950960065, 27968.160955171377, 28188.577171342036, 28329.71670283353, 28532.42935141327, 28541.143765687062], "value": 22141.628830335227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.95858393452653, 441.81664609187186, 444.6131865277209, 446.6761597841563, 455.3238440915242, 20493.077811498482, 21286.787132128673, 22389.55220895581, 22523.887380563094, 22593.774062259374, 22548.88725556374, 22783.31650050497, 23112.0, 23113.0, 23288.534229315446, 6009.909851352233, 6020.187274717911, 6216.906746398785, 6284.622922624657, 6292.056191571278, 6060.363661815512, 6270.3729627037155, 6284.5600807943465, 6285.0, 6321.178246827906, 6150.969245153768, 6266.592671476339, 6335.11308416822, 6338.176037115169, 6440.259370172444, 6375.011873159668, 6412.903806442907, 6418.326075762047, 6427.646479443629, 6429.742810287583, 5583.05088135018, 5807.506361959238, 5851.297844258716, 5899.793507227227, 5921.881562368729, 15304.464343748026, 15306.923465382713, 15384.846151538453, 15474.767878481833, 15525.534233973, 2776.9166924992282, 2777.8611069446647, 2782.833030018185, 2793.2178989882864, 2793.7345952134515, 10832.295900766425, 11077.556897724082, 11287.548498060069, 12912.935435322857, 15190.544283671508, 1929.1962015515537, 2034.6947957806299, 2037.3073155127329, 2061.2167376397024, 2079.511314841011, 94004.0, 94452.52773736087, 94708.0, 95838.52080739621, 98757.55590998351, 12364.814527782091, 12407.689807754878, 12643.367831608382, 12944.870551294554, 12986.935065324802, 18465.81534184641, 18468.076596170136, 18470.630587388176, 18482.630347392977, 18489.81510184881, 8911.50986695738, 8992.100789920956, 9011.098890110936, 9057.230135438429, 9183.908160918305, 8329.08380078191, 8346.8330633387, 8362.79093022667, 8542.658293668184, 8553.0, 5482.725863706799, 5527.917081243784, 5565.582581306418, 5593.133064375028, 5648.039833228361, 2200.2519143490968, 2219.7003404540505, 2222.7443843958154, 2334.2763743239652, 2343.55472460232, 1119.972000699989, 1136.0, 1141.2068612314363, 1147.2829481574017, 1170.0990237517065, 20526.178952841718, 20674.58650826975, 21015.264465743625, 21045.368638940858, 21203.15187392487, 1115.760111576015, 1126.7408496045955, 1131.688785583971, 1134.4724703012973, 1146.031603295231, 11637.825432618349, 11784.469698863571, 11825.822612660817, 11854.88145118555, 11884.0, 601358.0, 650603.0, 671090.0, 684065.0, 687773.0, 97649.51175244221, 99732.50133749285, 102200.0, 105582.47208763906, 107541.0, 1144.7653231087606, 1175.1538891997577, 1189.084405008139, 1194.5580135349803, 1199.3763243113533, 19140.617187656448, 19496.31762888292, 19498.0, 19660.115294811483, 19694.31069912546, 45635.54364456313, 45704.54295457003, 45846.0, 47317.29024064573, 48426.01085851616, 62629.0, 66270.66864665646, 66448.66775666284, 67768.6611566939, 69266.0, 9521.0, 9709.854352184582, 9729.881063677485, 9781.559829807818, 9848.458334791369, 11488.770224595628, 14384.712305753617, 14399.856001439852, 14413.927930360282, 14463.0, 10626.203034772578, 11498.94250528742, 11961.564612246586, 12112.091593130726, 12776.10567260283, 7648.235176482307, 7978.521288722695, 12360.25838449696, 12513.687157821127, 12714.427850746924, 12174.513019479122, 12320.876791231973, 12518.061145413949, 12699.174553653984, 13068.346582671018, 9299.76750581241, 9568.904310956801, 9644.565994530123, 9659.565319560777, 9702.0, 10647.733806654896, 11696.70758231051, 11759.529618815493, 11781.352025638673, 12046.156769026084], "value": 10144.366376195074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.9320033998297, 1500.137420982935, 1500.2798656644804, 1500.5348342013976, 1516.5071351810664, 7780.221977802217, 8420.873686894694, 8706.912930870689, 8707.608157632905, 8795.91204087959, 8494.660213591449, 8638.265747411462, 8639.092895246004, 8823.647054117828, 8846.380753347268, 2076.3978446250644, 2136.8824714640687, 2434.111549284516, 2484.689413823272, 2485.9129930452436, 2424.35754525051, 2508.5484612769787, 2508.623706444039, 2519.59686450168, 2522.8990840366364, 2445.364205306615, 2458.1150785717127, 2458.43456005118, 2461.913833015845, 2476.9968162893965, 2469.715982661999, 2511.3847107458605, 2526.1916186820226, 2528.7471252874657, 2536.5307418127704, 2493.875306234699, 2509.1218073674067, 2511.660925775015, 2517.5720127578356, 2517.6097704855592, 8635.0, 8695.130486951255, 8744.344174186897, 8843.823123537493, 8954.41796283246, 5410.783568657249, 5549.112142057252, 5550.91673624896, 5553.527950124244, 5554.444555544454, 3160.5417214504, 3300.85146168423, 3412.795232286046, 3445.3453843769603, 3454.6372630873648, 1341.6377578053969, 1380.5168191133123, 1405.4659229492727, 1410.7672234081365, 1424.9643758906006, 11413.942930285295, 11447.656570302905, 11505.654830355103, 11523.59667411645, 11556.0, 4443.2224360736745, 4742.596879265232, 4757.690750101232, 4852.2479015752615, 4856.247281671346, 10421.895781042243, 10449.791004179873, 10450.529726162342, 10489.790204195873, 10555.47222638865, 5412.729363531807, 5455.945440545624, 5456.672599644034, 5461.453854614507, 5467.097928841776, 4882.633802464829, 4888.9755551222015, 5031.723255220998, 5042.924356134661, 5100.566451851634, 4244.469441319835, 4286.61420472159, 4301.591348821857, 4354.804033818486, 4395.868123956287, 1368.3910659756314, 1405.086693649116, 1405.5853523210678, 1413.6819215676392, 1424.7577911755027, 985.2561316206219, 1006.174936552035, 1020.0666390252984, 1023.8873723890366, 1028.5217373921162, 5716.342620598684, 5905.084711869667, 5919.852003699942, 6078.848028799227, 6109.694515274218, 647.5402464250341, 661.5137873662854, 664.7839452178061, 670.8389986403325, 672.4721093941232, 4007.4189242560246, 4102.835886564504, 4160.251154792106, 4189.392538082022, 4217.641500472433, 10205.285630005828, 10741.570337186426, 10752.354858708346, 10757.731056723644, 10760.300580462244, 10493.317934334244, 10604.575816967235, 10605.522751476203, 10627.628033018807, 10637.202209834293, 8047.919520804717, 8184.2224988625985, 8252.752417427366, 8270.172982701682, 8280.296174825207, 5836.678982655994, 5881.411858814085, 5993.790217342372, 6004.939950600613, 6063.72713227897, 9212.677556285498, 9227.3079519035, 9231.676891308773, 9462.858057129011, 9470.052994700474, 8671.783205419915, 9542.522873856418, 9685.128338449573, 9727.367721098106, 9798.363106398061, 7083.795754721813, 7463.701451941862, 7635.0, 7753.612319384121, 7875.960620196863, 8288.0, 8316.126806685212, 8365.832683346422, 8458.281046110904, 8498.74503764888, 7495.213002634863, 7574.886376704464, 7580.658870350737, 7590.39276857839, 7637.083549974039, 7384.37232835215, 7421.925780742339, 7487.6630551626395, 7594.848103038019, 7652.61736913141, 6580.868382632225, 6713.261541230363, 6840.452763778985, 6850.0409942607075, 6914.792556223321, 5106.4893510648635, 5182.263941579613, 5221.537969368583, 5308.0, 5327.9467205329, 5039.722815245197, 5049.394072711299, 5050.141475949024, 5110.97444512775, 5202.0], "value": 4653.122686213267, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.5356616673907, 410.2695916087511, 417.3864419303624, 427.67496702506094, 432.23494414885675, 5179.896402071956, 5228.29418028566, 5262.394969534291, 5274.077036518613, 5276.788928442863, 4950.480199579038, 5049.636598118505, 5068.8225912093085, 5157.896842063156, 5185.833187532803, 4249.383839343293, 4254.383114448396, 4257.467816522934, 4260.850870219543, 4273.850415235467, 4284.378765079062, 4285.44289242398, 4290.0, 4296.226679197744, 4303.7848107594655, 3965.286248475273, 4089.5092588889224, 4246.617804397603, 4249.745015299092, 4293.076988447483, 4197.538270790211, 4221.831126754926, 4249.6387807036435, 4266.210751011057, 4270.295401258789, 3858.4791053207737, 3861.4787003754413, 3872.1539668343744, 3884.3008258513455, 3906.226579128822, 4997.925031124536, 5010.624203184776, 5038.420581633122, 5084.389873215201, 5166.767495462713, 4766.928496072562, 4792.832250871203, 4810.186041165922, 4815.0, 4833.7583120844165, 5460.071787796084, 5463.617546771728, 5483.7806487740445, 5506.229127922094, 5532.834014979517, 4191.811368488426, 4235.49174099107, 4269.231538323101, 4276.657867370603, 4306.784660766949, 5462.508374246337, 5616.269884914935, 5643.802466913679, 5666.971665141689, 5667.489925906688, 4334.739915605074, 4354.716943398669, 4372.453443319585, 4393.890152746143, 4404.295312750009, 4323.7621930793475, 4361.669690744354, 4390.209762242827, 4428.889277768081, 4435.469762931783, 4822.132016237111, 4837.637177211653, 4841.0, 4853.733044682576, 4876.853694389174, 5530.529904958124, 5535.391106978229, 5548.55611551075, 5592.120058170046, 5596.0, 1466.633341664584, 1471.3599584180915, 1485.576610665955, 1500.6173425776576, 1505.3903169216485, 1038.8441733739999, 1049.7952899184586, 1068.8557044799009, 1099.4063205868902, 1100.6863044032411, 5241.554467870197, 5247.291615631917, 5247.501487358695, 5251.264822924793, 5258.947410525846, 5428.37573679032, 5462.562994960394, 5466.262054622654, 5469.371022332482, 5480.972595136999, 4991.201407774739, 5150.381954165449, 5178.326817513699, 5228.901930594541, 5230.8169214077325, 2856.643094530123, 2871.535516886403, 2882.2506148401567, 2887.870045847942, 2891.3638999420095, 5475.479829416199, 5615.0454422748235, 5645.9717701412055, 5646.322441307069, 5675.914861277084, 5480.561555075585, 5492.340919089655, 5505.642133261325, 5505.6696598204235, 5512.200730894078, 5608.85977850557, 5610.438956104357, 5619.381867994517, 5652.378238393856, 5676.574256930664, 5244.76398562058, 5342.679439233659, 5427.48438898304, 5443.149329228081, 5485.753141108739, 5427.565794736491, 5433.239346491573, 5433.293671822637, 5447.863803404946, 5448.373437054631, 5512.476314750093, 5670.319561652628, 5701.344345400332, 5702.8024114936325, 5712.200291959046, 4186.413902053776, 4219.915601688011, 4228.5388914695295, 4231.746095234173, 4234.703570750018, 5373.570114390917, 5411.729413529387, 5416.160495123262, 5424.830067972843, 5510.228568000563, 5063.885006987334, 5300.867478313073, 5334.826338205588, 5358.097875254384, 5364.678119312854, 5270.075108314922, 5282.709450980233, 5293.867653308698, 5294.655847369909, 5300.9133127707955, 5172.922406163986, 5287.656302340336, 5293.311869456946, 5309.389420216725, 5328.374845672107, 5319.813806516753, 5473.507384335429, 5488.231647569423, 5509.146082357241, 5524.58565607573, 5320.707361095022, 5324.0, 5354.678719276856, 5369.48989845964, 5390.326209223847], "value": 4257.2595290227955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.3910436724641, 838.6561509780984, 852.7868032991752, 911.2205193361393, 920.9769755756105, 14429.567112986613, 15169.696606067871, 15180.31688574014, 15191.088534687913, 16290.26693798779, 15882.444114455997, 16049.0, 16069.437569685064, 16093.517194484155, 16096.356145754156, 682.1473158551822, 702.0, 787.8857565653005, 809.550699361854, 810.3800592546706, 816.995915020424, 817.9468334558235, 818.5825229133155, 818.7748369198488, 818.8526065308242, 845.5983407881268, 861.8190180062195, 862.288611895189, 862.7325529085972, 863.2791618998144, 716.9498135130543, 734.5996431944576, 810.3922058456158, 829.0424559633573, 850.9361797865154, 620.4509009526556, 620.6772478311298, 620.8913440147955, 621.1056079245872, 622.6730966242759, 14473.986820922539, 14479.05886117399, 14492.927535362362, 14537.0, 14949.551513454506, 14590.197539135343, 15095.32071056805, 15245.771313430307, 15428.537143885702, 15654.45209417665, 13964.162150271017, 14037.508687196001, 14058.859411405858, 14202.573922782332, 14409.71180576393, 4530.229860923618, 4590.08198360326, 4591.4260717410325, 4630.189716799547, 4672.766361681936, 72716.27283727148, 73454.0, 74474.0, 74621.0, 74679.62660186719, 11907.226030308002, 11930.3438310892, 11956.461959211856, 12004.939975300067, 12077.154599177973, 23167.768322316897, 23304.184353547884, 23378.883105584362, 23591.646125308132, 23755.643665345033, 8442.62008209632, 8527.786805329917, 8535.061143274235, 8546.13686097062, 8661.13388661129, 4689.60138388234, 4733.881652958635, 4747.430308362949, 4816.253480710496, 4857.0, 3643.4534819776713, 3680.0431887709387, 3725.161838586296, 3725.4784330193793, 3748.2878253131817, 583.5652438933022, 583.5944018906819, 584.400988986284, 594.4501336263938, 595.76765061626, 725.3045190528488, 739.1684355100512, 759.1156302907161, 790.4585359029084, 797.57728403946, 10685.732856678645, 10848.349099054081, 10972.670819875417, 10999.450027498593, 11349.148813838996, 749.966251518672, 752.3078767533773, 758.332667252825, 776.2121446731572, 801.8436404900988, 4704.270838020112, 4808.663393562417, 4813.28378774993, 4845.806167753321, 4901.705897646153, 78440.60779696179, 78521.60739196268, 80723.19276807274, 81978.0, 84537.0, 70932.2906770936, 70985.64507177535, 71297.64351178211, 73151.26848731551, 73719.26280737232, 61955.38044619496, 62036.68981655063, 62065.37934620596, 62276.688616557534, 62807.37192628015, 9176.908230917605, 9243.815123697623, 9290.72127836166, 9375.249980001447, 9470.14768670823, 37475.25049499049, 37502.81248593739, 45036.0, 45394.31908521309, 46084.30873536967, 52353.0, 53396.1990570134, 53539.464605353445, 55871.441285586625, 57705.422945770006, 14213.857861421253, 14545.200013999332, 14638.341274642453, 14652.340644671229, 14794.852051479347, 16241.59396015109, 16258.593535161715, 16320.755188671941, 16332.428365007643, 16498.25757840876, 15202.239888005777, 15608.687826243638, 15646.452374166849, 16139.1930403477, 16608.086555239577, 14690.192039437934, 14722.55832325032, 14897.702045958804, 14938.925305373403, 15033.924830375778, 14711.190884501455, 14738.215852996358, 14780.778288325899, 14938.925305373403, 14941.252937353307, 12539.24764514132, 12709.17390369623, 12943.482260709843, 13271.137376070525, 13448.055450132708, 11437.199396042197, 11527.596534121602, 11619.709507262387, 11653.242539234923, 11893.524259029888], "value": 7572.377422348811, "unit": "score"}], "name": "dromaeo_css", "value": 7523.172432131876, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 112.0, 111.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 118.0, 119.0, 152.0, 121.0, 120.0, 118.0, 119.0, 135.0, 121.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 163.0, 161.0, 162.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 115.0, 76.0, 76.0, 75.0, 76.0, 93.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 98.0, 83.0, 83.0, 83.0, 97.0, 83.0, 82.0, 108.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 116.0, 118.0, 116.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 50.0, 49.0, 50.0, 49.0, 51.0, 50.0, 51.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 66.0, 66.0, 65.0, 65.0, 66.0, 64.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 79.0, 78.0, 77.0, 82.0, 76.0, 76.0, 76.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 133.0, 123.0, 123.0, 127.0, 121.0, 121.0, 130.0, 174.0, 121.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 162.0, 165.0, 161.0, 164.0, 159.0, 165.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 71.0, 61.0, 63.0, 64.0, 64.0, 61.0, 59.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1479.3999999999999, "alertThreshold": 2.0}]} 20:12:34 INFO - Return code: 0 20:12:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:12:34 ERROR - # TBPL SUCCESS # 20:12:34 INFO - Running post-action listener: _resource_record_post_action 20:12:34 INFO - [mozharness: 2017-02-10 04:12:34.923060Z] Finished run-tests step (success) 20:12:34 INFO - Running post-run listener: _resource_record_post_run 20:12:35 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 373964800; Read time: 4; Write time: 235140 20:12:35 INFO - TinderboxPrint: CPU usage
13.1% 20:12:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 20:12:35 INFO - TinderboxPrint: I/O write bytes / time
373,964,800 / 235,140 20:12:35 INFO - TinderboxPrint: CPU idle
8,252.9 (86.9%) 20:12:35 INFO - TinderboxPrint: CPU user
1,195.9 (12.6%) 20:12:35 INFO - TinderboxPrint: Swap in / out
0 / 0 20:12:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117972992; Read time: 0; Write time: 85352 20:12:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255991808; Read time: 4; Write time: 149788 20:12:35 INFO - Running post-run listener: _upload_blobber_files 20:12:35 INFO - Blob upload gear active. 20:12:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:12: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 20:12: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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:12: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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:12:35 INFO - (blobuploader) - INFO - Open directory for files ... 20:12:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:12:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:12:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:36 INFO - (blobuploader) - INFO - Done attempting. 20:12:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:12:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:39 INFO - (blobuploader) - INFO - Done attempting. 20:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:12:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:40 INFO - (blobuploader) - INFO - Done attempting. 20:12:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:12:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:12:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:41 INFO - (blobuploader) - INFO - Done attempting. 20:12:41 INFO - (blobuploader) - INFO - Iteration through files over. 20:12:41 INFO - Return code: 0 20:12:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:12:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:12:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db8aac0d0d286b808d66683562f9af1f88b3cab56572bc84621eb79cecfee9f3a0cedba3bb9b3b6d0f175d3dd39497a8b7b5c82524a4c59c75d4d0eec8e58b08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/601c579f6ff7d2162325957e763bfaca05aff14e9946181151615c87dfd3cb8243089255da1d8a333b93eebf41f2c2dd8c33d2f2ed768f81fe5b3052021663da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8841ece6dbd6088eec9c2d2ca31d1022b7707de213d37447a1f8dda9ba3af6054ec703196017ae3108865f027e49f35e9cf1556b4f0db345b88576a05cffe21e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71d430302b68380eb8038798d75c0ef71c83d633757e7025f36c462f77cced4c9865111da0e0ece064cb814dc85fcff6ac39a9937c74833d916af162c5b2da98"} 20:12:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:12:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:12:41 INFO - Contents: 20:12:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db8aac0d0d286b808d66683562f9af1f88b3cab56572bc84621eb79cecfee9f3a0cedba3bb9b3b6d0f175d3dd39497a8b7b5c82524a4c59c75d4d0eec8e58b08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/601c579f6ff7d2162325957e763bfaca05aff14e9946181151615c87dfd3cb8243089255da1d8a333b93eebf41f2c2dd8c33d2f2ed768f81fe5b3052021663da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8841ece6dbd6088eec9c2d2ca31d1022b7707de213d37447a1f8dda9ba3af6054ec703196017ae3108865f027e49f35e9cf1556b4f0db345b88576a05cffe21e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71d430302b68380eb8038798d75c0ef71c83d633757e7025f36c462f77cced4c9865111da0e0ece064cb814dc85fcff6ac39a9937c74833d916af162c5b2da98"} 20:12:41 INFO - Running post-run listener: copy_logs_to_upload_dir 20:12:41 INFO - Copying logs to upload dir... 20:12:41 INFO - mkdir: /builds/slave/test/build/upload/logs 20:12:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.375784 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-09 20:12:41.193117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 20:12:41.198049) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db8aac0d0d286b808d66683562f9af1f88b3cab56572bc84621eb79cecfee9f3a0cedba3bb9b3b6d0f175d3dd39497a8b7b5c82524a4c59c75d4d0eec8e58b08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/601c579f6ff7d2162325957e763bfaca05aff14e9946181151615c87dfd3cb8243089255da1d8a333b93eebf41f2c2dd8c33d2f2ed768f81fe5b3052021663da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8841ece6dbd6088eec9c2d2ca31d1022b7707de213d37447a1f8dda9ba3af6054ec703196017ae3108865f027e49f35e9cf1556b4f0db345b88576a05cffe21e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71d430302b68380eb8038798d75c0ef71c83d633757e7025f36c462f77cced4c9865111da0e0ece064cb814dc85fcff6ac39a9937c74833d916af162c5b2da98"} build_url:https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/ZzdwFyNnSGG9B6WoJ2cGww/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db8aac0d0d286b808d66683562f9af1f88b3cab56572bc84621eb79cecfee9f3a0cedba3bb9b3b6d0f175d3dd39497a8b7b5c82524a4c59c75d4d0eec8e58b08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/601c579f6ff7d2162325957e763bfaca05aff14e9946181151615c87dfd3cb8243089255da1d8a333b93eebf41f2c2dd8c33d2f2ed768f81fe5b3052021663da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8841ece6dbd6088eec9c2d2ca31d1022b7707de213d37447a1f8dda9ba3af6054ec703196017ae3108865f027e49f35e9cf1556b4f0db345b88576a05cffe21e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71d430302b68380eb8038798d75c0ef71c83d633757e7025f36c462f77cced4c9865111da0e0ece064cb814dc85fcff6ac39a9937c74833d916af162c5b2da98"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 20:12:41.226407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:12:41.226780) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1486698723.505933-2017385906 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:12:41.306552) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 20:12:41.306894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 20:12:41.307234) ========= ========= Total master_lag: 0.19 =========