builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1485995212.29 results: success (0) revision: d06f2bf30b22a04b03e2046d5c148adedd6777c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:52.289634) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:52.290098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:52.290369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:52.306482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:52.306736) ========= 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=41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-01 16:26:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2017-02-01 16:26:52 (50.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111003 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:52.431061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:52.431365) ========= 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=41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:52.480785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:52.481170) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d06f2bf30b22a04b03e2046d5c148adedd6777c1 --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 d06f2bf30b22a04b03e2046d5c148adedd6777c1 --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=41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-01 16:26:52,600 truncating revision to first 12 chars 2017-02-01 16:26:52,600 Setting DEBUG logging. 2017-02-01 16:26:52,600 attempt 1/10 2017-02-01 16:26:52,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d06f2bf30b22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 16:26:52,948 unpacking tar archive at: mozilla-aurora-d06f2bf30b22/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654470 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:53.148202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:53.148513) ========= script_repo_revision: d06f2bf30b22a04b03e2046d5c148adedd6777c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:53.148870) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:53.149147) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 16:26:53.158401) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-01 16:26:53.158661) ========= /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=41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:26:53 INFO - MultiFileLogger online at 20170201 16:26:53 in /builds/slave/test 16:26:53 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 16:26:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:26:53 INFO - {'append_to_log': False, 16:26:53 INFO - 'base_work_dir': '/builds/slave/test', 16:26:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:26:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:26:53 INFO - 'branch': 'Mozilla-Aurora', 16:26:53 INFO - 'buildbot_json_path': 'buildprops.json', 16:26:53 INFO - 'config_files': ('talos/linux_config.py',), 16:26:53 INFO - 'default_actions': ('clobber', 16:26:53 INFO - 'read-buildbot-config', 16:26:53 INFO - 'download-and-extract', 16:26:53 INFO - 'populate-webroot', 16:26:53 INFO - 'create-virtualenv', 16:26:53 INFO - 'install', 16:26:53 INFO - 'run-tests'), 16:26:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:26:53 INFO - 'download_minidump_stackwalk': True, 16:26:53 INFO - 'download_symbols': 'ondemand', 16:26:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:26:53 INFO - 'tooltool.py': '/tools/tooltool.py', 16:26:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:26:53 INFO - '/tools/misc-python/virtualenv.py')}, 16:26:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:26:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:26:53 INFO - 'installer_path': 'installer.exe', 16:26:53 INFO - 'log_level': 'info', 16:26:53 INFO - 'log_name': 'talos', 16:26:53 INFO - 'log_to_console': True, 16:26:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:26:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:26:53 INFO - 'opt_config_files': (), 16:26:53 INFO - 'pip_index': False, 16:26:53 INFO - 'sps_profile': False, 16:26:53 INFO - 'sps_profile_interval': 0, 16:26:53 INFO - 'suite': 'dromaeojs', 16:26:53 INFO - 'system_bits': '32', 16:26:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:26:53 INFO - 'title': 'talos-linux64-ix-024', 16:26:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:26:53 INFO - 'use_talos_json': True, 16:26:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:26:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:26:53 INFO - 'work_dir': 'build'} 16:26:53 INFO - [mozharness: 2017-02-02 00:26:53.374707Z] Running clobber step. 16:26:53 INFO - Running pre-action listener: _resource_record_pre_action 16:26:53 INFO - Running main action method: clobber 16:26:53 INFO - rmtree: /builds/slave/test/build 16:26:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:26:53 INFO - Running post-action listener: _resource_record_post_action 16:26:53 INFO - [mozharness: 2017-02-02 00:26:53.831293Z] Finished clobber step (success) 16:26:53 INFO - [mozharness: 2017-02-02 00:26:53.831394Z] Running read-buildbot-config step. 16:26:53 INFO - Running pre-action listener: _resource_record_pre_action 16:26:53 INFO - Running main action method: read_buildbot_config 16:26:53 INFO - Using buildbot properties: 16:26:53 INFO - { 16:26:53 INFO - "project": "", 16:26:53 INFO - "product": "firefox", 16:26:53 INFO - "who": "ryanvm@gmail.com", 16:26:53 INFO - "installer_path": "public/build/target.tar.bz2", 16:26:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:26:53 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 16:26:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:26:53 INFO - "stage_platform": "linux64-pgo", 16:26:53 INFO - "basedir": "/builds/slave/test", 16:26:53 INFO - "buildnumber": 758, 16:26:53 INFO - "platform": "ubuntu64_hw", 16:26:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:26:53 INFO - "slavebuilddir": "test", 16:26:53 INFO - "taskId": "OAD22s7oQ_2-w3IotS72EQ", 16:26:53 INFO - "branch": "mozilla-aurora", 16:26:53 INFO - "script_repo_revision": "production", 16:26:53 INFO - "revision": "d06f2bf30b22a04b03e2046d5c148adedd6777c1", 16:26:53 INFO - "slavename": "talos-linux64-ix-024", 16:26:53 INFO - "repo_path": "releases/mozilla-aurora" 16:26:53 INFO - } 16:26:53 INFO - Finding installer, test and symbols from parent task. 16:26:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OAD22s7oQ_2-w3IotS72EQ'}, attempt #1 16:26:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OAD22s7oQ_2-w3IotS72EQ'}, attempt #1 16:26:54 INFO - Task dependencies: ZEbpYNOJT4WIARNT5A0gxA 16:26:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA'}, attempt #1 16:26:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.tar.bz2 16:26:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/test_packages.json 16:26:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.crashreporter-symbols.zip 16:26:55 INFO - Running post-action listener: _resource_record_post_action 16:26:55 INFO - [mozharness: 2017-02-02 00:26:55.248164Z] Finished read-buildbot-config step (success) 16:26:55 INFO - [mozharness: 2017-02-02 00:26:55.248379Z] Running download-and-extract step. 16:26:55 INFO - Running pre-action listener: _resource_record_pre_action 16:26:55 INFO - Running main action method: download_and_extract 16:26:55 INFO - mkdir: /builds/slave/test/build/tests 16:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:26:55 INFO - trying https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.test_packages.json 16:26:55 INFO - Downloading https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:26:55 INFO - Downloaded 896 bytes. 16:26:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:26:55 INFO - Using the following test package requirements: 16:26:55 INFO - {u'common': [u'target.common.tests.zip'], 16:26:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:26:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:26:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:26:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:26:55 INFO - u'mozbase': [u'target.common.tests.zip'], 16:26:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:26:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:26:55 INFO - u'web-platform': [u'target.common.tests.zip', 16:26:55 INFO - u'target.web-platform.tests.zip'], 16:26:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:26:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:26:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.common.tests.zip 16:26:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:26:55 INFO - Fetch https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.common.tests.zip into memory 16:26:56 INFO - Expected file size: 21854135 16:26:56 INFO - Obtained file size: 21854135 16:27:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:27:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.common.tests.zip 16:27:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:27:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.common.tests.zip into memory 16:27:01 INFO - Expected file size: 21854135 16:27:01 INFO - Obtained file size: 21854135 16:27:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.talos.tests.zip 16:27:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:27:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.talos.tests.zip into memory 16:27:06 INFO - Expected file size: 14403485 16:27:06 INFO - Obtained file size: 14403485 16:27:06 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')]} 16:27:06 INFO - trying https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.tar.bz2 16:27:06 INFO - Downloading https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:27:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:27:08 INFO - Downloaded 66017035 bytes. 16:27:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.tar.bz2 16:27:08 INFO - mkdir: /builds/slave/test/properties 16:27:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:27:08 INFO - Writing to file /builds/slave/test/properties/build_url 16:27:08 INFO - Contents: 16:27:08 INFO - build_url:https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.tar.bz2 16:27:08 INFO - Running post-action listener: _resource_record_post_action 16:27:08 INFO - Running post-action listener: set_extra_try_arguments 16:27:08 INFO - [mozharness: 2017-02-02 00:27:08.136149Z] Finished download-and-extract step (success) 16:27:08 INFO - [mozharness: 2017-02-02 00:27:08.136245Z] Running populate-webroot step. 16:27:08 INFO - Running pre-action listener: _resource_record_pre_action 16:27:08 INFO - Running main action method: populate_webroot 16:27:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:27:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:27:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:27:08 INFO - '--tppagecycles', 16:27:08 INFO - '7'], 16:27:08 INFO - 'tests': ['tsvgm']}}, 16:27:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:27:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:27:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:27:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:27:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:27:08 INFO - 'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:27:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:27:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:27:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:27:08 INFO - 'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['damp', 'tps']}, 16:27:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:27:08 INFO - 'tests': ['damp', 'tps']}, 16:27:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['dromaeo_dom']}, 16:27:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:27:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['basic_compositor_video']}, 16:27:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:27:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['a11yr', 16:27:08 INFO - 'ts_paint', 16:27:08 INFO - 'tpaint', 16:27:08 INFO - 'sessionrestore', 16:27:08 INFO - 'sessionrestore_no_auto_restore', 16:27:08 INFO - 'tabpaint']}, 16:27:08 INFO - 'other-e10s': {'tests': ['a11yr', 16:27:08 INFO - 'ts_paint', 16:27:08 INFO - 'tpaint', 16:27:08 INFO - 'sessionrestore', 16:27:08 INFO - 'sessionrestore_no_auto_restore', 16:27:08 INFO - 'tabpaint']}, 16:27:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:27:08 INFO - 'ts_paint', 16:27:08 INFO - 'tpaint', 16:27:08 INFO - 'sessionrestore', 16:27:08 INFO - 'sessionrestore_no_auto_restore', 16:27:08 INFO - 'tabpaint']}, 16:27:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:27:08 INFO - 'ts_paint', 16:27:08 INFO - 'tpaint', 16:27:08 INFO - 'sessionrestore', 16:27:08 INFO - 'sessionrestore_no_auto_restore', 16:27:08 INFO - 'tabpaint']}, 16:27:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['a11yr', 16:27:08 INFO - 'ts_paint', 16:27:08 INFO - 'tpaint', 16:27:08 INFO - 'sessionrestore', 16:27:08 INFO - 'sessionrestore_no_auto_restore', 16:27:08 INFO - 'tabpaint']}, 16:27:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['a11yr', 16:27:08 INFO - 'ts_paint', 16:27:08 INFO - 'tpaint', 16:27:08 INFO - 'sessionrestore', 16:27:08 INFO - 'sessionrestore_no_auto_restore', 16:27:08 INFO - 'tabpaint']}, 16:27:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['tsvgx', 16:27:08 INFO - 'tsvgr_opacity', 16:27:08 INFO - 'tart', 16:27:08 INFO - 'tscrollx', 16:27:08 INFO - 'cart', 16:27:08 INFO - 'tsvg_static']}, 16:27:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:27:08 INFO - 'tsvgr_opacity', 16:27:08 INFO - 'tart', 16:27:08 INFO - 'tscrollx', 16:27:08 INFO - 'cart', 16:27:08 INFO - 'tsvg_static']}, 16:27:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:27:08 INFO - 'talos_options': ['--disable-e10s'], 16:27:08 INFO - 'tests': ['tp5o']}, 16:27:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:27:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:27:08 INFO - 'talos_options': ['--disable-e10s', 16:27:08 INFO - '--xperf_path', 16:27:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:27:08 INFO - 'tests': ['tp5n']}, 16:27:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:27:08 INFO - 'talos_options': ['--xperf_path', 16:27:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:27:08 INFO - 'tests': ['tp5n']}}, 16:27:08 INFO - 'talos.zip': {'path': '', 16:27:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:27:08 INFO - Running post-action listener: _resource_record_post_action 16:27:08 INFO - [mozharness: 2017-02-02 00:27:08.149327Z] Finished populate-webroot step (success) 16:27:08 INFO - [mozharness: 2017-02-02 00:27:08.149416Z] Running create-virtualenv step. 16:27:08 INFO - Running pre-action listener: _resource_record_pre_action 16:27:08 INFO - Running main action method: create_virtualenv 16:27:08 INFO - Creating virtualenv /builds/slave/test/build/venv 16:27:08 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 16:27:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:27:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:27:08 INFO - Using real prefix '/usr' 16:27:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:27:08 INFO - Installing distribute.............................................................................................................................................................................................done. 16:27:10 INFO - Installing pip.................done. 16:27:10 INFO - Return code: 0 16:27:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:27:10 INFO - Reading from file tmpfile_stdout 16:27:10 INFO - Output received: 16:27:10 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) 16:27:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:10 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 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27:10 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 16:27:10 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 16:27:10 INFO - Using env: {'DISPLAY': ':0', 16:27:10 INFO - 'HOME': '/home/cltbld', 16:27:10 INFO - 'LANG': 'en_US.UTF-8', 16:27:10 INFO - 'LANGUAGE': 'en_US:en', 16:27:10 INFO - 'LOGNAME': 'cltbld', 16:27:10 INFO - 'MAIL': '/var/mail/cltbld', 16:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:10 INFO - 'MOZ_NO_REMOTE': '1', 16:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:10 INFO - 'NO_EM_RESTART': '1', 16:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:10 INFO - 'PWD': '/builds/slave/test', 16:27:10 INFO - 'SHELL': '/bin/bash', 16:27:10 INFO - 'SHLVL': '1', 16:27:10 INFO - 'TERM': 'linux', 16:27:10 INFO - 'TMOUT': '86400', 16:27:10 INFO - 'USER': 'cltbld', 16:27:10 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:10 INFO - '_': '/tools/buildbot/bin/python'} 16:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:11 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 16:27:11 INFO - Cleaning up... 16:27:11 INFO - Return code: 0 16:27:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:11 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 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27:11 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 16:27:11 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 16:27:11 INFO - Using env: {'DISPLAY': ':0', 16:27:11 INFO - 'HOME': '/home/cltbld', 16:27:11 INFO - 'LANG': 'en_US.UTF-8', 16:27:11 INFO - 'LANGUAGE': 'en_US:en', 16:27:11 INFO - 'LOGNAME': 'cltbld', 16:27:11 INFO - 'MAIL': '/var/mail/cltbld', 16:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:11 INFO - 'MOZ_NO_REMOTE': '1', 16:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:11 INFO - 'NO_EM_RESTART': '1', 16:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:11 INFO - 'PWD': '/builds/slave/test', 16:27:11 INFO - 'SHELL': '/bin/bash', 16:27:11 INFO - 'SHLVL': '1', 16:27:11 INFO - 'TERM': 'linux', 16:27:11 INFO - 'TMOUT': '86400', 16:27:11 INFO - 'USER': 'cltbld', 16:27:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:11 INFO - '_': '/tools/buildbot/bin/python'} 16:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:11 INFO - Downloading/unpacking psutil>=3.1.1 16:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:27:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:27:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:27:13 INFO - Installing collected packages: psutil 16:27:13 INFO - Running setup.py install for psutil 16:27:13 INFO - building 'psutil._psutil_linux' extension 16:27:13 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 16:27:13 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 16:27:13 INFO - building 'psutil._psutil_posix' extension 16:27:13 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 16:27:13 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 16:27:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:27:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:27:14 INFO - Successfully installed psutil 16:27:14 INFO - Cleaning up... 16:27:14 INFO - Return code: 0 16:27:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:27:14 INFO - Using env: {'DISPLAY': ':0', 16:27:14 INFO - 'HOME': '/home/cltbld', 16:27:14 INFO - 'LANG': 'en_US.UTF-8', 16:27:14 INFO - 'LANGUAGE': 'en_US:en', 16:27:14 INFO - 'LOGNAME': 'cltbld', 16:27:14 INFO - 'MAIL': '/var/mail/cltbld', 16:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:14 INFO - 'MOZ_NO_REMOTE': '1', 16:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:14 INFO - 'NO_EM_RESTART': '1', 16:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:14 INFO - 'PWD': '/builds/slave/test', 16:27:14 INFO - 'SHELL': '/bin/bash', 16:27:14 INFO - 'SHLVL': '1', 16:27:14 INFO - 'TERM': 'linux', 16:27:14 INFO - 'TMOUT': '86400', 16:27:14 INFO - 'USER': 'cltbld', 16:27:14 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:14 INFO - '_': '/tools/buildbot/bin/python'} 16:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:27:14 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 16:27:14 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 16:27:14 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 16:27:14 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 16:27:14 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 16:27:14 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 16:27:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:27:16 INFO - Installing collected packages: mozsystemmonitor 16:27:16 INFO - Running setup.py install for mozsystemmonitor 16:27:16 INFO - Successfully installed mozsystemmonitor 16:27:16 INFO - Cleaning up... 16:27:16 INFO - Return code: 0 16:27:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:16 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 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27:16 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 16:27:16 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 16:27:16 INFO - Using env: {'DISPLAY': ':0', 16:27:16 INFO - 'HOME': '/home/cltbld', 16:27:16 INFO - 'LANG': 'en_US.UTF-8', 16:27:16 INFO - 'LANGUAGE': 'en_US:en', 16:27:16 INFO - 'LOGNAME': 'cltbld', 16:27:16 INFO - 'MAIL': '/var/mail/cltbld', 16:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:16 INFO - 'MOZ_NO_REMOTE': '1', 16:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:16 INFO - 'NO_EM_RESTART': '1', 16:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:16 INFO - 'PWD': '/builds/slave/test', 16:27:16 INFO - 'SHELL': '/bin/bash', 16:27:16 INFO - 'SHLVL': '1', 16:27:16 INFO - 'TERM': 'linux', 16:27:16 INFO - 'TMOUT': '86400', 16:27:16 INFO - 'USER': 'cltbld', 16:27:16 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:16 INFO - '_': '/tools/buildbot/bin/python'} 16:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:16 INFO - Downloading/unpacking jsonschema==2.5.1 16:27:16 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 16:27:16 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 16:27:16 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 16:27:16 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 16:27:16 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 16:27:16 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 16:27:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:27:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:27:18 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 16:27:18 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 16:27:18 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 16:27:18 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 16:27:18 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 16:27:18 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 16:27:18 INFO - Downloading functools32-3.2.3-2.tar.gz 16:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:27:18 INFO - warning: no files found matching '*.txt' 16:27:18 INFO - no previously-included directories found matching 'build' 16:27:18 INFO - no previously-included directories found matching 'dist' 16:27:18 INFO - no previously-included directories found matching '.git*' 16:27:18 INFO - Installing collected packages: jsonschema, functools32 16:27:19 INFO - Running setup.py install for functools32 16:27:19 INFO - warning: no files found matching '*.txt' 16:27:19 INFO - no previously-included directories found matching 'build' 16:27:19 INFO - no previously-included directories found matching 'dist' 16:27:19 INFO - no previously-included directories found matching '.git*' 16:27:19 INFO - Successfully installed jsonschema functools32 16:27:19 INFO - Cleaning up... 16:27:19 INFO - Return code: 0 16:27:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:19 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 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27:19 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 16:27:19 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 16:27:19 INFO - Using env: {'DISPLAY': ':0', 16:27:19 INFO - 'HOME': '/home/cltbld', 16:27:19 INFO - 'LANG': 'en_US.UTF-8', 16:27:19 INFO - 'LANGUAGE': 'en_US:en', 16:27:19 INFO - 'LOGNAME': 'cltbld', 16:27:19 INFO - 'MAIL': '/var/mail/cltbld', 16:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:19 INFO - 'MOZ_NO_REMOTE': '1', 16:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:19 INFO - 'NO_EM_RESTART': '1', 16:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:19 INFO - 'PWD': '/builds/slave/test', 16:27:19 INFO - 'SHELL': '/bin/bash', 16:27:19 INFO - 'SHLVL': '1', 16:27:19 INFO - 'TERM': 'linux', 16:27:19 INFO - 'TMOUT': '86400', 16:27:19 INFO - 'USER': 'cltbld', 16:27:19 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:19 INFO - '_': '/tools/buildbot/bin/python'} 16:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:27:19 INFO - Cleaning up... 16:27:19 INFO - Return code: 0 16:27:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:19 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 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27:19 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 16:27:19 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 16:27:19 INFO - Using env: {'DISPLAY': ':0', 16:27:19 INFO - 'HOME': '/home/cltbld', 16:27:19 INFO - 'LANG': 'en_US.UTF-8', 16:27:19 INFO - 'LANGUAGE': 'en_US:en', 16:27:19 INFO - 'LOGNAME': 'cltbld', 16:27:19 INFO - 'MAIL': '/var/mail/cltbld', 16:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:19 INFO - 'MOZ_NO_REMOTE': '1', 16:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:19 INFO - 'NO_EM_RESTART': '1', 16:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:19 INFO - 'PWD': '/builds/slave/test', 16:27:19 INFO - 'SHELL': '/bin/bash', 16:27:19 INFO - 'SHLVL': '1', 16:27:19 INFO - 'TERM': 'linux', 16:27:19 INFO - 'TMOUT': '86400', 16:27:19 INFO - 'USER': 'cltbld', 16:27:19 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:19 INFO - '_': '/tools/buildbot/bin/python'} 16:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:19 INFO - Downloading/unpacking blobuploader==1.2.4 16:27:19 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 16:27:19 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 16:27:19 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 16:27:19 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 16:27:19 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 16:27:19 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 16:27:21 INFO - Downloading blobuploader-1.2.4.tar.gz 16:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:27:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:27:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:27:22 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 16:27:22 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 16:27:22 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 16:27:22 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 16:27:22 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 16:27:22 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 16:27:22 INFO - Downloading docopt-0.6.1.tar.gz 16:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:27:22 INFO - Installing collected packages: blobuploader, requests, docopt 16:27:22 INFO - Running setup.py install for blobuploader 16:27:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:27:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:27:22 INFO - Running setup.py install for requests 16:27:22 INFO - Running setup.py install for docopt 16:27:23 INFO - Successfully installed blobuploader requests docopt 16:27:23 INFO - Cleaning up... 16:27:23 INFO - Return code: 0 16:27:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:23 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 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27:23 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 16:27:23 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 16:27:23 INFO - Using env: {'DISPLAY': ':0', 16:27:23 INFO - 'HOME': '/home/cltbld', 16:27:23 INFO - 'LANG': 'en_US.UTF-8', 16:27:23 INFO - 'LANGUAGE': 'en_US:en', 16:27:23 INFO - 'LOGNAME': 'cltbld', 16:27:23 INFO - 'MAIL': '/var/mail/cltbld', 16:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:23 INFO - 'MOZ_NO_REMOTE': '1', 16:27:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:23 INFO - 'NO_EM_RESTART': '1', 16:27:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:23 INFO - 'PWD': '/builds/slave/test', 16:27:23 INFO - 'SHELL': '/bin/bash', 16:27:23 INFO - 'SHLVL': '1', 16:27:23 INFO - 'TERM': 'linux', 16:27:23 INFO - 'TMOUT': '86400', 16:27:23 INFO - 'USER': 'cltbld', 16:27:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:23 INFO - '_': '/tools/buildbot/bin/python'} 16:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:27:23 INFO - Running setup.py (path:/tmp/pip-Kn2gUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:27:23 INFO - Running setup.py (path:/tmp/pip-528lB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:27:23 INFO - Running setup.py (path:/tmp/pip-KFr0RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:27:23 INFO - Running setup.py (path:/tmp/pip-4sfp9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:27:23 INFO - Running setup.py (path:/tmp/pip-2PcaMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:27:23 INFO - Running setup.py (path:/tmp/pip-iW5jvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:27:23 INFO - Running setup.py (path:/tmp/pip-7SFpMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:27:23 INFO - Running setup.py (path:/tmp/pip-37hIGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:27:23 INFO - Running setup.py (path:/tmp/pip-qXuYRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:27:23 INFO - Running setup.py (path:/tmp/pip-ZVQsR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:27:24 INFO - Running setup.py (path:/tmp/pip-VuAyv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:27:24 INFO - Running setup.py (path:/tmp/pip-HDekOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:27:24 INFO - Running setup.py (path:/tmp/pip-y5GFiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:27:24 INFO - Running setup.py (path:/tmp/pip-nM44Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:24 INFO - Running setup.py (path:/tmp/pip-3ro9KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:27:24 INFO - Running setup.py (path:/tmp/pip-drMCNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:27:24 INFO - Running setup.py (path:/tmp/pip-HCo6jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:27:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:27:24 INFO - Running setup.py install for manifestparser 16:27:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:27:24 INFO - Running setup.py install for mozcrash 16:27:24 INFO - Running setup.py install for mozdebug 16:27:24 INFO - Running setup.py install for mozdevice 16:27:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:27:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:27:24 INFO - Running setup.py install for mozfile 16:27:25 INFO - Running setup.py install for mozhttpd 16:27:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Running setup.py install for mozinfo 16:27:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Running setup.py install for mozInstall 16:27:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Running setup.py install for mozleak 16:27:25 INFO - Running setup.py install for mozlog 16:27:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Running setup.py install for moznetwork 16:27:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Running setup.py install for mozprocess 16:27:25 INFO - Running setup.py install for mozprofile 16:27:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:27:25 INFO - Running setup.py install for mozrunner 16:27:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:27:26 INFO - Running setup.py install for mozscreenshot 16:27:26 INFO - Running setup.py install for moztest 16:27:26 INFO - Running setup.py install for mozversion 16:27:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:27:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:27:26 INFO - Cleaning up... 16:27:26 INFO - Return code: 0 16:27:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:26 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')]} 16:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:26 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')]} 16:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:26 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 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27:26 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 16:27:26 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 16:27:26 INFO - Using env: {'DISPLAY': ':0', 16:27:26 INFO - 'HOME': '/home/cltbld', 16:27:26 INFO - 'LANG': 'en_US.UTF-8', 16:27:26 INFO - 'LANGUAGE': 'en_US:en', 16:27:26 INFO - 'LOGNAME': 'cltbld', 16:27:26 INFO - 'MAIL': '/var/mail/cltbld', 16:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:26 INFO - 'MOZ_NO_REMOTE': '1', 16:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:26 INFO - 'NO_EM_RESTART': '1', 16:27:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:26 INFO - 'PWD': '/builds/slave/test', 16:27:26 INFO - 'SHELL': '/bin/bash', 16:27:26 INFO - 'SHLVL': '1', 16:27:26 INFO - 'TERM': 'linux', 16:27:26 INFO - 'TMOUT': '86400', 16:27:26 INFO - 'USER': 'cltbld', 16:27:26 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:26 INFO - '_': '/tools/buildbot/bin/python'} 16:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:27:26 INFO - Running setup.py (path:/tmp/pip-zWG6Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:27:26 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)) 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:27:26 INFO - Running setup.py (path:/tmp/pip-XlKN40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:27:26 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)) 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:27:26 INFO - Running setup.py (path:/tmp/pip-hWomFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:27:26 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)) 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:27:26 INFO - Running setup.py (path:/tmp/pip-2onUv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:27:26 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)) 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:27:26 INFO - Running setup.py (path:/tmp/pip-fXLpIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:27:26 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)) 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:27:26 INFO - Running setup.py (path:/tmp/pip-VXsImv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:27:27 INFO - Running setup.py (path:/tmp/pip-hLg3TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:27:27 INFO - Running setup.py (path:/tmp/pip-Q4PHRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:27:27 INFO - Running setup.py (path:/tmp/pip-gRlxs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:27:27 INFO - Running setup.py (path:/tmp/pip-ReMRVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:27:27 INFO - Running setup.py (path:/tmp/pip-HcUgBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:27:27 INFO - Running setup.py (path:/tmp/pip-uiW9m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:27:27 INFO - Running setup.py (path:/tmp/pip-b74m_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:27:27 INFO - Running setup.py (path:/tmp/pip-A9zdZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:27 INFO - Running setup.py (path:/tmp/pip-xDtdrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:27:27 INFO - Running setup.py (path:/tmp/pip-BJATSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:27:27 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)) 16:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:27:27 INFO - Running setup.py (path:/tmp/pip-yd9SyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:27:27 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)) 16:27:27 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)) 16:27:27 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)) 16:27:27 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)) 16:27:27 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)) 16:27:27 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)) 16:27:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:29 INFO - Downloading blessings-1.6.tar.gz 16:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:27:29 INFO - Installing collected packages: blessings 16:27:29 INFO - Running setup.py install for blessings 16:27:29 INFO - Successfully installed blessings 16:27:30 INFO - Cleaning up... 16:27:30 INFO - Return code: 0 16:27:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:27:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:27:30 INFO - Reading from file tmpfile_stdout 16:27:30 INFO - Current package versions: 16:27:30 INFO - argparse == 1.2.1 16:27:30 INFO - blessings == 1.6 16:27:30 INFO - blobuploader == 1.2.4 16:27:30 INFO - docopt == 0.6.1 16:27:30 INFO - functools32 == 3.2.3-2 16:27:30 INFO - jsonschema == 2.5.1 16:27:30 INFO - manifestparser == 1.1 16:27:30 INFO - mozInstall == 1.12 16:27:30 INFO - mozcrash == 1.0 16:27:30 INFO - mozdebug == 0.1 16:27:30 INFO - mozdevice == 0.49 16:27:30 INFO - mozfile == 1.2 16:27:30 INFO - mozhttpd == 0.7 16:27:30 INFO - mozinfo == 0.9 16:27:30 INFO - mozleak == 0.1 16:27:30 INFO - mozlog == 3.4 16:27:30 INFO - moznetwork == 0.27 16:27:30 INFO - mozprocess == 0.24 16:27:30 INFO - mozprofile == 0.28 16:27:30 INFO - mozrunner == 6.13 16:27:30 INFO - mozscreenshot == 0.1 16:27:30 INFO - mozsystemmonitor == 0.3 16:27:30 INFO - moztest == 0.8 16:27:30 INFO - mozversion == 1.4 16:27:30 INFO - psutil == 3.1.1 16:27:30 INFO - requests == 1.2.3 16:27:30 INFO - wsgiref == 0.1.2 16:27:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27: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')]} 16:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27: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')]} 16:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:30 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 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27:30 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 16:27:30 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 16:27:30 INFO - Using env: {'DISPLAY': ':0', 16:27:30 INFO - 'HOME': '/home/cltbld', 16:27:30 INFO - 'LANG': 'en_US.UTF-8', 16:27:30 INFO - 'LANGUAGE': 'en_US:en', 16:27:30 INFO - 'LOGNAME': 'cltbld', 16:27:30 INFO - 'MAIL': '/var/mail/cltbld', 16:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:30 INFO - 'MOZ_NO_REMOTE': '1', 16:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:30 INFO - 'NO_EM_RESTART': '1', 16:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:30 INFO - 'PWD': '/builds/slave/test', 16:27:30 INFO - 'SHELL': '/bin/bash', 16:27:30 INFO - 'SHLVL': '1', 16:27:30 INFO - 'TERM': 'linux', 16:27:30 INFO - 'TMOUT': '86400', 16:27:30 INFO - 'USER': 'cltbld', 16:27:30 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:30 INFO - '_': '/tools/buildbot/bin/python'} 16:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:30 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)) 16:27:30 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)) 16:27:30 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)) 16:27:30 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)) 16:27:30 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)) 16:27:30 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)) 16:27:30 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)) 16:27:30 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)) 16:27:30 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)) 16:27:30 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)) 16:27:30 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)) 16:27:30 INFO - Cleaning up... 16:27:30 INFO - Return code: 0 16:27:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:27: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')]} 16:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27: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')]} 16:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, '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': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', '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 16:27: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'] in /builds/slave/test/build 16:27: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 16:27:30 INFO - Using env: {'DISPLAY': ':0', 16:27:30 INFO - 'HOME': '/home/cltbld', 16:27:30 INFO - 'LANG': 'en_US.UTF-8', 16:27:30 INFO - 'LANGUAGE': 'en_US:en', 16:27:30 INFO - 'LOGNAME': 'cltbld', 16:27:30 INFO - 'MAIL': '/var/mail/cltbld', 16:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:30 INFO - 'MOZ_NO_REMOTE': '1', 16:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:30 INFO - 'NO_EM_RESTART': '1', 16:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:30 INFO - 'PWD': '/builds/slave/test', 16:27:30 INFO - 'SHELL': '/bin/bash', 16:27:30 INFO - 'SHLVL': '1', 16:27:30 INFO - 'TERM': 'linux', 16:27:30 INFO - 'TMOUT': '86400', 16:27:30 INFO - 'USER': 'cltbld', 16:27:30 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:30 INFO - '_': '/tools/buildbot/bin/python'} 16:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:27:30 INFO - Cleaning up... 16:27:30 INFO - Return code: 0 16:27:30 INFO - Running post-action listener: _resource_record_post_action 16:27:30 INFO - Running post-action listener: _start_resource_monitoring 16:27:30 INFO - Starting resource monitoring. 16:27:30 INFO - [mozharness: 2017-02-02 00:27:30.793071Z] Finished create-virtualenv step (success) 16:27:30 INFO - [mozharness: 2017-02-02 00:27:30.793529Z] Running install step. 16:27:30 INFO - Running pre-action listener: _resource_record_pre_action 16:27:30 INFO - Running main action method: install 16:27:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:27:31 INFO - Reading from file tmpfile_stdout 16:27:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:27:31 INFO - Reading from file tmpfile_stdout 16:27:31 INFO - Output received: 16:27:31 INFO - Usage: mozinstall [options] installer 16:27:31 INFO - Options: 16:27:31 INFO - -h, --help show this help message and exit 16:27:31 INFO - -d DEST, --destination=DEST 16:27:31 INFO - Directory to install application into. [default: 16:27:31 INFO - "/builds/slave/test"] 16:27:31 INFO - --app=APP Application being installed. [default: firefox] 16:27:31 INFO - mkdir: /builds/slave/test/build/application 16:27:31 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'] 16:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:27:47 INFO - Reading from file tmpfile_stdout 16:27:47 INFO - Output received: 16:27:47 INFO - /builds/slave/test/build/application/firefox/firefox 16:27:47 INFO - Running post-action listener: _resource_record_post_action 16:27:47 INFO - [mozharness: 2017-02-02 00:27:47.527825Z] Finished install step (success) 16:27:47 INFO - [mozharness: 2017-02-02 00:27:47.527975Z] Running run-tests step. 16:27:47 INFO - Running pre-action listener: _resource_record_pre_action 16:27:47 INFO - Running main action method: run_tests 16:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:27:47 INFO - Python 2.7.3 16:27:47 INFO - Return code: 0 16:27:47 INFO - grabbing minidump binary from tooltool 16:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:47 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 0x1d38850>, '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 0x1cad6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cadb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:27:47 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 16:27:47 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 16:27:47 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 16:27:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:27:47 INFO - Return code: 0 16:27:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:27:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:27:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:27:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:27:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:27:47 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/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 16:27:47 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/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 16:27:47 INFO - Using env: {'DISPLAY': ':0', 16:27:47 INFO - 'HOME': '/home/cltbld', 16:27:47 INFO - 'LANG': 'en_US.UTF-8', 16:27:47 INFO - 'LANGUAGE': 'en_US:en', 16:27:47 INFO - 'LOGNAME': 'cltbld', 16:27:47 INFO - 'MAIL': '/var/mail/cltbld', 16:27:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:27:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:47 INFO - 'MOZ_NO_REMOTE': '1', 16:27:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:47 INFO - 'NO_EM_RESTART': '1', 16:27:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:47 INFO - 'PWD': '/builds/slave/test', 16:27:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:27:47 INFO - 'SHELL': '/bin/bash', 16:27:47 INFO - 'SHLVL': '1', 16:27:47 INFO - 'TERM': 'linux', 16:27:47 INFO - 'TMOUT': '86400', 16:27:47 INFO - 'USER': 'cltbld', 16:27:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364', 16:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:47 INFO - '_': '/tools/buildbot/bin/python'} 16:27:47 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/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 16:27:47 INFO - mozversion application_buildid: 20170201231610 16:27:47 INFO - mozversion application_changeset: d06f2bf30b22a04b03e2046d5c148adedd6777c1 16:27:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:27:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:27:47 INFO - mozversion application_name: Firefox 16:27:47 INFO - mozversion application_remotingname: firefox-dev 16:27:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:27:47 INFO - mozversion application_vendor: Mozilla 16:27:47 INFO - mozversion application_version: 53.0a2 16:27:47 INFO - mozversion platform_buildid: 20170201231610 16:27:47 INFO - mozversion platform_changeset: d06f2bf30b22a04b03e2046d5c148adedd6777c1 16:27:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:27:47 INFO - mozversion platform_version: 53.0a2 16:27:47 INFO - using testdate: 1485995267 16:27:47 INFO - actual date: 1485995267 16:27:47 INFO - starting webserver on 'localhost:54360' 16:27:47 INFO - SUITE-START | Running 2 tests 16:27:47 INFO - TEST-START | dromaeo_css 16:27:47 INFO - operating with platform_type : linux_ 16:27:47 INFO - Initialising browser for dromaeo_css test... 16:27:47 INFO - TEST-INFO | started process 30583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOczA2W/profile http://localhost:54360/getInfo.html) 16:27:51 INFO - PROCESS | 30583 | __metrics Screen width/height:1600/1200 16:27:51 INFO - PROCESS | 30583 | colorDepth:24 16:27:51 INFO - PROCESS | 30583 | Browser inner width/height: 1024/697 16:27:51 INFO - PROCESS | 30583 | __metrics 16:27:52 INFO - PROCESS | 30583 | 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" 16:27:52 INFO - PROCESS | 30583 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:27:53 INFO - PROCESS | 30583 | console.error: PushService: 16:27:53 INFO - PROCESS | 30583 | stateChangeProcessEnqueue: Error transitioning state 16:27:53 INFO - PROCESS | 30583 | UnknownError 16:27:53 INFO - TEST-INFO | 30583: exit 0 16:27:53 INFO - Browser initialized. 16:27:53 INFO - Running cycle 1/1 for dromaeo_css test... 16:27:53 INFO - TEST-INFO | started process 30675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOczA2W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:28:05 INFO - PROCESS | 30675 | RSS: Main: 138301440 16:28:05 INFO - PROCESS | 30675 | 16:31:05 INFO - PROCESS | 30675 | Cycle 1(1): loaded http://localhost:54360/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54360/tests/dromaeo/cssquery-ext.html) 16:31:06 INFO - PROCESS | 30675 | RSS: Main: 242294784 16:31:06 INFO - PROCESS | 30675 | 16:32:55 INFO - PROCESS | 30675 | ************************* 16:32:55 INFO - PROCESS | 30675 | A coding exception was thrown and uncaught in a Task. 16:32:55 INFO - PROCESS | 30675 | 16:32:55 ERROR - PROCESS | 30675 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:32:55 INFO - PROCESS | 30675 | Full stack: 16:32:55 INFO - PROCESS | 30675 | ************************* 16:34:08 INFO - PROCESS | 30675 | Cycle 1(1): loaded http://localhost:54360/tests/dromaeo/cssquery-ext.html (next: http://localhost:54360/tests/dromaeo/cssquery-jquery.html) 16:34:09 INFO - PROCESS | 30675 | RSS: Main: 223059968 16:34:09 INFO - PROCESS | 30675 | 16:37:11 INFO - PROCESS | 30675 | Cycle 1(1): loaded http://localhost:54360/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54360/tests/dromaeo/cssquery-mootools.html) 16:37:11 INFO - PROCESS | 30675 | RSS: Main: 198897664 16:37:11 INFO - PROCESS | 30675 | 16:40:13 INFO - PROCESS | 30675 | Cycle 1(1): loaded http://localhost:54360/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54360/tests/dromaeo/cssquery-prototype.html) 16:40:14 INFO - PROCESS | 30675 | RSS: Main: 225148928 16:40:14 INFO - PROCESS | 30675 | 16:43:17 INFO - PROCESS | 30675 | Cycle 1(1): loaded http://localhost:54360/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54360/tests/dromaeo/cssquery-yui.html) 16:43:17 INFO - PROCESS | 30675 | RSS: Main: 171552768 16:43:17 INFO - PROCESS | 30675 | 16:46:20 INFO - PROCESS | 30675 | Cycle 1(1): loaded http://localhost:54360/tests/dromaeo/cssquery-yui.html (next: http://localhost:54360/tests/dromaeo/cssquery-dojo.html) 16:46:20 INFO - PROCESS | 30675 | RSS: Main: 253026304 16:46:20 INFO - PROCESS | 30675 | 16:46:20 INFO - PROCESS | 30675 | __start_tp_report 16:46:20 INFO - PROCESS | 30675 | _x_x_mozilla_page_load 16:46:20 INFO - PROCESS | 30675 | _x_x_mozilla_page_load_details 16:46:20 INFO - PROCESS | 30675 | |i|pagename|runs| 16:46:20 INFO - PROCESS | 30675 | |0;dojo.html;3200.247941733693;3226.8225247611385;3247.431699452596;3259.1852036990754;3266.0854960611036;5481.12302031675;5564;5567.916481252774;5581.553475721943;5618.719064046797;5567.860803479915;5590.049691552435;5591.077472217089;5600.327960644719;5604.971975140119;4935.2103663413955;4960.305557221992;4981.501849815026;4992.575631071363;5067.113255180348;4944.456109827916;4997.050560393532;5040.495950404967;5057.064443078024;5082.288479612857;4905.386826646669;4925.630577706686;4927.384076990376;4938.407391113072;5064.746762661871;5028.974855125719;5064.873378165576;5068.239764035387;5079.111155547765;5106.617003724736;4907.190313598252;4976.377952755905;5028.4971502849785;5031.044101620717;5044.092063428581;5429.945700542983;5460.208269800856;5512.724363781835;5521.917171242435;5528.5577153828;5973.492253158487;5995.7901473448655;6002.519798416116;6006.459418652343;6030.939690603125;6026.638401695912;6045.12345709874;6056.303525094627;6058.363871793486;6085.513158947274;5505.587080968903;5508.44915508446;5575.860603484945;5623.184638227475;5624.409437009137;6118.314626315956;6120.90429240112;6127.628174126313;6133.867031338107;6138.615839526931;5863.003289440805;5917.733701983421;5920.289565252111;5923.4076592340425;5933.614315069507;5809.854753631109;5825.155352473952;5860.267466566679;5988.191594134823;6012.609180403259;5832.475077242983;5834.649921004669;5885.028970219952;5912.260967379078;5922.970385148046;5923.940760592339;5925.05199168131;5925.911111333334;5926.614770039933;5928.466438020512;4528.139653465831;4548.158590660738;4588.632909367243;4596.816127354935;4613.354130421743;4016.8995775105855;4036.65688416482;4051.5745846685672;4086.427900093989;4111.280525908014;5820.679862607512;5820.854478637983;5822.592418530747;5823.126531020296;5830.854228644318;5741.885162296814;5778.162166485836;5884.382139875337;5949.732262048132;6004.729787159588;5722.227499287543;5787.681677507693;5795.362510123883;5811.389804070512;5822.970885145547;5101.668391554537;5102.872428189251;5105.33630628016;5110.335656364723;5113.207452844815;6006.639601623917;6052.636841789506;6224.502039836802;6264.5301602380005;6265.0602409638;5931.228940237742;5995.520358371407;6002.609830361012;6054.75780968774;6056.7274472649715;6291.804045015356;6307.526935479949;6311.2426508819235;6325.146105275729;6330.430261276507;5762.0204565223175;5912.260967379078;5972.850678733066;5988.850278742892;6001.715916119608;5892.440218179266;5894.734736936763;5938.524918006463;5944.821655350346;6028.487578555872;5827.155062515996;5866.735996880066;5885.47030767233;5888.941110588839;5893.852653683693;5852.736626851717;5853.473187413153;5857.882842343214;5859.121131830259;5861.882762344814;5615.831525054255;5722;5728.54171666274;5759.049756790083;5775.711214439178;5829.8251052468495;5840.123981402654;5858.853528661817;5875.676837773793;5878.735456904535;5710.942890571041;5714.20001199824;5719.342275638355;5723.828285151452;5730.856728581819 16:46:20 INFO - PROCESS | 30675 | |1;ext.html;582.2401765695765;615.9106929495223;618.9288231853338;651.6448535548122;651.664392837689;36860.81569592152;48207.276890846624;49679;49782.75108624456;49810.50189498104;52869;53355;53402.19896701543;53448;53482.73258633701;8616.26761725254;9231.999999999984;9394.013628569004;9403.059694030611;9413.670521531714;8768.69309574165;10891.891081089207;11131.833022504668;11152.553897844116;11551.595694150707;11345.489452974636;11409.030232430254;11413.372264525447;11414.71463213422;11427.657170284905;11220;11273.830892536618;11303.943480282629;11306.152038597138;11308.943455282671;11037.558497660084;11196.552137914474;11199.608013719562;11200.607978720705;11201.215914885961;49272.01455970861;49530.50469495331;49624;49633.25550116715;49682.50317496815;4338.349247612852;4444.177827101997;4522.276435770294;4536.274196128604;4716.080364328957;33177;33370.49944250838;33445.6655433445;33700.98897033093;34699.653003469895;4672.579467847876;4677.7193368398;4699.271612900006;4707.976460117712;4812;354257;356019;356251;356459;357628.21185894165;62725.686371568765;62871;62900.37099629037;63099.6845015772;63182;66512.66743666347;66554.33445665578;66641.33358666352;66806.66596667083;67453;18951.052447377577;19338;19362.128704208346;19375.612487750448;19394.933278669807;14204;14601.926990365193;14801.333939972727;15036.924815375853;15257.389704411698;19327.90336048311;20426.285080022128;20623.175072997212;20627.4843128923;20785.168593256403;7256.528325658815;7295.927040729631;7321.572293402842;7413.851722965511;7508.737194198176;1003.1272792670278;1012.9746756331003;1022.8158931392272;1025.7692019295598;1029.9794004119876;34664.480032799525;34920;35556.73319201712;35556.82221588876;35688.286234275685;1096.1833434091493;1134.773045390925;1135.8693750218665;1158.2992289664633;1169.0939521870448;15820.841791581937;16178.514644560682;16199.433019844484;16294.348226070824;16470.75293870593;505563;522549;526364;526505;527221.4555708864;60775.392246076975;61280;61293.69353153206;61374;61613.07580386298;1469.9412023519153;1473.9484118055816;1483.7774333849793;1497.1316636350891;1520.467836257301;28785;30426.543601845548;30466.390672186877;30621.54067689031;30944.381112378076;51317;52723.20915186352;53136.20295695645;53143.46856531385;53150.4684953161;453685;454492;454741;455450;456953;29752.553711694774;29783.851080744458;30017;30702.385952281275;30702.84648576743;48763.268550972476;48906;49097.01805963789;50209.497905020486;50333.49666503288;38836.41745373765;41153.588464114975;41621.79189104035;42042.57957420387;42315.15369692527;39671.40492892667;40130.799346003085;40365.79817100896;44106.11787764163;46084;42259.7887010563;42507.57492425036;42531.1493770129;42584.14831703411;42765.57234427616;35267.47098793572;37554.24891502209;37684.43473347847;37879.43180852345;38274;28410.715892840806;28418.573721393783;28611.713882860906;28625.570616441186;28756.42487150287 16:46:20 INFO - PROCESS | 30675 | |2;jquery.html;392.51720383927784;452.25829639391407;459.4027763906921;460.7488918539395;472.48263151848715;20060.598788024232;21537.56924861502;21731;22110.88944555279;22225.999830007648;22271.665925011097;22471.438214044658;22498.88750556249;22692.319230423072;22841.31476055717;5271.5782737381105;6079.118527813464;6285.3400392958765;6296.968515157418;6310.652914089723;6184.969075154618;6254.124422580842;6254.312025677172;6274.090256912745;6277.560570760049;6012.75948962041;6123.601965872204;6183.690815459209;6198.752049917998;6200.348963358828;5998.640081595118;6127.387261273881;6142.570020098573;6201.131841542187;6202.813915582517;5513.338399392059;5544.63959842613;5552.666839989613;5553.527950124204;5553.6390134641115;21497.785022149736;24338.391540211458;24634.137805176913;25358.873205634038;25605.48789024228;2668.3329167708075;2791.5393959996577;2800.327921298894;2805.509035918706;2828.1656911211035;11279.943600282028;11404.087672986141;11525.592263902405;11539.019183369424;11922.821157682642;2020.8383329333617;2045.9386218413472;2047.692846073101;2064.1227478321803;2075.771665116851;98549;99063;99430;100540.49729751378;103779;11438.313701177789;12043.277403355827;12780.61658150257;12807.61577152687;13093.476260949456;15251.694966100838;15825.446109386115;16066.43767468133;16701.63993118059;16965.830341696674;9147.222486088624;9164.450132992042;9242.72271831846;9251.861222081674;9385.765355866159;9045.864312035324;9088.772780680403;9112.681056163136;9278.67524636648;9282.48946307946;4992.725400102957;5005.724685142352;5021.322121513549;5119.283300337956;5205.6616319939085;2156.6628690211855;2162.5782972320562;2163.8377121715935;2208.8012078912975;2263.852849564773;1093.7211011192096;1096.1011970184372;1101.2456467319912;1116.2353787655481;1129.3957732613176;20324.69512957307;21730.239441619466;21758.78241217599;21837.890810545847;21887.890560547094;1074.6561100447782;1076.2304951959386;1100.1144079016308;1105.8728246251785;1107.8338249262674;11314;11923.642290731292;12076.577319793765;12078.094142939315;12163.635090947286;664845;677517;677784;687508;710318;80483.59758201172;110281;112400.43799780948;113492;113887.43056284665;962.6149540183842;964.9469279189572;990.0742805476903;991.2119864707574;996.9711636819038;18320.900745955285;18638.34765783245;18638.53403664919;18815;18823.529411764815;46269.30596041129;46842.29736553886;46980.53019469762;47915.281270780266;48860.26709599288;66631.66684166742;67516.32483675101;70009.64995174992;73405;74003.25996740178;9349.672761453316;10039.146672532625;10050.09549140581;10214.080732733792;10264.435456049989;14074.577762667137;14845.628859278173;15517.146556939477;15652.37390504367;15944.282507287431;5833.67914764692;9502;10532.315399499315;12815.231086134861;12871.871281287442;5677.460641239076;10205.877353490961;12499.500019999097;12560.371981401076;12808.487660493476;12641.304728240035;12815.42330595144;12832.935835320764;12871.806922895978;13337.933310333774;9792.118709315911;9995.900040999497;10030.29787914839;10099.495025248854;10155;10507.684769456928;12400;12418.441170147184;12600;12742.745145097231 16:46:20 INFO - PROCESS | 30675 | |3;mootools.html;1516.848315168484;1524.0931645670828;1529.5717199184226;1544.8068991376078;1549.0782984124446;8546.743597692064;9125;9136.817263654732;9139.543022848857;9141.542922853863;7592.54444733315;7777.611119444019;7778.377729781618;8694.826103477943;9064.954675226614;2488.651588777568;2554.0294688018525;2556.3736884463333;2560.8591527465983;2562.7181010088875;2532.987335063331;2563.6026415905562;2567.3453269416273;2583.8320509166842;2584.7673709366154;2505.3736565858535;2506.385935445818;2529.0768869362732;2530.8354956927833;2534.51844149611;2355.882205889707;2367.30164601443;2387.522495500898;2393.9760602393926;2477.269205584348;2409.120670955106;2415.1909110448023;2469.296250568579;2469.9753002469924;2470.2465747946867;9100;9173.954130229373;9174.67888623895;9181.173694367471;9184.770380740469;5375.596830237748;5513.724313784295;5520.91718624221;5522.30971128609;5525.171224316345;3425.7349599748472;3491.9476207856646;3493.2314890724;3500.264944361687;3580.6214607376087;1407.268220525321;1444.2056868722161;1459.5183589415574;1469.8824094072556;1502.0762231227825;11929.880701193051;12155.088368372319;12310.81533776994;12415;12662.49350026007;4614.792334344896;4713.128071306819;4795.472498025214;4829.855104346805;4922.58158056562;9684.370515916444;9695.70912872615;9722.61109555624;9730.902690973142;9734;5459.2629994950175;5473.0969390050195;5473.507384335429;5475.123980163235;5476.863078423071;4277.2087163874785;4978.800847966041;5044.470330615306;5159.793608255703;5217.556507696812;3781.1681430085337;3844.7308688391545;3855.63371479709;3898.2593307271527;3920.2943470175073;1195.1753290229713;1196.7845787758288;1206.7224538356227;1210.891019808204;1219.664592237142;828.5153185386616;843.7679638099572;845.4842546046906;872.2542226396466;874.2350443362059;6150.600210986271;6240.500759939194;6258.780942666985;6361.141245931833;6417.358264173638;648.1088503307951;657.4838751579987;664.378805816563;697.396751809681;697.4524997876642;4215.810288537024;4281.871543853689;4358.56414358568;4380.649548036149;4395.516493185747;10540.420276884844;10919.290246134135;10936.125109991182;10947.671569852917;11027.669169924915;10695.679129626124;10868.565257389773;10897.182711296684;10907.072898803532;10970.780584388267;8195.67217311301;8495.617697203641;8502.744917652604;8505.61724722389;8505.829883402297;6004.519638428827;6071.939280607314;6102.328743838086;6131.448169664752;6143.84640383994;9432.481213533321;10036.548355324174;10055.74860628461;10082.647107351208;10096.949515252376;9860.359076659994;10076.395416275047;10117.29178957466;10167.644132455625;10179.541920613443;7189.460790440633;7574.545527268381;7986.960065199637;7997.360211183208;8127.065387480279;8638.481691098554;8772.342074344322;8775.210231079234;8778.561071946506;8821.514816684887;7194.748183813542;7205.099362579677;7298.124225093023;7393.320688388021;7451.105867295959;7451.478396512192;7456.366208872089;7460.66427010775;7466.328030477283;7513.1359893612935;6509.349065093453;6539.869202616016;6593.439557637655;6597.80206593803;6614.140161778938;5480.753366098455;5480.835574932758;5528.087865502308;5565.526930210977;5607.355154157324;5269.394019687785;5283.418823929288;5323;5341.65279256847;5389.21856330822 16:46:20 INFO - PROCESS | 30675 | |4;prototype.html;410.87262948485954;417.57824597156883;423.08824483238624;431.4649834205584;438.0669174657978;5271.209318602211;5303.867403314919;5341.813036543722;5342.732863356831;5351.304330437048;5052.837847295124;5140.588752899768;5180.922286165711;5230.947690523094;5280.788768449257;4225.661947044229;4233;4241.384999175118;4245.299525578276;4260.595243451867;4269.252880745873;4280.529141794415;4280.72175308604;4294.334378171388;4295.4777082792125;3988.8205030773684;4063.3295506241584;4230.830766769341;4239.660827133837;4284.871453856389;4216.85241016566;4221.155768846213;4227.513835908864;4232.217039847638;4266.360045993095;3874.8837534874;3875.786831724254;3879.301725689375;3885.7279990400684;3896.201278737852;5104.106781313292;5156.819511317086;5163.870903227412;5216.2958000669805;5219.791208351661;4895.755212239374;4928.852134435972;4950.183219768734;4962.156433406293;4985.881000574741;5608.915866262009;5609.270794796691;5641.661500309953;5655.179998900177;5661.547076233891;3957.56466788653;4148.481439820022;4151.003759097825;4384.758838263894;4405.845795397177;5691.3170419549915;5717.771289148471;5731.770729170828;5734.971325143348;5754.539636829044;4199.895002624959;4219.156168766259;4227.112306415687;4227.795078402641;4258.723182993095;4220.345846393814;4257.318828987347;4298.677599180074;4311;4316.093620339701;4761.999960016801;4778.474367819537;4810.759462026885;4825.469198388175;4835.95164048362;5542.334919809568;5547.833564993057;5578.525825304894;5579.553635709133;5606.187102870143;1401.8457969623332;1425.137791636066;1432.4556668466125;1435.3182238436868;1439.6760728835927;963.8457846744487;971.4705485510414;980.6616717232544;991.82468774501;995.2038369304672;5306.310179676694;5313.760880760375;5313.973430132824;5325.4142044375085;5341.919871201935;5491.670499770026;5510;5516.503514683617;5519.779208831682;5522.784987302787;5152.355955505562;5292.311999440125;5293.947060529423;5302.708351040653;5303.28405665238;2878.956815647767;2883.6539615246306;2884.206843118159;2896.898608548691;2920.605718228012;5436.238926550286;5641.858953526113;5660.518855897295;5700.209360775121;5729.627574207663;5548.611597188239;5564.499195072382;5566.0499935034495;5613.382527921925;5643.463870932255;5705.600607957486;5714.342850572238;5742.7029188325005;5747.620571062831;5751.683657398799;5212.348456442945;5455.536279416294;5468.2891224142195;5469.75386107634;5478.424765399575;5388.272583201375;5397.898985458861;5416.133418652997;5432.311006052029;5447.591430642638;5550.833474995757;5580.609357344947;5684.516816070681;5716.857078573069;5726.255586773693;4064.7154699170774;4085.3667681508223;4100.138970816042;4114.354258296586;4119.279126152971;5500;5502.724863756716;5539.612227144061;5542.695151766691;5609.467100625434;5287.365516138088;5391.622586418913;5445.292112025411;5468.671879687232;5480.410331233049;5566.332040155207;5585.497305242385;5610.915836262541;5614.550835933197;5620.85947851307;5355.384130824849;5510.862228444321;5558.888822223614;5602.853888122679;5611.466910643482;5431.619786614899;5569;5577.860553486195;5587.161925711176;5590.972045139748;5458.208559758733;5476.440313796064;5478.863028424162;5480.561555075505;5492.928878868742 16:46:20 INFO - PROCESS | 30675 | |5;yui.html;824.0276473760963;827.4290739389817;906.8005038891445;906.9501177435243;950.1401231885142;14057.648558786035;14905.03117297375;14907.180105094229;14915.179665118414;14920.253987300619;14198.858011419883;14495;14505.347259373328;14520.85479145211;14526.491572794954;706.6290197646251;723.8914162875584;798.9600519974007;821.5522540215596;828.573284758347;814.5072231300067;827.4704189318811;827.6317038917684;828.772087675888;828.8508068547659;861.3195575495382;861.4099341950753;861.4917198852676;861.7543999960012;861.9655213791441;740.6815069520077;756.0134025097246;846.8729690546405;863.2662237098448;863.9654413823471;631.9715612797389;632.3455223843346;632.4750457120625;632.9493640508748;637.2384999925091;14109.153450792985;14326.068805527608;14330.49843255481;14368.13791172533;14375.928120359436;14376.64058398538;15158.090514569161;15172.772408413883;15336.079835209812;15640.921795391065;13937.372818223204;14155.575332740034;14262.072965257224;14270.143791372448;14497.057691250035;4693.812247510095;4715.1512727709;4733.053389322149;4766.022965292107;4868.294097355899;64437;65551.67224163897;67256.32743672549;78722.99999999943;85509;11530;11795.587154449724;11816.35010074437;11819.940900295443;12012.519499219934;23758.287251382488;23862.284131476084;24089.63865542018;24187;24213.63679544808;8889.244414224733;8962.596683149273;9008.928081286058;9009.684661036832;9127.634894604274;4764.380630518011;4776.522347765195;4946;4970.130227210224;5061.5950723942;3671.8714844980295;3743.3262012837404;3744.045268456526;3749.456328832304;3750.6811920986474;616.3866952382408;630.9936900631027;640.8942524483501;641.8844607970517;642.5534253693731;790.5059337913804;797.924197201265;799.188823344306;800.7117437722416;842.2293601354814;9723;10180.898191018143;10464;10842.457877106113;10866.61966831157;739.6412739821183;749.9587522686305;757.3524636435878;774.0633833061945;805.0741647105758;5118.155504341742;5144.897102057937;5178.559822415137;5186.247994040843;5213.6089793265655;77405;77957.220427795;78067.60966195133;80685;81243.18756812357;56674.71662641743;58511;58825.705871471226;64767.67616161889;71945;63753.36246637567;65105.67447162734;65284.673576631816;65347.67326163339;65426.67286663536;9449.338546301693;9837.458939758095;9889.851652225367;9926.454045027303;9951.701448956543;45071.549284508044;45309.546904530536;45608.77195614001;46606.76696616495;46841.53158468508;56437;58374.4162558369;58434.7078264623;58927;60396.39603603908;10599.311044782064;10627.468626568796;10718.678439646512;10773.19201059908;11134.498947547541;12843.614691559269;12958.740825183255;13036.739265214832;13085.41115649779;13123.475060997453;12173.878261217274;12182.208156469802;12198.207116537396;12296.569620063256;12477.251364918135;11944.112883654314;12047.156699031335;12101;12173.147879648694;12214.26714397139;12109.273443593413;12130.878691212974;12184.63446096583;12361.752764944831;12409.813852792397;10428.222324663633;10469.895301046892;10773.407462589634;10910.61812836547;10978.890211097787;10151.847722284025;10231.43727095017;10313.9484302578;10372.896271037192;10387.428691422045 16:46:20 INFO - PROCESS | 30675 | __end_tp_report 16:46:20 INFO - PROCESS | 30675 | __start_cc_report 16:46:20 INFO - PROCESS | 30675 | _x_x_mozilla_cycle_collect,950 16:46:20 INFO - PROCESS | 30675 | __end_cc_report 16:46:20 INFO - PROCESS | 30675 | __startTimestamp1485996380332__endTimestamp 16:46:20 INFO - PROCESS | 30675 | 16:46:20 INFO - PROCESS | 30675 | ------- Summary: start ------- 16:46:20 INFO - PROCESS | 30675 | Number of tests: 6 16:46:20 INFO - PROCESS | 30675 | 16:46:20 INFO - PROCESS | 30675 | [#0] dojo.html Cycles:165 Average:5541.94 Median:5811.39 stddev:643.99 (11.1%) stddev-sans-first:619.21 16:46:20 INFO - PROCESS | 30675 | Values: 3200.2 3226.8 3247.4 3259.2 3266.1 5481.1 5564.0 5567.9 5581.6 5618.7 5567.9 5590.0 5591.1 5600.3 5605.0 4935.2 4960.3 4981.5 4992.6 5067.1 4944.5 4997.1 5040.5 5057.1 5082.3 4905.4 4925.6 4927.4 4938.4 5064.7 5029.0 5064.9 5068.2 5079.1 5106.6 4907.2 4976.4 5028.5 5031.0 5044.1 5429.9 5460.2 5512.7 5521.9 5528.6 5973.5 5995.8 6002.5 6006.5 6030.9 6026.6 6045.1 6056.3 6058.4 6085.5 5505.6 5508.4 5575.9 5623.2 5624.4 6118.3 6120.9 6127.6 6133.9 6138.6 5863.0 5917.7 5920.3 5923.4 5933.6 5809.9 5825.2 5860.3 5988.2 6012.6 5832.5 5834.6 5885.0 5912.3 5923.0 5923.9 5925.1 5925.9 5926.6 5928.5 4528.1 4548.2 4588.6 4596.8 4613.4 4016.9 4036.7 4051.6 4086.4 4111.3 5820.7 5820.9 5822.6 5823.1 5830.9 5741.9 5778.2 5884.4 5949.7 6004.7 5722.2 5787.7 5795.4 5811.4 5823.0 5101.7 5102.9 5105.3 5110.3 5113.2 6006.6 6052.6 6224.5 6264.5 6265.1 5931.2 5995.5 6002.6 6054.8 6056.7 6291.8 6307.5 6311.2 6325.1 6330.4 5762.0 5912.3 5972.9 5988.9 6001.7 5892.4 5894.7 5938.5 5944.8 6028.5 5827.2 5866.7 5885.5 5888.9 5893.9 5852.7 5853.5 5857.9 5859.1 5861.9 5615.8 5722.0 5728.5 5759.0 5775.7 5829.8 5840.1 5858.9 5875.7 5878.7 5710.9 5714.2 5719.3 5723.8 5730.9 16:46:20 INFO - PROCESS | 30675 | 16:46:20 INFO - PROCESS | 30675 | [#1] ext.html Cycles:180 Average:62279.17 Median:39253.91 stddev:118772.48 (302.6%) stddev-sans-first:119015.33 16:46:20 INFO - PROCESS | 30675 | Values: 582.2 615.9 618.9 651.6 651.7 36860.8 48207.3 49679.0 49782.8 49810.5 52869.0 53355.0 53402.2 53448.0 53482.7 8616.3 9232.0 9394.0 9403.1 9413.7 8768.7 10891.9 11131.8 11152.6 11551.6 11345.5 11409.0 11413.4 11414.7 11427.7 11220.0 11273.8 11303.9 11306.2 11308.9 11037.6 11196.6 11199.6 11200.6 11201.2 49272.0 49530.5 49624.0 49633.3 49682.5 4338.3 4444.2 4522.3 4536.3 4716.1 33177.0 33370.5 33445.7 33701.0 34699.7 4672.6 4677.7 4699.3 4708.0 4812.0 354257.0 356019.0 356251.0 356459.0 357628.2 62725.7 62871.0 62900.4 63099.7 63182.0 66512.7 66554.3 66641.3 66806.7 67453.0 18951.1 19338.0 19362.1 19375.6 19394.9 14204.0 14601.9 14801.3 15036.9 15257.4 19327.9 20426.3 20623.2 20627.5 20785.2 7256.5 7295.9 7321.6 7413.9 7508.7 1003.1 1013.0 1022.8 1025.8 1030.0 34664.5 34920.0 35556.7 35556.8 35688.3 1096.2 1134.8 1135.9 1158.3 1169.1 15820.8 16178.5 16199.4 16294.3 16470.8 505563.0 522549.0 526364.0 526505.0 527221.5 60775.4 61280.0 61293.7 61374.0 61613.1 1469.9 1473.9 1483.8 1497.1 1520.5 28785.0 30426.5 30466.4 30621.5 30944.4 51317.0 52723.2 53136.2 53143.5 53150.5 453685.0 454492.0 454741.0 455450.0 456953.0 29752.6 29783.9 30017.0 30702.4 30702.8 48763.3 48906.0 49097.0 50209.5 50333.5 38836.4 41153.6 41621.8 42042.6 42315.2 39671.4 40130.8 40365.8 44106.1 46084.0 42259.8 42507.6 42531.1 42584.1 42765.6 35267.5 37554.2 37684.4 37879.4 38274.0 28410.7 28418.6 28611.7 28625.6 28756.4 16:46:20 INFO - PROCESS | 30675 | 16:46:20 INFO - PROCESS | 30675 | [#2] jquery.html Cycles:180 Average:36493.65 Median:22371.55 stddev:112452.95 (502.7%) stddev-sans-first:112735.73 16:46:20 INFO - PROCESS | 30675 | Values: 392.5 452.3 459.4 460.7 472.5 20060.6 21537.6 21731.0 22110.9 22226.0 22271.7 22471.4 22498.9 22692.3 22841.3 5271.6 6079.1 6285.3 6297.0 6310.7 6185.0 6254.1 6254.3 6274.1 6277.6 6012.8 6123.6 6183.7 6198.8 6200.3 5998.6 6127.4 6142.6 6201.1 6202.8 5513.3 5544.6 5552.7 5553.5 5553.6 21497.8 24338.4 24634.1 25358.9 25605.5 2668.3 2791.5 2800.3 2805.5 2828.2 11279.9 11404.1 11525.6 11539.0 11922.8 2020.8 2045.9 2047.7 2064.1 2075.8 98549.0 99063.0 99430.0 100540.5 103779.0 11438.3 12043.3 12780.6 12807.6 13093.5 15251.7 15825.4 16066.4 16701.6 16965.8 9147.2 9164.5 9242.7 9251.9 9385.8 9045.9 9088.8 9112.7 9278.7 9282.5 4992.7 5005.7 5021.3 5119.3 5205.7 2156.7 2162.6 2163.8 2208.8 2263.9 1093.7 1096.1 1101.2 1116.2 1129.4 20324.7 21730.2 21758.8 21837.9 21887.9 1074.7 1076.2 1100.1 1105.9 1107.8 11314.0 11923.6 12076.6 12078.1 12163.6 664845.0 677517.0 677784.0 687508.0 710318.0 80483.6 110281.0 112400.4 113492.0 113887.4 962.6 964.9 990.1 991.2 997.0 18320.9 18638.3 18638.5 18815.0 18823.5 46269.3 46842.3 46980.5 47915.3 48860.3 66631.7 67516.3 70009.6 73405.0 74003.3 9349.7 10039.1 10050.1 10214.1 10264.4 14074.6 14845.6 15517.1 15652.4 15944.3 5833.7 9502.0 10532.3 12815.2 12871.9 5677.5 10205.9 12499.5 12560.4 12808.5 12641.3 12815.4 12832.9 12871.8 13337.9 9792.1 9995.9 10030.3 10099.5 10155.0 10507.7 12400.0 12418.4 12600.0 12742.7 16:46:20 INFO - PROCESS | 30675 | 16:46:20 INFO - PROCESS | 30675 | [#3] mootools.html Cycles:180 Average:5840.05 Median:5332.33 stddev:3237.65 (60.7%) stddev-sans-first:3230.43 16:46:20 INFO - PROCESS | 30675 | Values: 1516.8 1524.1 1529.6 1544.8 1549.1 8546.7 9125.0 9136.8 9139.5 9141.5 7592.5 7777.6 7778.4 8694.8 9065.0 2488.7 2554.0 2556.4 2560.9 2562.7 2533.0 2563.6 2567.3 2583.8 2584.8 2505.4 2506.4 2529.1 2530.8 2534.5 2355.9 2367.3 2387.5 2394.0 2477.3 2409.1 2415.2 2469.3 2470.0 2470.2 9100.0 9174.0 9174.7 9181.2 9184.8 5375.6 5513.7 5520.9 5522.3 5525.2 3425.7 3491.9 3493.2 3500.3 3580.6 1407.3 1444.2 1459.5 1469.9 1502.1 11929.9 12155.1 12310.8 12415.0 12662.5 4614.8 4713.1 4795.5 4829.9 4922.6 9684.4 9695.7 9722.6 9730.9 9734.0 5459.3 5473.1 5473.5 5475.1 5476.9 4277.2 4978.8 5044.5 5159.8 5217.6 3781.2 3844.7 3855.6 3898.3 3920.3 1195.2 1196.8 1206.7 1210.9 1219.7 828.5 843.8 845.5 872.3 874.2 6150.6 6240.5 6258.8 6361.1 6417.4 648.1 657.5 664.4 697.4 697.5 4215.8 4281.9 4358.6 4380.6 4395.5 10540.4 10919.3 10936.1 10947.7 11027.7 10695.7 10868.6 10897.2 10907.1 10970.8 8195.7 8495.6 8502.7 8505.6 8505.8 6004.5 6071.9 6102.3 6131.4 6143.8 9432.5 10036.5 10055.7 10082.6 10096.9 9860.4 10076.4 10117.3 10167.6 10179.5 7189.5 7574.5 7987.0 7997.4 8127.1 8638.5 8772.3 8775.2 8778.6 8821.5 7194.7 7205.1 7298.1 7393.3 7451.1 7451.5 7456.4 7460.7 7466.3 7513.1 6509.3 6539.9 6593.4 6597.8 6614.1 5480.8 5480.8 5528.1 5565.5 5607.4 5269.4 5283.4 5323.0 5341.7 5389.2 16:46:20 INFO - PROCESS | 30675 | 16:46:20 INFO - PROCESS | 30675 | [#4] prototype.html Cycles:180 Average:4676.13 Median:5313.87 stddev:1320.30 (24.8%) stddev-sans-first:1284.60 16:46:20 INFO - PROCESS | 30675 | Values: 410.9 417.6 423.1 431.5 438.1 5271.2 5303.9 5341.8 5342.7 5351.3 5052.8 5140.6 5180.9 5230.9 5280.8 4225.7 4233.0 4241.4 4245.3 4260.6 4269.3 4280.5 4280.7 4294.3 4295.5 3988.8 4063.3 4230.8 4239.7 4284.9 4216.9 4221.2 4227.5 4232.2 4266.4 3874.9 3875.8 3879.3 3885.7 3896.2 5104.1 5156.8 5163.9 5216.3 5219.8 4895.8 4928.9 4950.2 4962.2 4985.9 5608.9 5609.3 5641.7 5655.2 5661.5 3957.6 4148.5 4151.0 4384.8 4405.8 5691.3 5717.8 5731.8 5735.0 5754.5 4199.9 4219.2 4227.1 4227.8 4258.7 4220.3 4257.3 4298.7 4311.0 4316.1 4762.0 4778.5 4810.8 4825.5 4836.0 5542.3 5547.8 5578.5 5579.6 5606.2 1401.8 1425.1 1432.5 1435.3 1439.7 963.8 971.5 980.7 991.8 995.2 5306.3 5313.8 5314.0 5325.4 5341.9 5491.7 5510.0 5516.5 5519.8 5522.8 5152.4 5292.3 5293.9 5302.7 5303.3 2879.0 2883.7 2884.2 2896.9 2920.6 5436.2 5641.9 5660.5 5700.2 5729.6 5548.6 5564.5 5566.0 5613.4 5643.5 5705.6 5714.3 5742.7 5747.6 5751.7 5212.3 5455.5 5468.3 5469.8 5478.4 5388.3 5397.9 5416.1 5432.3 5447.6 5550.8 5580.6 5684.5 5716.9 5726.3 4064.7 4085.4 4100.1 4114.4 4119.3 5500.0 5502.7 5539.6 5542.7 5609.5 5287.4 5391.6 5445.3 5468.7 5480.4 5566.3 5585.5 5610.9 5614.6 5620.9 5355.4 5510.9 5558.9 5602.9 5611.5 5431.6 5569.0 5577.9 5587.2 5591.0 5458.2 5476.4 5478.9 5480.6 5492.9 16:46:20 INFO - PROCESS | 30675 | 16:46:20 INFO - PROCESS | 30675 | [#5] yui.html Cycles:180 Average:17437.14 Median:4907.15 stddev:22023.08 (448.8%) stddev-sans-first:22049.53 16:46:20 INFO - PROCESS | 30675 | Values: 824.0 827.4 906.8 907.0 950.1 14057.6 14905.0 14907.2 14915.2 14920.3 14198.9 14495.0 14505.3 14520.9 14526.5 706.6 723.9 799.0 821.6 828.6 814.5 827.5 827.6 828.8 828.9 861.3 861.4 861.5 861.8 862.0 740.7 756.0 846.9 863.3 864.0 632.0 632.3 632.5 632.9 637.2 14109.2 14326.1 14330.5 14368.1 14375.9 14376.6 15158.1 15172.8 15336.1 15640.9 13937.4 14155.6 14262.1 14270.1 14497.1 4693.8 4715.2 4733.1 4766.0 4868.3 64437.0 65551.7 67256.3 78723.0 85509.0 11530.0 11795.6 11816.4 11819.9 12012.5 23758.3 23862.3 24089.6 24187.0 24213.6 8889.2 8962.6 9008.9 9009.7 9127.6 4764.4 4776.5 4946.0 4970.1 5061.6 3671.9 3743.3 3744.0 3749.5 3750.7 616.4 631.0 640.9 641.9 642.6 790.5 797.9 799.2 800.7 842.2 9723.0 10180.9 10464.0 10842.5 10866.6 739.6 750.0 757.4 774.1 805.1 5118.2 5144.9 5178.6 5186.2 5213.6 77405.0 77957.2 78067.6 80685.0 81243.2 56674.7 58511.0 58825.7 64767.7 71945.0 63753.4 65105.7 65284.7 65347.7 65426.7 9449.3 9837.5 9889.9 9926.5 9951.7 45071.5 45309.5 45608.8 46606.8 46841.5 56437.0 58374.4 58434.7 58927.0 60396.4 10599.3 10627.5 10718.7 10773.2 11134.5 12843.6 12958.7 13036.7 13085.4 13123.5 12173.9 12182.2 12198.2 12296.6 12477.3 11944.1 12047.2 12101.0 12173.1 12214.3 12109.3 12130.9 12184.6 12361.8 12409.8 10428.2 10469.9 10773.4 10910.6 10978.9 10151.8 10231.4 10313.9 10372.9 10387.4 16:46:20 INFO - PROCESS | 30675 | -------- Summary: end -------- 16:46:20 INFO - PROCESS | 30675 | 16:46:21 INFO - TEST-INFO | 30675: exit 0 16:46:21 INFO - TEST-OK | dromaeo_css | took 1113284ms 16:46:21 INFO - TEST-START | kraken 16:46:21 INFO - operating with platform_type : linux_ 16:46:21 INFO - Initialising browser for kraken test... 16:46:21 INFO - TEST-INFO | started process 30992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfFtikl/profile http://localhost:54360/getInfo.html) 16:46:25 INFO - PROCESS | 30992 | __metrics Screen width/height:1600/1200 16:46:25 INFO - PROCESS | 30992 | colorDepth:24 16:46:25 INFO - PROCESS | 30992 | Browser inner width/height: 1024/697 16:46:25 INFO - PROCESS | 30992 | __metrics 16:46:25 INFO - PROCESS | 30992 | 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" 16:46:25 INFO - PROCESS | 30992 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:46:26 INFO - PROCESS | 30992 | console.error: PushService: 16:46:26 INFO - PROCESS | 30992 | stateChangeProcessEnqueue: Error transitioning state 16:46:26 INFO - PROCESS | 30992 | UnknownError 16:46:26 INFO - TEST-INFO | 30992: exit 0 16:46:26 INFO - Browser initialized. 16:46:26 INFO - Running cycle 1/1 for kraken test... 16:46:26 INFO - TEST-INFO | started process 31085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfFtikl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:38 INFO - PROCESS | 31085 | RSS: Main: 141320192 16:46:38 INFO - PROCESS | 31085 | 16:46:41 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54360/tests/kraken/driver.html?testName=audio-beat-detection) 16:46:41 INFO - PROCESS | 31085 | RSS: Main: 185544704 16:46:41 INFO - PROCESS | 31085 | 16:46:44 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54360/tests/kraken/driver.html?testName=audio-dft) 16:46:44 INFO - PROCESS | 31085 | RSS: Main: 175800320 16:46:44 INFO - PROCESS | 31085 | 16:46:47 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54360/tests/kraken/driver.html?testName=audio-fft) 16:46:48 INFO - PROCESS | 31085 | RSS: Main: 267366400 16:46:48 INFO - PROCESS | 31085 | 16:46:50 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54360/tests/kraken/driver.html?testName=audio-oscillator) 16:46:51 INFO - PROCESS | 31085 | RSS: Main: 173469696 16:46:51 INFO - PROCESS | 31085 | 16:46:53 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54360/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:46:53 INFO - PROCESS | 31085 | RSS: Main: 176185344 16:46:53 INFO - PROCESS | 31085 | 16:46:56 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54360/tests/kraken/driver.html?testName=imaging-darkroom) 16:46:57 INFO - PROCESS | 31085 | RSS: Main: 215121920 16:46:57 INFO - PROCESS | 31085 | 16:47:00 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54360/tests/kraken/driver.html?testName=imaging-desaturate) 16:47:01 INFO - PROCESS | 31085 | RSS: Main: 212885504 16:47:01 INFO - PROCESS | 31085 | 16:47:03 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54360/tests/kraken/driver.html?testName=json-parse-financial) 16:47:04 INFO - PROCESS | 31085 | RSS: Main: 211537920 16:47:04 INFO - PROCESS | 31085 | 16:47:05 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54360/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:47:06 INFO - PROCESS | 31085 | RSS: Main: 173961216 16:47:06 INFO - PROCESS | 31085 | 16:47:08 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54360/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:47:08 INFO - PROCESS | 31085 | RSS: Main: 180809728 16:47:08 INFO - PROCESS | 31085 | 16:47:10 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54360/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:47:11 INFO - PROCESS | 31085 | RSS: Main: 187953152 16:47:11 INFO - PROCESS | 31085 | 16:47:14 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:47:14 INFO - PROCESS | 31085 | RSS: Main: 197251072 16:47:14 INFO - PROCESS | 31085 | 16:47:17 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:47:18 INFO - PROCESS | 31085 | RSS: Main: 193589248 16:47:18 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | Cycle 1(1): loaded http://localhost:54360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54360/tests/kraken/driver.html?testName=ai-astar) 16:47:19 INFO - PROCESS | 31085 | RSS: Main: 245686272 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | __start_tp_report 16:47:19 INFO - PROCESS | 31085 | _x_x_mozilla_page_load 16:47:19 INFO - PROCESS | 31085 | _x_x_mozilla_page_load_details 16:47:19 INFO - PROCESS | 31085 | |i|pagename|runs| 16:47:19 INFO - PROCESS | 31085 | |0;ai-astar;110;113;111;112;111;112;112;110;111;110 16:47:19 INFO - PROCESS | 31085 | |1;audio-beat-detection;140;118;118;164;119;121;123;117;146;123 16:47:19 INFO - PROCESS | 31085 | |2;audio-dft;161;160;161;161;159;160;161;160;160;160 16:47:19 INFO - PROCESS | 31085 | |3;audio-fft;76;75;76;111;75;76;76;75;91;74 16:47:19 INFO - PROCESS | 31085 | |4;audio-oscillator;82;83;110;83;83;84;108;84;83;100 16:47:19 INFO - PROCESS | 31085 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;116;116 16:47:19 INFO - PROCESS | 31085 | |6;imaging-darkroom;147;146;147;147;147;147;147;146;147;146 16:47:19 INFO - PROCESS | 31085 | |7;imaging-desaturate;96;95;96;95;97;95;96;96;95;96 16:47:19 INFO - PROCESS | 31085 | |8;json-parse-financial;48;49;51;48;48;51;50;48;48;50 16:47:19 INFO - PROCESS | 31085 | |9;json-stringify-tinderbox;64;64;63;63;64;64;63;64;64;65 16:47:19 INFO - PROCESS | 31085 | |10;stanford-crypto-aes;76;77;76;77;75;76;75;75;83;76 16:47:19 INFO - PROCESS | 31085 | |11;stanford-crypto-ccm;130;121;141;120;122;121;121;128;157;123 16:47:19 INFO - PROCESS | 31085 | |12;stanford-crypto-pbkdf2;154;157;155;159;155;157;158;155;154;158 16:47:19 INFO - PROCESS | 31085 | |13;stanford-crypto-sha256-iterative;63;60;61;63;60;64;62;61;60;59 16:47:19 INFO - PROCESS | 31085 | __end_tp_report 16:47:19 INFO - PROCESS | 31085 | __start_cc_report 16:47:19 INFO - PROCESS | 31085 | _x_x_mozilla_cycle_collect,1530 16:47:19 INFO - PROCESS | 31085 | __end_cc_report 16:47:19 INFO - PROCESS | 31085 | __startTimestamp1485996439913__endTimestamp 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | ------- Summary: start ------- 16:47:19 INFO - PROCESS | 31085 | Number of tests: 14 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.50 stddev:1.03 (0.9%) stddev-sans-first:1.00 16:47:19 INFO - PROCESS | 31085 | Values: 110.0 113.0 111.0 112.0 111.0 112.0 112.0 110.0 111.0 110.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:123.00 stddev:15.84 (12.9%) stddev-sans-first:16.28 16:47:19 INFO - PROCESS | 31085 | Values: 140.0 118.0 118.0 164.0 119.0 121.0 123.0 117.0 146.0 123.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 16:47:19 INFO - PROCESS | 31085 | Values: 161.0 160.0 161.0 161.0 159.0 160.0 161.0 160.0 160.0 160.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:11.81 (15.5%) stddev-sans-first:12.41 16:47:19 INFO - PROCESS | 31085 | Values: 76.0 75.0 76.0 111.0 75.0 76.0 76.0 75.0 91.0 74.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:83.00 stddev:11.33 (13.7%) stddev-sans-first:11.65 16:47:19 INFO - PROCESS | 31085 | Values: 82.0 83.0 110.0 83.0 83.0 84.0 108.0 84.0 83.0 100.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:47:19 INFO - PROCESS | 31085 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:47:19 INFO - PROCESS | 31085 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 16:47:19 INFO - PROCESS | 31085 | Values: 96.0 95.0 96.0 95.0 97.0 95.0 96.0 96.0 95.0 96.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.50 stddev:1.29 (2.6%) stddev-sans-first:1.30 16:47:19 INFO - PROCESS | 31085 | Values: 48.0 49.0 51.0 48.0 48.0 51.0 50.0 48.0 48.0 50.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 16:47:19 INFO - PROCESS | 31085 | Values: 64.0 64.0 63.0 63.0 64.0 64.0 63.0 64.0 64.0 65.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:2.37 (3.1%) stddev-sans-first:2.50 16:47:19 INFO - PROCESS | 31085 | Values: 76.0 77.0 76.0 77.0 75.0 76.0 75.0 75.0 83.0 76.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:125.50 stddev:11.95 (9.5%) stddev-sans-first:12.66 16:47:19 INFO - PROCESS | 31085 | Values: 130.0 121.0 141.0 120.0 122.0 121.0 121.0 128.0 157.0 123.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:157.00 stddev:1.81 (1.2%) stddev-sans-first:1.74 16:47:19 INFO - PROCESS | 31085 | Values: 154.0 157.0 155.0 159.0 155.0 157.0 158.0 155.0 154.0 158.0 16:47:19 INFO - PROCESS | 31085 | 16:47:19 INFO - PROCESS | 31085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.50 stddev:1.64 (2.7%) stddev-sans-first:1.62 16:47:19 INFO - PROCESS | 31085 | Values: 63.0 60.0 61.0 63.0 60.0 64.0 62.0 61.0 60.0 59.0 16:47:19 INFO - PROCESS | 31085 | -------- Summary: end -------- 16:47:19 INFO - PROCESS | 31085 | 16:47:20 INFO - TEST-INFO | 31085: exit 0 16:47:21 INFO - TEST-OK | kraken | took 59947ms 16:47:21 INFO - SUITE-END | took 1173s 16:47:21 INFO - Completed test suite (00:19:33) 16:47:21 INFO - javascript benchmark 16:47:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3200.247941733693, 3226.8225247611385, 3247.431699452596, 3259.1852036990754, 3266.0854960611036, 5481.12302031675, 5564.0, 5567.916481252774, 5581.553475721943, 5618.719064046797, 5567.860803479915, 5590.049691552435, 5591.077472217089, 5600.327960644719, 5604.971975140119, 4935.2103663413955, 4960.305557221992, 4981.501849815026, 4992.575631071363, 5067.113255180348, 4944.456109827916, 4997.050560393532, 5040.495950404967, 5057.064443078024, 5082.288479612857, 4905.386826646669, 4925.630577706686, 4927.384076990376, 4938.407391113072, 5064.746762661871, 5028.974855125719, 5064.873378165576, 5068.239764035387, 5079.111155547765, 5106.617003724736, 4907.190313598252, 4976.377952755905, 5028.4971502849785, 5031.044101620717, 5044.092063428581, 5429.945700542983, 5460.208269800856, 5512.724363781835, 5521.917171242435, 5528.5577153828, 5973.492253158487, 5995.7901473448655, 6002.519798416116, 6006.459418652343, 6030.939690603125, 6026.638401695912, 6045.12345709874, 6056.303525094627, 6058.363871793486, 6085.513158947274, 5505.587080968903, 5508.44915508446, 5575.860603484945, 5623.184638227475, 5624.409437009137, 6118.314626315956, 6120.90429240112, 6127.628174126313, 6133.867031338107, 6138.615839526931, 5863.003289440805, 5917.733701983421, 5920.289565252111, 5923.4076592340425, 5933.614315069507, 5809.854753631109, 5825.155352473952, 5860.267466566679, 5988.191594134823, 6012.609180403259, 5832.475077242983, 5834.649921004669, 5885.028970219952, 5912.260967379078, 5922.970385148046, 5923.940760592339, 5925.05199168131, 5925.911111333334, 5926.614770039933, 5928.466438020512, 4528.139653465831, 4548.158590660738, 4588.632909367243, 4596.816127354935, 4613.354130421743, 4016.8995775105855, 4036.65688416482, 4051.5745846685672, 4086.427900093989, 4111.280525908014, 5820.679862607512, 5820.854478637983, 5822.592418530747, 5823.126531020296, 5830.854228644318, 5741.885162296814, 5778.162166485836, 5884.382139875337, 5949.732262048132, 6004.729787159588, 5722.227499287543, 5787.681677507693, 5795.362510123883, 5811.389804070512, 5822.970885145547, 5101.668391554537, 5102.872428189251, 5105.33630628016, 5110.335656364723, 5113.207452844815, 6006.639601623917, 6052.636841789506, 6224.502039836802, 6264.5301602380005, 6265.0602409638, 5931.228940237742, 5995.520358371407, 6002.609830361012, 6054.75780968774, 6056.7274472649715, 6291.804045015356, 6307.526935479949, 6311.2426508819235, 6325.146105275729, 6330.430261276507, 5762.0204565223175, 5912.260967379078, 5972.850678733066, 5988.850278742892, 6001.715916119608, 5892.440218179266, 5894.734736936763, 5938.524918006463, 5944.821655350346, 6028.487578555872, 5827.155062515996, 5866.735996880066, 5885.47030767233, 5888.941110588839, 5893.852653683693, 5852.736626851717, 5853.473187413153, 5857.882842343214, 5859.121131830259, 5861.882762344814, 5615.831525054255, 5722.0, 5728.54171666274, 5759.049756790083, 5775.711214439178, 5829.8251052468495, 5840.123981402654, 5858.853528661817, 5875.676837773793, 5878.735456904535, 5710.942890571041, 5714.20001199824, 5719.342275638355, 5723.828285151452, 5730.856728581819], "value": 5497.767307828932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2401765695765, 615.9106929495223, 618.9288231853338, 651.6448535548122, 651.664392837689, 36860.81569592152, 48207.276890846624, 49679.0, 49782.75108624456, 49810.50189498104, 52869.0, 53355.0, 53402.19896701543, 53448.0, 53482.73258633701, 8616.26761725254, 9231.999999999984, 9394.013628569004, 9403.059694030611, 9413.670521531714, 8768.69309574165, 10891.891081089207, 11131.833022504668, 11152.553897844116, 11551.595694150707, 11345.489452974636, 11409.030232430254, 11413.372264525447, 11414.71463213422, 11427.657170284905, 11220.0, 11273.830892536618, 11303.943480282629, 11306.152038597138, 11308.943455282671, 11037.558497660084, 11196.552137914474, 11199.608013719562, 11200.607978720705, 11201.215914885961, 49272.01455970861, 49530.50469495331, 49624.0, 49633.25550116715, 49682.50317496815, 4338.349247612852, 4444.177827101997, 4522.276435770294, 4536.274196128604, 4716.080364328957, 33177.0, 33370.49944250838, 33445.6655433445, 33700.98897033093, 34699.653003469895, 4672.579467847876, 4677.7193368398, 4699.271612900006, 4707.976460117712, 4812.0, 354257.0, 356019.0, 356251.0, 356459.0, 357628.21185894165, 62725.686371568765, 62871.0, 62900.37099629037, 63099.6845015772, 63182.0, 66512.66743666347, 66554.33445665578, 66641.33358666352, 66806.66596667083, 67453.0, 18951.052447377577, 19338.0, 19362.128704208346, 19375.612487750448, 19394.933278669807, 14204.0, 14601.926990365193, 14801.333939972727, 15036.924815375853, 15257.389704411698, 19327.90336048311, 20426.285080022128, 20623.175072997212, 20627.4843128923, 20785.168593256403, 7256.528325658815, 7295.927040729631, 7321.572293402842, 7413.851722965511, 7508.737194198176, 1003.1272792670278, 1012.9746756331003, 1022.8158931392272, 1025.7692019295598, 1029.9794004119876, 34664.480032799525, 34920.0, 35556.73319201712, 35556.82221588876, 35688.286234275685, 1096.1833434091493, 1134.773045390925, 1135.8693750218665, 1158.2992289664633, 1169.0939521870448, 15820.841791581937, 16178.514644560682, 16199.433019844484, 16294.348226070824, 16470.75293870593, 505563.0, 522549.0, 526364.0, 526505.0, 527221.4555708864, 60775.392246076975, 61280.0, 61293.69353153206, 61374.0, 61613.07580386298, 1469.9412023519153, 1473.9484118055816, 1483.7774333849793, 1497.1316636350891, 1520.467836257301, 28785.0, 30426.543601845548, 30466.390672186877, 30621.54067689031, 30944.381112378076, 51317.0, 52723.20915186352, 53136.20295695645, 53143.46856531385, 53150.4684953161, 453685.0, 454492.0, 454741.0, 455450.0, 456953.0, 29752.553711694774, 29783.851080744458, 30017.0, 30702.385952281275, 30702.84648576743, 48763.268550972476, 48906.0, 49097.01805963789, 50209.497905020486, 50333.49666503288, 38836.41745373765, 41153.588464114975, 41621.79189104035, 42042.57957420387, 42315.15369692527, 39671.40492892667, 40130.799346003085, 40365.79817100896, 44106.11787764163, 46084.0, 42259.7887010563, 42507.57492425036, 42531.1493770129, 42584.14831703411, 42765.57234427616, 35267.47098793572, 37554.24891502209, 37684.43473347847, 37879.43180852345, 38274.0, 28410.715892840806, 28418.573721393783, 28611.713882860906, 28625.570616441186, 28756.42487150287], "value": 21725.26704658692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.51720383927784, 452.25829639391407, 459.4027763906921, 460.7488918539395, 472.48263151848715, 20060.598788024232, 21537.56924861502, 21731.0, 22110.88944555279, 22225.999830007648, 22271.665925011097, 22471.438214044658, 22498.88750556249, 22692.319230423072, 22841.31476055717, 5271.5782737381105, 6079.118527813464, 6285.3400392958765, 6296.968515157418, 6310.652914089723, 6184.969075154618, 6254.124422580842, 6254.312025677172, 6274.090256912745, 6277.560570760049, 6012.75948962041, 6123.601965872204, 6183.690815459209, 6198.752049917998, 6200.348963358828, 5998.640081595118, 6127.387261273881, 6142.570020098573, 6201.131841542187, 6202.813915582517, 5513.338399392059, 5544.63959842613, 5552.666839989613, 5553.527950124204, 5553.6390134641115, 21497.785022149736, 24338.391540211458, 24634.137805176913, 25358.873205634038, 25605.48789024228, 2668.3329167708075, 2791.5393959996577, 2800.327921298894, 2805.509035918706, 2828.1656911211035, 11279.943600282028, 11404.087672986141, 11525.592263902405, 11539.019183369424, 11922.821157682642, 2020.8383329333617, 2045.9386218413472, 2047.692846073101, 2064.1227478321803, 2075.771665116851, 98549.0, 99063.0, 99430.0, 100540.49729751378, 103779.0, 11438.313701177789, 12043.277403355827, 12780.61658150257, 12807.61577152687, 13093.476260949456, 15251.694966100838, 15825.446109386115, 16066.43767468133, 16701.63993118059, 16965.830341696674, 9147.222486088624, 9164.450132992042, 9242.72271831846, 9251.861222081674, 9385.765355866159, 9045.864312035324, 9088.772780680403, 9112.681056163136, 9278.67524636648, 9282.48946307946, 4992.725400102957, 5005.724685142352, 5021.322121513549, 5119.283300337956, 5205.6616319939085, 2156.6628690211855, 2162.5782972320562, 2163.8377121715935, 2208.8012078912975, 2263.852849564773, 1093.7211011192096, 1096.1011970184372, 1101.2456467319912, 1116.2353787655481, 1129.3957732613176, 20324.69512957307, 21730.239441619466, 21758.78241217599, 21837.890810545847, 21887.890560547094, 1074.6561100447782, 1076.2304951959386, 1100.1144079016308, 1105.8728246251785, 1107.8338249262674, 11314.0, 11923.642290731292, 12076.577319793765, 12078.094142939315, 12163.635090947286, 664845.0, 677517.0, 677784.0, 687508.0, 710318.0, 80483.59758201172, 110281.0, 112400.43799780948, 113492.0, 113887.43056284665, 962.6149540183842, 964.9469279189572, 990.0742805476903, 991.2119864707574, 996.9711636819038, 18320.900745955285, 18638.34765783245, 18638.53403664919, 18815.0, 18823.529411764815, 46269.30596041129, 46842.29736553886, 46980.53019469762, 47915.281270780266, 48860.26709599288, 66631.66684166742, 67516.32483675101, 70009.64995174992, 73405.0, 74003.25996740178, 9349.672761453316, 10039.146672532625, 10050.09549140581, 10214.080732733792, 10264.435456049989, 14074.577762667137, 14845.628859278173, 15517.146556939477, 15652.37390504367, 15944.282507287431, 5833.67914764692, 9502.0, 10532.315399499315, 12815.231086134861, 12871.871281287442, 5677.460641239076, 10205.877353490961, 12499.500019999097, 12560.371981401076, 12808.487660493476, 12641.304728240035, 12815.42330595144, 12832.935835320764, 12871.806922895978, 13337.933310333774, 9792.118709315911, 9995.900040999497, 10030.29787914839, 10099.495025248854, 10155.0, 10507.684769456928, 12400.0, 12418.441170147184, 12600.0, 12742.745145097231], "value": 10177.867919715114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.848315168484, 1524.0931645670828, 1529.5717199184226, 1544.8068991376078, 1549.0782984124446, 8546.743597692064, 9125.0, 9136.817263654732, 9139.543022848857, 9141.542922853863, 7592.54444733315, 7777.611119444019, 7778.377729781618, 8694.826103477943, 9064.954675226614, 2488.651588777568, 2554.0294688018525, 2556.3736884463333, 2560.8591527465983, 2562.7181010088875, 2532.987335063331, 2563.6026415905562, 2567.3453269416273, 2583.8320509166842, 2584.7673709366154, 2505.3736565858535, 2506.385935445818, 2529.0768869362732, 2530.8354956927833, 2534.51844149611, 2355.882205889707, 2367.30164601443, 2387.522495500898, 2393.9760602393926, 2477.269205584348, 2409.120670955106, 2415.1909110448023, 2469.296250568579, 2469.9753002469924, 2470.2465747946867, 9100.0, 9173.954130229373, 9174.67888623895, 9181.173694367471, 9184.770380740469, 5375.596830237748, 5513.724313784295, 5520.91718624221, 5522.30971128609, 5525.171224316345, 3425.7349599748472, 3491.9476207856646, 3493.2314890724, 3500.264944361687, 3580.6214607376087, 1407.268220525321, 1444.2056868722161, 1459.5183589415574, 1469.8824094072556, 1502.0762231227825, 11929.880701193051, 12155.088368372319, 12310.81533776994, 12415.0, 12662.49350026007, 4614.792334344896, 4713.128071306819, 4795.472498025214, 4829.855104346805, 4922.58158056562, 9684.370515916444, 9695.70912872615, 9722.61109555624, 9730.902690973142, 9734.0, 5459.2629994950175, 5473.0969390050195, 5473.507384335429, 5475.123980163235, 5476.863078423071, 4277.2087163874785, 4978.800847966041, 5044.470330615306, 5159.793608255703, 5217.556507696812, 3781.1681430085337, 3844.7308688391545, 3855.63371479709, 3898.2593307271527, 3920.2943470175073, 1195.1753290229713, 1196.7845787758288, 1206.7224538356227, 1210.891019808204, 1219.664592237142, 828.5153185386616, 843.7679638099572, 845.4842546046906, 872.2542226396466, 874.2350443362059, 6150.600210986271, 6240.500759939194, 6258.780942666985, 6361.141245931833, 6417.358264173638, 648.1088503307951, 657.4838751579987, 664.378805816563, 697.396751809681, 697.4524997876642, 4215.810288537024, 4281.871543853689, 4358.56414358568, 4380.649548036149, 4395.516493185747, 10540.420276884844, 10919.290246134135, 10936.125109991182, 10947.671569852917, 11027.669169924915, 10695.679129626124, 10868.565257389773, 10897.182711296684, 10907.072898803532, 10970.780584388267, 8195.67217311301, 8495.617697203641, 8502.744917652604, 8505.61724722389, 8505.829883402297, 6004.519638428827, 6071.939280607314, 6102.328743838086, 6131.448169664752, 6143.84640383994, 9432.481213533321, 10036.548355324174, 10055.74860628461, 10082.647107351208, 10096.949515252376, 9860.359076659994, 10076.395416275047, 10117.29178957466, 10167.644132455625, 10179.541920613443, 7189.460790440633, 7574.545527268381, 7986.960065199637, 7997.360211183208, 8127.065387480279, 8638.481691098554, 8772.342074344322, 8775.210231079234, 8778.561071946506, 8821.514816684887, 7194.748183813542, 7205.099362579677, 7298.124225093023, 7393.320688388021, 7451.105867295959, 7451.478396512192, 7456.366208872089, 7460.66427010775, 7466.328030477283, 7513.1359893612935, 6509.349065093453, 6539.869202616016, 6593.439557637655, 6597.80206593803, 6614.140161778938, 5480.753366098455, 5480.835574932758, 5528.087865502308, 5565.526930210977, 5607.355154157324, 5269.394019687785, 5283.418823929288, 5323.0, 5341.65279256847, 5389.21856330822], "value": 4682.883115016156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.87262948485954, 417.57824597156883, 423.08824483238624, 431.4649834205584, 438.0669174657978, 5271.209318602211, 5303.867403314919, 5341.813036543722, 5342.732863356831, 5351.304330437048, 5052.837847295124, 5140.588752899768, 5180.922286165711, 5230.947690523094, 5280.788768449257, 4225.661947044229, 4233.0, 4241.384999175118, 4245.299525578276, 4260.595243451867, 4269.252880745873, 4280.529141794415, 4280.72175308604, 4294.334378171388, 4295.4777082792125, 3988.8205030773684, 4063.3295506241584, 4230.830766769341, 4239.660827133837, 4284.871453856389, 4216.85241016566, 4221.155768846213, 4227.513835908864, 4232.217039847638, 4266.360045993095, 3874.8837534874, 3875.786831724254, 3879.301725689375, 3885.7279990400684, 3896.201278737852, 5104.106781313292, 5156.819511317086, 5163.870903227412, 5216.2958000669805, 5219.791208351661, 4895.755212239374, 4928.852134435972, 4950.183219768734, 4962.156433406293, 4985.881000574741, 5608.915866262009, 5609.270794796691, 5641.661500309953, 5655.179998900177, 5661.547076233891, 3957.56466788653, 4148.481439820022, 4151.003759097825, 4384.758838263894, 4405.845795397177, 5691.3170419549915, 5717.771289148471, 5731.770729170828, 5734.971325143348, 5754.539636829044, 4199.895002624959, 4219.156168766259, 4227.112306415687, 4227.795078402641, 4258.723182993095, 4220.345846393814, 4257.318828987347, 4298.677599180074, 4311.0, 4316.093620339701, 4761.999960016801, 4778.474367819537, 4810.759462026885, 4825.469198388175, 4835.95164048362, 5542.334919809568, 5547.833564993057, 5578.525825304894, 5579.553635709133, 5606.187102870143, 1401.8457969623332, 1425.137791636066, 1432.4556668466125, 1435.3182238436868, 1439.6760728835927, 963.8457846744487, 971.4705485510414, 980.6616717232544, 991.82468774501, 995.2038369304672, 5306.310179676694, 5313.760880760375, 5313.973430132824, 5325.4142044375085, 5341.919871201935, 5491.670499770026, 5510.0, 5516.503514683617, 5519.779208831682, 5522.784987302787, 5152.355955505562, 5292.311999440125, 5293.947060529423, 5302.708351040653, 5303.28405665238, 2878.956815647767, 2883.6539615246306, 2884.206843118159, 2896.898608548691, 2920.605718228012, 5436.238926550286, 5641.858953526113, 5660.518855897295, 5700.209360775121, 5729.627574207663, 5548.611597188239, 5564.499195072382, 5566.0499935034495, 5613.382527921925, 5643.463870932255, 5705.600607957486, 5714.342850572238, 5742.7029188325005, 5747.620571062831, 5751.683657398799, 5212.348456442945, 5455.536279416294, 5468.2891224142195, 5469.75386107634, 5478.424765399575, 5388.272583201375, 5397.898985458861, 5416.133418652997, 5432.311006052029, 5447.591430642638, 5550.833474995757, 5580.609357344947, 5684.516816070681, 5716.857078573069, 5726.255586773693, 4064.7154699170774, 4085.3667681508223, 4100.138970816042, 4114.354258296586, 4119.279126152971, 5500.0, 5502.724863756716, 5539.612227144061, 5542.695151766691, 5609.467100625434, 5287.365516138088, 5391.622586418913, 5445.292112025411, 5468.671879687232, 5480.410331233049, 5566.332040155207, 5585.497305242385, 5610.915836262541, 5614.550835933197, 5620.85947851307, 5355.384130824849, 5510.862228444321, 5558.888822223614, 5602.853888122679, 5611.466910643482, 5431.619786614899, 5569.0, 5577.860553486195, 5587.161925711176, 5590.972045139748, 5458.208559758733, 5476.440313796064, 5478.863028424162, 5480.561555075505, 5492.928878868742], "value": 4277.851648965363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.0276473760963, 827.4290739389817, 906.8005038891445, 906.9501177435243, 950.1401231885142, 14057.648558786035, 14905.03117297375, 14907.180105094229, 14915.179665118414, 14920.253987300619, 14198.858011419883, 14495.0, 14505.347259373328, 14520.85479145211, 14526.491572794954, 706.6290197646251, 723.8914162875584, 798.9600519974007, 821.5522540215596, 828.573284758347, 814.5072231300067, 827.4704189318811, 827.6317038917684, 828.772087675888, 828.8508068547659, 861.3195575495382, 861.4099341950753, 861.4917198852676, 861.7543999960012, 861.9655213791441, 740.6815069520077, 756.0134025097246, 846.8729690546405, 863.2662237098448, 863.9654413823471, 631.9715612797389, 632.3455223843346, 632.4750457120625, 632.9493640508748, 637.2384999925091, 14109.153450792985, 14326.068805527608, 14330.49843255481, 14368.13791172533, 14375.928120359436, 14376.64058398538, 15158.090514569161, 15172.772408413883, 15336.079835209812, 15640.921795391065, 13937.372818223204, 14155.575332740034, 14262.072965257224, 14270.143791372448, 14497.057691250035, 4693.812247510095, 4715.1512727709, 4733.053389322149, 4766.022965292107, 4868.294097355899, 64437.0, 65551.67224163897, 67256.32743672549, 78722.99999999943, 85509.0, 11530.0, 11795.587154449724, 11816.35010074437, 11819.940900295443, 12012.519499219934, 23758.287251382488, 23862.284131476084, 24089.63865542018, 24187.0, 24213.63679544808, 8889.244414224733, 8962.596683149273, 9008.928081286058, 9009.684661036832, 9127.634894604274, 4764.380630518011, 4776.522347765195, 4946.0, 4970.130227210224, 5061.5950723942, 3671.8714844980295, 3743.3262012837404, 3744.045268456526, 3749.456328832304, 3750.6811920986474, 616.3866952382408, 630.9936900631027, 640.8942524483501, 641.8844607970517, 642.5534253693731, 790.5059337913804, 797.924197201265, 799.188823344306, 800.7117437722416, 842.2293601354814, 9723.0, 10180.898191018143, 10464.0, 10842.457877106113, 10866.61966831157, 739.6412739821183, 749.9587522686305, 757.3524636435878, 774.0633833061945, 805.0741647105758, 5118.155504341742, 5144.897102057937, 5178.559822415137, 5186.247994040843, 5213.6089793265655, 77405.0, 77957.220427795, 78067.60966195133, 80685.0, 81243.18756812357, 56674.71662641743, 58511.0, 58825.705871471226, 64767.67616161889, 71945.0, 63753.36246637567, 65105.67447162734, 65284.673576631816, 65347.67326163339, 65426.67286663536, 9449.338546301693, 9837.458939758095, 9889.851652225367, 9926.454045027303, 9951.701448956543, 45071.549284508044, 45309.546904530536, 45608.77195614001, 46606.76696616495, 46841.53158468508, 56437.0, 58374.4162558369, 58434.7078264623, 58927.0, 60396.39603603908, 10599.311044782064, 10627.468626568796, 10718.678439646512, 10773.19201059908, 11134.498947547541, 12843.614691559269, 12958.740825183255, 13036.739265214832, 13085.41115649779, 13123.475060997453, 12173.878261217274, 12182.208156469802, 12198.207116537396, 12296.569620063256, 12477.251364918135, 11944.112883654314, 12047.156699031335, 12101.0, 12173.147879648694, 12214.26714397139, 12109.273443593413, 12130.878691212974, 12184.63446096583, 12361.752764944831, 12409.813852792397, 10428.222324663633, 10469.895301046892, 10773.407462589634, 10910.61812836547, 10978.890211097787, 10151.847722284025, 10231.43727095017, 10313.9484302578, 10372.896271037192, 10387.428691422045], "value": 7320.179476314861, "unit": "score"}], "name": "dromaeo_css", "value": 7502.157179813404, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 111.0, 112.0, 111.0, 112.0, 112.0, 110.0, 111.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 118.0, 118.0, 164.0, 119.0, 121.0, 123.0, 117.0, 146.0, 123.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 159.0, 160.0, 161.0, 160.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 111.0, 75.0, 76.0, 76.0, 75.0, 91.0, 74.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 110.0, 83.0, 83.0, 84.0, 108.0, 84.0, 83.0, 100.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 51.0, 48.0, 48.0, 51.0, 50.0, 48.0, 48.0, 50.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 77.0, 75.0, 76.0, 75.0, 75.0, 83.0, 76.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 121.0, 141.0, 120.0, 122.0, 121.0, 121.0, 128.0, 157.0, 123.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 155.0, 159.0, 155.0, 157.0, 158.0, 155.0, 154.0, 158.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 61.0, 63.0, 60.0, 64.0, 62.0, 61.0, 60.0, 59.0], "value": 61.3, "unit": "score"}], "name": "kraken", "value": 1465.3000000000002, "alertThreshold": 2.0}]} 16:47:21 INFO - Return code: 0 16:47:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:47:21 ERROR - # TBPL SUCCESS # 16:47:21 INFO - Running post-action listener: _resource_record_post_action 16:47:21 INFO - [mozharness: 2017-02-02 00:47:21.210476Z] Finished run-tests step (success) 16:47:21 INFO - Running post-run listener: _resource_record_post_run 16:47:21 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370180096; Read time: 16; Write time: 227148 16:47:21 INFO - TinderboxPrint: CPU usage
13.0% 16:47:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:47:21 INFO - TinderboxPrint: I/O write bytes / time
370,180,096 / 227,148 16:47:21 INFO - TinderboxPrint: CPU idle
8,259.5 (87.0%) 16:47:21 INFO - TinderboxPrint: CPU user
1,192.7 (12.6%) 16:47:21 INFO - TinderboxPrint: Swap in / out
0 / 0 16:47:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117207040; Read time: 0; Write time: 91932 16:47:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252973056; Read time: 16; Write time: 135216 16:47:21 INFO - Running post-run listener: _upload_blobber_files 16:47:21 INFO - Blob upload gear active. 16:47:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:47:21 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 16:47:21 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'] 16:47:21 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 16:47:22 INFO - (blobuploader) - INFO - Open directory for files ... 16:47:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:47:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:47:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:26 INFO - (blobuploader) - INFO - Done attempting. 16:47:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:47:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:47:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:27 INFO - (blobuploader) - INFO - Done attempting. 16:47:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:47:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:47:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:28 INFO - (blobuploader) - INFO - Done attempting. 16:47:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:47:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:47:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:29 INFO - (blobuploader) - INFO - Done attempting. 16:47:29 INFO - (blobuploader) - INFO - Iteration through files over. 16:47:29 INFO - Return code: 0 16:47:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:47:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:47:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b41cda428ad3e97be50723be122a88ed4d6995544f7f8e9e3885102ce7e175e18ef539250c6bfda32767a1cd5650cc7ebb5ece153dbbd2e9e8ec1dee0eb7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae3b3e5fa28fd03279b182125c740cd11caa95f10b433676d12efca614bd147ea68d8c6af0816393aaa4744c78937fd9bc9b9c7e837e977cf25682b5dd009ae0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bdcfbd6cf587abb26fb47c18477e39f2e2b83fd002a81e99209136b67849403d00124c786a291e29e1cd0d75ee6c524e0f2b75c968323301c83a69382d19855", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c9d4fbbcdcf7c05af55dd12eddb4f8d0e13711ec7f1fd956575d98b5c2dbd7d7a0c60858b46dff82a651d306f074f9e28ba5ea537e4f4f828e0fc8f4093855f"} 16:47:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:47:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:47:29 INFO - Contents: 16:47:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b41cda428ad3e97be50723be122a88ed4d6995544f7f8e9e3885102ce7e175e18ef539250c6bfda32767a1cd5650cc7ebb5ece153dbbd2e9e8ec1dee0eb7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae3b3e5fa28fd03279b182125c740cd11caa95f10b433676d12efca614bd147ea68d8c6af0816393aaa4744c78937fd9bc9b9c7e837e977cf25682b5dd009ae0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bdcfbd6cf587abb26fb47c18477e39f2e2b83fd002a81e99209136b67849403d00124c786a291e29e1cd0d75ee6c524e0f2b75c968323301c83a69382d19855", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c9d4fbbcdcf7c05af55dd12eddb4f8d0e13711ec7f1fd956575d98b5c2dbd7d7a0c60858b46dff82a651d306f074f9e28ba5ea537e4f4f828e0fc8f4093855f"} 16:47:29 INFO - Running post-run listener: copy_logs_to_upload_dir 16:47:29 INFO - Copying logs to upload dir... 16:47:29 INFO - mkdir: /builds/slave/test/build/upload/logs 16:47:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.898302 ========= master_lag: 0.55 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-01 16:47:29.609996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 16:47:29.614390) ========= 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=41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364 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/d5b41cda428ad3e97be50723be122a88ed4d6995544f7f8e9e3885102ce7e175e18ef539250c6bfda32767a1cd5650cc7ebb5ece153dbbd2e9e8ec1dee0eb7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae3b3e5fa28fd03279b182125c740cd11caa95f10b433676d12efca614bd147ea68d8c6af0816393aaa4744c78937fd9bc9b9c7e837e977cf25682b5dd009ae0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bdcfbd6cf587abb26fb47c18477e39f2e2b83fd002a81e99209136b67849403d00124c786a291e29e1cd0d75ee6c524e0f2b75c968323301c83a69382d19855", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c9d4fbbcdcf7c05af55dd12eddb4f8d0e13711ec7f1fd956575d98b5c2dbd7d7a0c60858b46dff82a651d306f074f9e28ba5ea537e4f4f828e0fc8f4093855f"} build_url:https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/ZEbpYNOJT4WIARNT5A0gxA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b41cda428ad3e97be50723be122a88ed4d6995544f7f8e9e3885102ce7e175e18ef539250c6bfda32767a1cd5650cc7ebb5ece153dbbd2e9e8ec1dee0eb7d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae3b3e5fa28fd03279b182125c740cd11caa95f10b433676d12efca614bd147ea68d8c6af0816393aaa4744c78937fd9bc9b9c7e837e977cf25682b5dd009ae0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bdcfbd6cf587abb26fb47c18477e39f2e2b83fd002a81e99209136b67849403d00124c786a291e29e1cd0d75ee6c524e0f2b75c968323301c83a69382d19855", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c9d4fbbcdcf7c05af55dd12eddb4f8d0e13711ec7f1fd956575d98b5c2dbd7d7a0c60858b46dff82a651d306f074f9e28ba5ea537e4f4f828e0fc8f4093855f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 16:47:29.638656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 16:47:29.638946) ========= 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=41a7e32711b8e08598a63237000001d6-1485995211.774624-1893504364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 16:47:29.690608) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 16:47:29.690908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 16:47:29.694218) ========= ========= Total master_lag: 0.67 =========