builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1490285072.9 results: success (0) revision: 7fec8b804687f87447477a5759039a2be4d16796 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:32.902479) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:32.902883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:32.903150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:32.950869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:32.951247) ========= 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-1490285072.505970-148446718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 09:04:33-- 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% 214M=0s 2017-03-23 09:04:33 (214 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:33.079128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:33.079444) ========= 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-1490285072.505970-148446718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018407 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:33.138961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 09:04:33.139290) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7fec8b804687f87447477a5759039a2be4d16796 --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 7fec8b804687f87447477a5759039a2be4d16796 --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-1490285072.505970-148446718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 09:04:33,440 truncating revision to first 12 chars 2017-03-23 09:04:33,440 Setting DEBUG logging. 2017-03-23 09:04:33,440 attempt 1/10 2017-03-23 09:04:33,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7fec8b804687?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 09:04:34,492 unpacking tar archive at: mozilla-aurora-7fec8b804687/testing/mozharness/ program finished with exit code 0 elapsedTime=1.351948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 09:04:34.504302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:34.504633) ========= script_repo_revision: 7fec8b804687f87447477a5759039a2be4d16796 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:34.505033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:34.505313) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 09:04:34.514207) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-23 09:04:34.514533) ========= /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-1490285072.505970-148446718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:34 INFO - MultiFileLogger online at 20170323 09:04:34 in /builds/slave/test 09:04:34 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 09:04:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:34 INFO - {'append_to_log': False, 09:04:34 INFO - 'base_work_dir': '/builds/slave/test', 09:04:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:04:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:34 INFO - 'branch': 'Mozilla-Aurora', 09:04:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:34 INFO - 'config_files': ('talos/linux_config.py',), 09:04:34 INFO - 'default_actions': ('clobber', 09:04:34 INFO - 'read-buildbot-config', 09:04:34 INFO - 'download-and-extract', 09:04:34 INFO - 'populate-webroot', 09:04:34 INFO - 'create-virtualenv', 09:04:34 INFO - 'install', 09:04:34 INFO - 'run-tests'), 09:04:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:34 INFO - 'download_minidump_stackwalk': True, 09:04:34 INFO - 'download_symbols': 'ondemand', 09:04:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:34 INFO - 'gecko_profile': False, 09:04:34 INFO - 'gecko_profile_interval': 0, 09:04:34 INFO - 'installer_path': 'installer.exe', 09:04:34 INFO - 'log_level': 'info', 09:04:34 INFO - 'log_name': 'talos', 09:04:34 INFO - 'log_to_console': True, 09:04:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:34 INFO - 'opt_config_files': (), 09:04:34 INFO - 'pip_index': False, 09:04:34 INFO - 'suite': 'dromaeojs', 09:04:34 INFO - 'system_bits': '32', 09:04:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:34 INFO - 'title': 'talos-linux64-ix-024', 09:04:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:34 INFO - 'use_talos_json': True, 09:04:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:34 INFO - 'work_dir': 'build'} 09:04:34 INFO - [mozharness: 2017-03-23 16:04:34.917605Z] Running clobber step. 09:04:34 INFO - Running pre-action listener: _resource_record_pre_action 09:04:34 INFO - Running main action method: clobber 09:04:34 INFO - rmtree: /builds/slave/test/build 09:04:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:35 INFO - Running post-action listener: _resource_record_post_action 09:04:35 INFO - [mozharness: 2017-03-23 16:04:35.917501Z] Finished clobber step (success) 09:04:35 INFO - [mozharness: 2017-03-23 16:04:35.917603Z] Running read-buildbot-config step. 09:04:35 INFO - Running pre-action listener: _resource_record_pre_action 09:04:35 INFO - Running main action method: read_buildbot_config 09:04:35 INFO - Using buildbot properties: 09:04:35 INFO - { 09:04:35 INFO - "project": "", 09:04:35 INFO - "product": "firefox", 09:04:35 INFO - "who": "cbook@mozilla.com", 09:04:35 INFO - "installer_path": "public/build/target.tar.bz2", 09:04:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:04:35 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:04:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:04:35 INFO - "stage_platform": "linux64-pgo", 09:04:35 INFO - "basedir": "/builds/slave/test", 09:04:35 INFO - "buildnumber": 847, 09:04:35 INFO - "platform": "ubuntu64_hw", 09:04:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:04:35 INFO - "slavebuilddir": "test", 09:04:35 INFO - "taskId": "bM9jrt2aTES7Sy-4Qq3u8Q", 09:04:35 INFO - "branch": "mozilla-aurora", 09:04:35 INFO - "script_repo_revision": "production", 09:04:35 INFO - "revision": "7fec8b804687f87447477a5759039a2be4d16796", 09:04:35 INFO - "slavename": "talos-linux64-ix-024", 09:04:35 INFO - "repo_path": "releases/mozilla-aurora" 09:04:35 INFO - } 09:04:35 INFO - Finding installer, test and symbols from parent task. 09:04:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bM9jrt2aTES7Sy-4Qq3u8Q'}, attempt #1 09:04:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bM9jrt2aTES7Sy-4Qq3u8Q'}, attempt #1 09:04:36 INFO - Task dependencies: XnpvdJqNT8-kRjsUsUY7vQ 09:04:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ'}, attempt #1 09:04:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.tar.bz2 09:04:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/test_packages.json 09:04:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.crashreporter-symbols.zip 09:04:37 INFO - Running post-action listener: _resource_record_post_action 09:04:37 INFO - [mozharness: 2017-03-23 16:04:37.324518Z] Finished read-buildbot-config step (success) 09:04:37 INFO - [mozharness: 2017-03-23 16:04:37.324735Z] Running download-and-extract step. 09:04:37 INFO - Running pre-action listener: _resource_record_pre_action 09:04:37 INFO - Running main action method: download_and_extract 09:04:37 INFO - mkdir: /builds/slave/test/build/tests 09:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:37 INFO - trying https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.test_packages.json 09:04:37 INFO - Downloading https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:04:37 INFO - Downloaded 896 bytes. 09:04:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:04:37 INFO - Using the following test package requirements: 09:04:37 INFO - {u'common': [u'target.common.tests.zip'], 09:04:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:04:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:04:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:04:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:04:37 INFO - u'mozbase': [u'target.common.tests.zip'], 09:04:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:04:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:04:37 INFO - u'web-platform': [u'target.common.tests.zip', 09:04:37 INFO - u'target.web-platform.tests.zip'], 09:04:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:04:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:04:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.common.tests.zip 09:04:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:04:37 INFO - Fetch https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.common.tests.zip into memory 09:04:39 INFO - Expected file size: 59534471 09:04:39 INFO - Obtained file size: 59534471 09:04:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:04:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.common.tests.zip 09:04:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:04:48 INFO - Fetch https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.common.tests.zip into memory 09:04:49 INFO - Expected file size: 59534471 09:04:49 INFO - Obtained file size: 59534471 09:05:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.talos.tests.zip 09:05:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:05:00 INFO - Fetch https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.talos.tests.zip into memory 09:05:01 INFO - Expected file size: 14404438 09:05:01 INFO - Obtained file size: 14404438 09:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:01 INFO - trying https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.tar.bz2 09:05:01 INFO - Downloading https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:05:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:05:02 INFO - Downloaded 66766847 bytes. 09:05:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.tar.bz2 09:05:02 INFO - mkdir: /builds/slave/test/properties 09:05:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:02 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:02 INFO - Contents: 09:05:02 INFO - build_url:https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.tar.bz2 09:05:02 INFO - Running post-action listener: _resource_record_post_action 09:05:02 INFO - Running post-action listener: set_extra_try_arguments 09:05:02 INFO - [mozharness: 2017-03-23 16:05:02.719889Z] Finished download-and-extract step (success) 09:05:02 INFO - [mozharness: 2017-03-23 16:05:02.719986Z] Running populate-webroot step. 09:05:02 INFO - Running pre-action listener: _resource_record_pre_action 09:05:02 INFO - Running main action method: populate_webroot 09:05:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:02 INFO - '--tppagecycles', 09:05:02 INFO - '7'], 09:05:02 INFO - 'tests': ['tsvgm']}}, 09:05:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:05:02 INFO - 'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:05:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:05:02 INFO - 'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['damp', 'tps']}, 09:05:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:05:02 INFO - 'tests': ['damp', 'tps']}, 09:05:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['dromaeo_dom']}, 09:05:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['basic_compositor_video']}, 09:05:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:05:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['a11yr', 09:05:02 INFO - 'ts_paint', 09:05:02 INFO - 'tpaint', 09:05:02 INFO - 'sessionrestore', 09:05:02 INFO - 'sessionrestore_no_auto_restore', 09:05:02 INFO - 'tabpaint']}, 09:05:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['tsvgx', 09:05:02 INFO - 'tsvgr_opacity', 09:05:02 INFO - 'tart', 09:05:02 INFO - 'tscrollx', 09:05:02 INFO - 'cart', 09:05:02 INFO - 'tsvg_static']}, 09:05:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:02 INFO - 'tsvgr_opacity', 09:05:02 INFO - 'tart', 09:05:02 INFO - 'tscrollx', 09:05:02 INFO - 'cart', 09:05:02 INFO - 'tsvg_static']}, 09:05:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:05:02 INFO - 'talos_options': ['--disable-e10s'], 09:05:02 INFO - 'tests': ['tp5o']}, 09:05:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:05:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:05:02 INFO - 'talos_options': ['--disable-e10s', 09:05:02 INFO - '--xperf_path', 09:05:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:02 INFO - 'tests': ['tp5n']}, 09:05:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:05:02 INFO - 'talos_options': ['--xperf_path', 09:05:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:02 INFO - 'tests': ['tp5n']}}, 09:05:02 INFO - 'talos.zip': {'path': '', 09:05:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:02 INFO - Running post-action listener: _resource_record_post_action 09:05:02 INFO - [mozharness: 2017-03-23 16:05:02.733509Z] Finished populate-webroot step (success) 09:05:02 INFO - [mozharness: 2017-03-23 16:05:02.733600Z] Running create-virtualenv step. 09:05:02 INFO - Running pre-action listener: _resource_record_pre_action 09:05:02 INFO - Running main action method: create_virtualenv 09:05:02 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:05:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:02 INFO - Using real prefix '/usr' 09:05:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:03 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:05 INFO - Installing pip.................done. 09:05:05 INFO - Return code: 0 09:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:05:05 INFO - Reading from file tmpfile_stdout 09:05:05 INFO - Output received: 09:05:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:05:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:05 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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:05:05 INFO - Using env: {'DISPLAY': ':0', 09:05:05 INFO - 'HOME': '/home/cltbld', 09:05:05 INFO - 'LANG': 'en_US.UTF-8', 09:05:05 INFO - 'LANGUAGE': 'en_US:en', 09:05:05 INFO - 'LOGNAME': 'cltbld', 09:05:05 INFO - 'MAIL': '/var/mail/cltbld', 09:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:05 INFO - 'MOZ_NO_REMOTE': '1', 09:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:05 INFO - 'NO_EM_RESTART': '1', 09:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:05 INFO - 'PWD': '/builds/slave/test', 09:05:05 INFO - 'SHELL': '/bin/bash', 09:05:05 INFO - 'SHLVL': '1', 09:05:05 INFO - 'TERM': 'linux', 09:05:05 INFO - 'TMOUT': '86400', 09:05:05 INFO - 'USER': 'cltbld', 09:05:05 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:05 INFO - '_': '/tools/buildbot/bin/python'} 09:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:05:05 INFO - Cleaning up... 09:05:05 INFO - Return code: 0 09:05:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:05 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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:05:05 INFO - Using env: {'DISPLAY': ':0', 09:05:05 INFO - 'HOME': '/home/cltbld', 09:05:05 INFO - 'LANG': 'en_US.UTF-8', 09:05:05 INFO - 'LANGUAGE': 'en_US:en', 09:05:05 INFO - 'LOGNAME': 'cltbld', 09:05:05 INFO - 'MAIL': '/var/mail/cltbld', 09:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:05 INFO - 'MOZ_NO_REMOTE': '1', 09:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:05 INFO - 'NO_EM_RESTART': '1', 09:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:05 INFO - 'PWD': '/builds/slave/test', 09:05:05 INFO - 'SHELL': '/bin/bash', 09:05:05 INFO - 'SHLVL': '1', 09:05:05 INFO - 'TERM': 'linux', 09:05:05 INFO - 'TMOUT': '86400', 09:05:05 INFO - 'USER': 'cltbld', 09:05:05 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:05 INFO - '_': '/tools/buildbot/bin/python'} 09:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:05 INFO - Downloading/unpacking psutil>=3.1.1 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:09 INFO - Installing collected packages: psutil 09:05:09 INFO - Running setup.py install for psutil 09:05:09 INFO - building 'psutil._psutil_linux' extension 09:05:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:05:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:05:09 INFO - building 'psutil._psutil_posix' extension 09:05:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:05:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:05:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:09 INFO - Successfully installed psutil 09:05:09 INFO - Cleaning up... 09:05:09 INFO - Return code: 0 09:05:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:09 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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:05:09 INFO - Using env: {'DISPLAY': ':0', 09:05:09 INFO - 'HOME': '/home/cltbld', 09:05:09 INFO - 'LANG': 'en_US.UTF-8', 09:05:09 INFO - 'LANGUAGE': 'en_US:en', 09:05:09 INFO - 'LOGNAME': 'cltbld', 09:05:09 INFO - 'MAIL': '/var/mail/cltbld', 09:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:09 INFO - 'MOZ_NO_REMOTE': '1', 09:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:09 INFO - 'NO_EM_RESTART': '1', 09:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:09 INFO - 'PWD': '/builds/slave/test', 09:05:09 INFO - 'SHELL': '/bin/bash', 09:05:09 INFO - 'SHLVL': '1', 09:05:09 INFO - 'TERM': 'linux', 09:05:09 INFO - 'TMOUT': '86400', 09:05:09 INFO - 'USER': 'cltbld', 09:05:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:09 INFO - '_': '/tools/buildbot/bin/python'} 09:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:11 INFO - Installing collected packages: mozsystemmonitor 09:05:11 INFO - Running setup.py install for mozsystemmonitor 09:05:11 INFO - Successfully installed mozsystemmonitor 09:05:11 INFO - Cleaning up... 09:05:12 INFO - Return code: 0 09:05:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:12 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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:05:12 INFO - Using env: {'DISPLAY': ':0', 09:05:12 INFO - 'HOME': '/home/cltbld', 09:05:12 INFO - 'LANG': 'en_US.UTF-8', 09:05:12 INFO - 'LANGUAGE': 'en_US:en', 09:05:12 INFO - 'LOGNAME': 'cltbld', 09:05:12 INFO - 'MAIL': '/var/mail/cltbld', 09:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:12 INFO - 'MOZ_NO_REMOTE': '1', 09:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:12 INFO - 'NO_EM_RESTART': '1', 09:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:12 INFO - 'PWD': '/builds/slave/test', 09:05:12 INFO - 'SHELL': '/bin/bash', 09:05:12 INFO - 'SHLVL': '1', 09:05:12 INFO - 'TERM': 'linux', 09:05:12 INFO - 'TMOUT': '86400', 09:05:12 INFO - 'USER': 'cltbld', 09:05:12 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:12 INFO - '_': '/tools/buildbot/bin/python'} 09:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:12 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05: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 09:05:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:14 INFO - warning: no files found matching '*.txt' 09:05:14 INFO - no previously-included directories found matching 'build' 09:05:14 INFO - no previously-included directories found matching 'dist' 09:05:14 INFO - no previously-included directories found matching '.git*' 09:05:14 INFO - Installing collected packages: jsonschema, functools32 09:05:14 INFO - Running setup.py install for functools32 09:05:14 INFO - warning: no files found matching '*.txt' 09:05:14 INFO - no previously-included directories found matching 'build' 09:05:14 INFO - no previously-included directories found matching 'dist' 09:05:14 INFO - no previously-included directories found matching '.git*' 09:05:14 INFO - Successfully installed jsonschema functools32 09:05:14 INFO - Cleaning up... 09:05:14 INFO - Return code: 0 09:05:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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', '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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:05: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 functools32==3.2.3-2 09:05:14 INFO - Using env: {'DISPLAY': ':0', 09:05:14 INFO - 'HOME': '/home/cltbld', 09:05:14 INFO - 'LANG': 'en_US.UTF-8', 09:05:14 INFO - 'LANGUAGE': 'en_US:en', 09:05:14 INFO - 'LOGNAME': 'cltbld', 09:05:14 INFO - 'MAIL': '/var/mail/cltbld', 09:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:14 INFO - 'MOZ_NO_REMOTE': '1', 09:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:14 INFO - 'NO_EM_RESTART': '1', 09:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:14 INFO - 'PWD': '/builds/slave/test', 09:05:14 INFO - 'SHELL': '/bin/bash', 09:05:14 INFO - 'SHLVL': '1', 09:05:14 INFO - 'TERM': 'linux', 09:05:14 INFO - 'TMOUT': '86400', 09:05:14 INFO - 'USER': 'cltbld', 09:05:14 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:14 INFO - '_': '/tools/buildbot/bin/python'} 09:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:05:14 INFO - Cleaning up... 09:05:14 INFO - Return code: 0 09:05:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:15 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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:05:15 INFO - Using env: {'DISPLAY': ':0', 09:05:15 INFO - 'HOME': '/home/cltbld', 09:05:15 INFO - 'LANG': 'en_US.UTF-8', 09:05:15 INFO - 'LANGUAGE': 'en_US:en', 09:05:15 INFO - 'LOGNAME': 'cltbld', 09:05:15 INFO - 'MAIL': '/var/mail/cltbld', 09:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:15 INFO - 'MOZ_NO_REMOTE': '1', 09:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:15 INFO - 'NO_EM_RESTART': '1', 09:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:15 INFO - 'PWD': '/builds/slave/test', 09:05:15 INFO - 'SHELL': '/bin/bash', 09:05:15 INFO - 'SHLVL': '1', 09:05:15 INFO - 'TERM': 'linux', 09:05:15 INFO - 'TMOUT': '86400', 09:05:15 INFO - 'USER': 'cltbld', 09:05:15 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:15 INFO - '_': '/tools/buildbot/bin/python'} 09:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:17 INFO - Downloading docopt-0.6.1.tar.gz 09:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:18 INFO - Running setup.py install for blobuploader 09:05:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:18 INFO - Running setup.py install for requests 09:05:18 INFO - Running setup.py install for docopt 09:05:18 INFO - Successfully installed blobuploader requests docopt 09:05:18 INFO - Cleaning up... 09:05:18 INFO - Return code: 0 09:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:18 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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:18 INFO - Using env: {'DISPLAY': ':0', 09:05:18 INFO - 'HOME': '/home/cltbld', 09:05:18 INFO - 'LANG': 'en_US.UTF-8', 09:05:18 INFO - 'LANGUAGE': 'en_US:en', 09:05:18 INFO - 'LOGNAME': 'cltbld', 09:05:18 INFO - 'MAIL': '/var/mail/cltbld', 09:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:18 INFO - 'MOZ_NO_REMOTE': '1', 09:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:18 INFO - 'NO_EM_RESTART': '1', 09:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:18 INFO - 'PWD': '/builds/slave/test', 09:05:18 INFO - 'SHELL': '/bin/bash', 09:05:18 INFO - 'SHLVL': '1', 09:05:18 INFO - 'TERM': 'linux', 09:05:18 INFO - 'TMOUT': '86400', 09:05:18 INFO - 'USER': 'cltbld', 09:05:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:18 INFO - '_': '/tools/buildbot/bin/python'} 09:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:18 INFO - Running setup.py (path:/tmp/pip-4O9OXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:18 INFO - Running setup.py (path:/tmp/pip-1IB2nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:19 INFO - Running setup.py (path:/tmp/pip-JTUdfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:19 INFO - Running setup.py (path:/tmp/pip-h6o8rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:19 INFO - Running setup.py (path:/tmp/pip-7uTyKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:19 INFO - Running setup.py (path:/tmp/pip-aYU0GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:19 INFO - Running setup.py (path:/tmp/pip-1dkeoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:19 INFO - Running setup.py (path:/tmp/pip-OZG2mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:19 INFO - Running setup.py (path:/tmp/pip-c_L2OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:19 INFO - Running setup.py (path:/tmp/pip-DNdhAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:19 INFO - Running setup.py (path:/tmp/pip-d1cc1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:19 INFO - Running setup.py (path:/tmp/pip-S0dyZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:19 INFO - Running setup.py (path:/tmp/pip-924lvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:19 INFO - Running setup.py (path:/tmp/pip-aPLAfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:19 INFO - Running setup.py (path:/tmp/pip-AFxWpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:19 INFO - Running setup.py (path:/tmp/pip-jJPWY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:20 INFO - Running setup.py (path:/tmp/pip-dXVhHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:20 INFO - Running setup.py install for manifestparser 09:05:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:20 INFO - Running setup.py install for mozcrash 09:05:20 INFO - Running setup.py install for mozdebug 09:05:20 INFO - Running setup.py install for mozdevice 09:05:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:20 INFO - Running setup.py install for mozfile 09:05:20 INFO - Running setup.py install for mozhttpd 09:05:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:20 INFO - Running setup.py install for mozinfo 09:05:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:20 INFO - Running setup.py install for mozInstall 09:05:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:20 INFO - Running setup.py install for mozleak 09:05:21 INFO - Running setup.py install for mozlog 09:05:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:21 INFO - Running setup.py install for moznetwork 09:05:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:21 INFO - Running setup.py install for mozprocess 09:05:21 INFO - Running setup.py install for mozprofile 09:05:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:21 INFO - Running setup.py install for mozrunner 09:05:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:21 INFO - Running setup.py install for mozscreenshot 09:05:21 INFO - Running setup.py install for moztest 09:05:21 INFO - Running setup.py install for mozversion 09:05:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:21 INFO - Cleaning up... 09:05:21 INFO - Return code: 0 09:05:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:21 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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:21 INFO - Using env: {'DISPLAY': ':0', 09:05:21 INFO - 'HOME': '/home/cltbld', 09:05:21 INFO - 'LANG': 'en_US.UTF-8', 09:05:21 INFO - 'LANGUAGE': 'en_US:en', 09:05:21 INFO - 'LOGNAME': 'cltbld', 09:05:21 INFO - 'MAIL': '/var/mail/cltbld', 09:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:21 INFO - 'MOZ_NO_REMOTE': '1', 09:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:21 INFO - 'NO_EM_RESTART': '1', 09:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:21 INFO - 'PWD': '/builds/slave/test', 09:05:21 INFO - 'SHELL': '/bin/bash', 09:05:21 INFO - 'SHLVL': '1', 09:05:21 INFO - 'TERM': 'linux', 09:05:21 INFO - 'TMOUT': '86400', 09:05:21 INFO - 'USER': 'cltbld', 09:05:21 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:21 INFO - '_': '/tools/buildbot/bin/python'} 09:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:22 INFO - Running setup.py (path:/tmp/pip-9tdbqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:22 INFO - Running setup.py (path:/tmp/pip-8dT3Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:22 INFO - Running setup.py (path:/tmp/pip-f9OQ6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:22 INFO - Running setup.py (path:/tmp/pip-uux_J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:22 INFO - Running setup.py (path:/tmp/pip-p9CpGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:22 INFO - Running setup.py (path:/tmp/pip-rzmZBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:22 INFO - Running setup.py (path:/tmp/pip-z11csv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:22 INFO - Running setup.py (path:/tmp/pip-U2JVf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:22 INFO - Running setup.py (path:/tmp/pip-TD9egf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:22 INFO - Running setup.py (path:/tmp/pip-X2AL9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:22 INFO - Running setup.py (path:/tmp/pip-7ucxhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:22 INFO - Running setup.py (path:/tmp/pip-R_FFDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:23 INFO - Running setup.py (path:/tmp/pip-0oSyUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:23 INFO - Running setup.py (path:/tmp/pip-p0gD12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:23 INFO - Running setup.py (path:/tmp/pip-jyQvPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:23 INFO - Running setup.py (path:/tmp/pip-bfcGqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:23 INFO - Running setup.py (path:/tmp/pip-lpAHYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:25 INFO - Downloading blessings-1.6.tar.gz 09:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:25 INFO - Installing collected packages: blessings 09:05:25 INFO - Running setup.py install for blessings 09:05:25 INFO - Successfully installed blessings 09:05:25 INFO - Cleaning up... 09:05:25 INFO - Return code: 0 09:05:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:25 INFO - Reading from file tmpfile_stdout 09:05:25 INFO - Current package versions: 09:05:25 INFO - argparse == 1.2.1 09:05:25 INFO - blessings == 1.6 09:05:25 INFO - blobuploader == 1.2.4 09:05:25 INFO - docopt == 0.6.1 09:05:25 INFO - functools32 == 3.2.3-2 09:05:25 INFO - jsonschema == 2.5.1 09:05:25 INFO - manifestparser == 1.1 09:05:25 INFO - mozInstall == 1.12 09:05:25 INFO - mozcrash == 1.0 09:05:25 INFO - mozdebug == 0.1 09:05:25 INFO - mozdevice == 0.49 09:05:25 INFO - mozfile == 1.2 09:05:25 INFO - mozhttpd == 0.7 09:05:25 INFO - mozinfo == 0.9 09:05:25 INFO - mozleak == 0.1 09:05:25 INFO - mozlog == 3.4 09:05:25 INFO - moznetwork == 0.27 09:05:25 INFO - mozprocess == 0.25 09:05:25 INFO - mozprofile == 0.28 09:05:25 INFO - mozrunner == 6.13 09:05:25 INFO - mozscreenshot == 0.1 09:05:25 INFO - mozsystemmonitor == 0.3 09:05:25 INFO - moztest == 0.8 09:05:25 INFO - mozversion == 1.4 09:05:25 INFO - psutil == 3.1.1 09:05:25 INFO - requests == 1.2.3 09:05:25 INFO - wsgiref == 0.1.2 09:05:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:25 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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:05:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:25 INFO - Using env: {'DISPLAY': ':0', 09:05:25 INFO - 'HOME': '/home/cltbld', 09:05:25 INFO - 'LANG': 'en_US.UTF-8', 09:05:25 INFO - 'LANGUAGE': 'en_US:en', 09:05:25 INFO - 'LOGNAME': 'cltbld', 09:05:25 INFO - 'MAIL': '/var/mail/cltbld', 09:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:25 INFO - 'MOZ_NO_REMOTE': '1', 09:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:25 INFO - 'NO_EM_RESTART': '1', 09:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:25 INFO - 'PWD': '/builds/slave/test', 09:05:25 INFO - 'SHELL': '/bin/bash', 09:05:25 INFO - 'SHLVL': '1', 09:05:25 INFO - 'TERM': 'linux', 09:05:25 INFO - 'TMOUT': '86400', 09:05:25 INFO - 'USER': 'cltbld', 09:05:25 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:25 INFO - '_': '/tools/buildbot/bin/python'} 09:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:05:26 INFO - Cleaning up... 09:05:26 INFO - Return code: 0 09:05:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:26 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 0x27751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a12b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, '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-1490285072.505970-148446718', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:05:26 INFO - Using env: {'DISPLAY': ':0', 09:05:26 INFO - 'HOME': '/home/cltbld', 09:05:26 INFO - 'LANG': 'en_US.UTF-8', 09:05:26 INFO - 'LANGUAGE': 'en_US:en', 09:05:26 INFO - 'LOGNAME': 'cltbld', 09:05:26 INFO - 'MAIL': '/var/mail/cltbld', 09:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:26 INFO - 'MOZ_NO_REMOTE': '1', 09:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:26 INFO - 'NO_EM_RESTART': '1', 09:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:26 INFO - 'PWD': '/builds/slave/test', 09:05:26 INFO - 'SHELL': '/bin/bash', 09:05:26 INFO - 'SHLVL': '1', 09:05:26 INFO - 'TERM': 'linux', 09:05:26 INFO - 'TMOUT': '86400', 09:05:26 INFO - 'USER': 'cltbld', 09:05:26 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:26 INFO - '_': '/tools/buildbot/bin/python'} 09:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:26 INFO - Cleaning up... 09:05:26 INFO - Return code: 0 09:05:26 INFO - Running post-action listener: _resource_record_post_action 09:05:26 INFO - Running post-action listener: _start_resource_monitoring 09:05:26 INFO - Starting resource monitoring. 09:05:26 INFO - [mozharness: 2017-03-23 16:05:26.390719Z] Finished create-virtualenv step (success) 09:05:26 INFO - [mozharness: 2017-03-23 16:05:26.391196Z] Running install step. 09:05:26 INFO - Running pre-action listener: _resource_record_pre_action 09:05:26 INFO - Running main action method: install 09:05:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:26 INFO - Reading from file tmpfile_stdout 09:05:26 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:26 INFO - Reading from file tmpfile_stdout 09:05:26 INFO - Output received: 09:05:26 INFO - Usage: mozinstall [options] installer 09:05:26 INFO - Options: 09:05:26 INFO - -h, --help show this help message and exit 09:05:26 INFO - -d DEST, --destination=DEST 09:05:26 INFO - Directory to install application into. [default: 09:05:26 INFO - "/builds/slave/test"] 09:05:26 INFO - --app=APP Application being installed. [default: firefox] 09:05:26 INFO - mkdir: /builds/slave/test/build/application 09:05:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:05:43 INFO - Reading from file tmpfile_stdout 09:05:43 INFO - Output received: 09:05:43 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:43 INFO - Running post-action listener: _resource_record_post_action 09:05:43 INFO - [mozharness: 2017-03-23 16:05:43.276363Z] Finished install step (success) 09:05:43 INFO - [mozharness: 2017-03-23 16:05:43.276641Z] Running run-tests step. 09:05:43 INFO - Running pre-action listener: _resource_record_pre_action 09:05:43 INFO - Running main action method: run_tests 09:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:43 INFO - Python 2.7.3 09:05:43 INFO - Return code: 0 09:05:43 INFO - grabbing minidump binary from tooltool 09:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:43 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 0x2a10290>, '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 0x2a10b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a11040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:05:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:05:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:05:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:43 INFO - Return code: 0 09:05:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:43 INFO - ENV: RUST_BACKTRACE is now 1 09:05:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:43 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/XnpvdJqNT8-kRjsUsUY7vQ/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 09:05:43 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/XnpvdJqNT8-kRjsUsUY7vQ/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 09:05:43 INFO - Using env: {'DISPLAY': ':0', 09:05:43 INFO - 'HOME': '/home/cltbld', 09:05:43 INFO - 'LANG': 'en_US.UTF-8', 09:05:43 INFO - 'LANGUAGE': 'en_US:en', 09:05:43 INFO - 'LOGNAME': 'cltbld', 09:05:43 INFO - 'MAIL': '/var/mail/cltbld', 09:05:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:43 INFO - 'MOZ_NO_REMOTE': '1', 09:05:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:43 INFO - 'NO_EM_RESTART': '1', 09:05:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:43 INFO - 'PWD': '/builds/slave/test', 09:05:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:43 INFO - 'RUST_BACKTRACE': '1', 09:05:43 INFO - 'SHELL': '/bin/bash', 09:05:43 INFO - 'SHLVL': '1', 09:05:43 INFO - 'TERM': 'linux', 09:05:43 INFO - 'TMOUT': '86400', 09:05:43 INFO - 'USER': 'cltbld', 09:05:43 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1490285072.505970-148446718', 09:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:43 INFO - '_': '/tools/buildbot/bin/python'} 09:05:43 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/XnpvdJqNT8-kRjsUsUY7vQ/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 09:05:43 INFO - mozversion application_buildid: 20170323150517 09:05:43 INFO - mozversion application_changeset: 7fec8b804687f87447477a5759039a2be4d16796 09:05:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:05:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:43 INFO - mozversion application_name: Firefox 09:05:43 INFO - mozversion application_remotingname: firefox-dev 09:05:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:05:43 INFO - mozversion application_vendor: Mozilla 09:05:43 INFO - mozversion application_version: 54.0a2 09:05:43 INFO - mozversion platform_buildid: 20170323150517 09:05:43 INFO - mozversion platform_changeset: 7fec8b804687f87447477a5759039a2be4d16796 09:05:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:05:43 INFO - mozversion platform_version: 54.0a2 09:05:43 INFO - using testdate: 1490285143 09:05:43 INFO - actual date: 1490285143 09:05:43 INFO - starting webserver on 'localhost:37396' 09:05:43 INFO - SUITE-START | Running 2 tests 09:05:43 INFO - TEST-START | dromaeo_css 09:05:43 INFO - operating with platform_type : linux_ 09:05:43 INFO - Initialising browser for dromaeo_css test... 09:05:43 INFO - TEST-INFO | started process 9757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm6QRoR/profile http://localhost:37396/getInfo.html) 09:05:47 INFO - PROCESS | 9757 | __metrics Screen width/height:1600/1200 09:05:47 INFO - PROCESS | 9757 | colorDepth:24 09:05:47 INFO - PROCESS | 9757 | Browser inner width/height: 1024/697 09:05:47 INFO - PROCESS | 9757 | __metrics 09:05:48 INFO - PROCESS | 9757 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:05:48 INFO - PROCESS | 9757 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:05:49 INFO - TEST-INFO | 9757: exit 0 09:05:49 INFO - Browser initialized. 09:05:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:05:49 INFO - TEST-INFO | started process 9846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm6QRoR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:01 INFO - PROCESS | 9846 | RSS: Main: 139501568 09:06:01 INFO - PROCESS | 9846 | 09:09:02 INFO - PROCESS | 9846 | Cycle 1(1): loaded http://localhost:37396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37396/tests/dromaeo/cssquery-ext.html) 09:09:04 INFO - PROCESS | 9846 | RSS: Main: 279531520 09:09:04 INFO - PROCESS | 9846 | 09:10:51 INFO - PROCESS | 9846 | ************************* 09:10:51 INFO - PROCESS | 9846 | A coding exception was thrown and uncaught in a Task. 09:10:51 INFO - PROCESS | 9846 | 09:10:51 ERROR - PROCESS | 9846 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:10:51 INFO - PROCESS | 9846 | Full stack: 09:10:51 INFO - PROCESS | 9846 | ************************* 09:12:06 INFO - PROCESS | 9846 | Cycle 1(1): loaded http://localhost:37396/tests/dromaeo/cssquery-ext.html (next: http://localhost:37396/tests/dromaeo/cssquery-jquery.html) 09:12:06 INFO - PROCESS | 9846 | RSS: Main: 222924800 09:12:06 INFO - PROCESS | 9846 | 09:15:08 INFO - PROCESS | 9846 | Cycle 1(1): loaded http://localhost:37396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37396/tests/dromaeo/cssquery-mootools.html) 09:15:09 INFO - PROCESS | 9846 | RSS: Main: 213659648 09:15:09 INFO - PROCESS | 9846 | 09:18:11 INFO - PROCESS | 9846 | Cycle 1(1): loaded http://localhost:37396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37396/tests/dromaeo/cssquery-prototype.html) 09:18:11 INFO - PROCESS | 9846 | RSS: Main: 170795008 09:18:11 INFO - PROCESS | 9846 | 09:21:14 INFO - PROCESS | 9846 | Cycle 1(1): loaded http://localhost:37396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37396/tests/dromaeo/cssquery-yui.html) 09:21:15 INFO - PROCESS | 9846 | RSS: Main: 177696768 09:21:15 INFO - PROCESS | 9846 | 09:24:17 INFO - PROCESS | 9846 | Cycle 1(1): loaded http://localhost:37396/tests/dromaeo/cssquery-yui.html (next: http://localhost:37396/tests/dromaeo/cssquery-dojo.html) 09:24:18 INFO - PROCESS | 9846 | RSS: Main: 255152128 09:24:18 INFO - PROCESS | 9846 | 09:24:18 INFO - PROCESS | 9846 | __start_tp_report 09:24:18 INFO - PROCESS | 9846 | _x_x_mozilla_page_load 09:24:18 INFO - PROCESS | 9846 | _x_x_mozilla_page_load_details 09:24:18 INFO - PROCESS | 9846 | |i|pagename|runs| 09:24:18 INFO - PROCESS | 9846 | |0;dojo.html;3419.794812311261;3424.4349682302422;3441.5698037745283;3450.7411944104197;3480.1995541025562;5853.560982926277;5929.43670351317;5937.85155371116;5941.168236446901;5942.970285148574;5904.114382842576;5968.224130862993;5970.313413957396;5972.581919265654;5973.372795856427;5381.165919282507;5406.432324605918;5437.870707272085;5441.727913604304;5491;5188.6367954243215;5225.8954820903555;5365.678059316453;5479.287692599956;5498.945010549904;5381.730913454331;5410.783568657269;5416.864578385533;5429.619926605139;5464.0711079116445;5455.099908515091;5464.043792336365;5465.180222966547;5469.589780766419;5475;5200.3759548854005;5225.268462415227;5312;5374.973125134349;5468.972655136698;5735.4551317624755;5762.3373312069225;5803.361630220672;5822.505087067604;5843.123531470271;6263.1544741459775;6293.842653933642;6327.24073111225;6336.778212762577;6338.778142765027;6077.118817771443;6354.17395738551;6367.140436041122;6382.648954307511;6389.233292004943;5760.0783874579865;5876.4123587641325;5881.088431293157;5918.585699001114;5937.2578427696535;6458.580192287486;6462.547621666438;6512.446442052384;6523.8695226095215;6527.836804079841;6248.718807653667;6252.781152659635;6264.906026409608;6270.655113968684;6273.404026617464;6090.147379366892;6122.510199184055;6174.722137503823;6186.19579454668;6195.101710252078;6288.811335659938;6291.496680265659;6294.622322660655;6297.2128483939505;6298.905516417258;6067.150598916155;6132.110843927606;6132.386761323832;6134.938650613526;6150.384961503813;4548.499665036909;4664.486906440289;4669.9726060266685;4674.579287864109;4674.813007479731;4189.2459357315975;4262.595053469915;4272.29507131326;4284.957150428456;4288.871333859989;6010.3689112643415;6031.728572214261;6061.666608336495;6106.938930610637;6125.571219981323;6391.680415979183;6397.6801159941815;6398.168238129014;6405.839854003687;6407.038944158414;6111.297200821962;6114.877702446015;6121.938780612226;6124.142620033199;6138.048602466625;5199.974000129975;5228.869278268074;5276.683398996072;5287.259783630295;5335.146376579806;6551.0173473979285;6574.178227721535;6577.177852768404;6578.638174900427;6586.27550969393;6292.590981586182;6298.968505157445;6332.620042797447;6338.746450141943;6353.269374021862;6282.497400207881;6338.302786693553;6422;6467.838304042437;6572.079908812866;6212.0371342441995;6225.595336303126;6226.346233645583;6226.533010024175;6229.595076320024;6381.138546296191;6383.1382763326355;6384.106225128578;6384.457321127757;6385.936140638534;5940.495057919952;5993.250843644544;6085.57400981927;6116.785912493041;6177;6118.771466972081;6136.171616831671;6151.32335443092;6163.1679723238585;6204;6182.443580077635;6183.041628547402;6184.81445556634;6189.35011823752;6193.752249910133;5983.850403739942;5996.610220335664;6050.45545900871;6128.63228206309;6198.256209254738;6074.058520929263;6074.696265186812;6108.419700128481;6116.113163591165;6116.66358350295 09:24:18 INFO - PROCESS | 9846 | |1;ext.html;756.2588663110151;820.6799348254181;835.6156168162645;894.4543828264757;901.7970956534776;30537.389252214944;43776.78111609441;43784.562154378444;43825.34261986073;44059.33910991338;40667.38998915011;40930.18139637213;40999.18001639973;45688;45777.542224577744;7572.432067594925;7720.536767793922;8996.550172491381;9139.58871850765;9160.541972901361;10443.321184123046;10663.520141593608;10671.092957098655;10676.78646427071;11041.723956901062;10825.729356766104;10848.78302433951;10864.293820901656;10868.565257389695;10875.619353322636;10761.408122553257;10879.401632910187;10884.891151088466;10887.618933337295;10892.945535272353;10442.738931526697;10491.318064325795;10507.579696812194;10523;10536.947315263375;41970.79014604938;42289.57710422918;42583.57416425858;42618;42657.786711066554;4131.088155092456;4188.874333769992;4196.727212731163;4261.531231564525;4343.587359200871;28880.566791498146;28913.132606021853;29155.41689166226;30219;30270.394592108256;4177.770222637754;4208.389783481409;4251.149770046003;4332.891677708051;4361.3457981302745;219473;219964;220286;220362;221111.89444052838;51066.48933510618;51195.232071518956;51473.48526514762;51650.22524662133;51676.74161629168;52429.73785131126;52480;52484.21273680898;52528.73735631374;52558.73720631449;16487;16863.831361686225;16902.154892255337;16911.069891156105;16911.91544042272;12922.806157907638;13172.670683232804;14649.853501465062;15189.848101519065;15190;13146.276954767389;13183.340832958314;13189.406476708571;13240.337983100999;13330.733385332433;5520.227168196456;5575.4424557544735;5606.243157173811;5618.410066942994;5646.830595082154;985.5811280205884;988.0564061321421;993.9006099390003;999.065873408351;1004.7186787699455;27820.721792782217;28138.2965425866;28508.28729281743;28579;28604.284892877844;1045.3048722599538;1061.91504679627;1063.0167095436846;1067.9733006674896;1095.0473088412973;14576.052556583789;14909.850901490847;14941.850581494264;15017.474388396573;15021;292101;293171;293224;293705;293757;54792.72603636956;54794.726026369615;54831.62920927009;54834.45165548293;54913.450865491635;1504.9849501505064;1510.7507261301982;1539.468883235282;1541.1600677630718;1546.3737186439284;25762.613560796977;27243.318917027234;27257.31856703598;27350.179494615193;27533.31166720848;39791.80104099461;39832.402513962894;39880;39930.401043984944;39959;258232;258506;258607;259069;259161;34167.82916085404;34764.65235347614;34767.13082172865;34863;34880.82559587288;42626.78686606547;42972.35541466818;43682.34476482792;44054.3391849129;44140.55859441365;36069.63930360663;36764.26471470609;36812.447813282284;36954;37029.44455833219;35948.28103437864;36069.098272542346;36291.45562816613;36313.818430907675;36660.08349791277;36779;36917.63082369142;37500.62499374971;37956.05109872275;37980.62019379771;30566;32771.67228327782;33053.17367065747;33068.83465582753;33076.33847322992;25199;25241.36896577527;25380.746192538576;25389.74610253874;25822.096226631977 09:24:18 INFO - PROCESS | 9846 | |2;jquery.html;418.3181414294699;474.45674702465675;480.6011010860986;489.52271535253124;492.67729637087706;19375.418737437863;19707.113179906904;20717.68923466149;21459.356219313406;21781.673274900888;22029.449263768412;22195.334139975785;22213.2225372112;22255.666165007537;22536.8873155634;6557.639329836857;6605.603663780164;6732.225794033675;6775;6876.965615171917;4102.5692302308125;6622.072909792633;6721.0926524919;6724.293949135344;6730.091437655903;4267.189234045537;4532.91210109573;7744;7901.565413902233;7920.366370690331;7740.574268415235;7851.764447066597;7855.921440785633;7886.6845326186885;7905.802354941115;7639.427042971799;7676.347510461617;7683.385329173652;7688.6155692215725;7694.961525192394;25142.748572514407;25278.620820687705;25509.872450637813;25540;25560.360990975187;3000.384921091193;3027.2583217111946;3120.1419609607315;3168.6356069051894;3168.651448340681;15177.392904283926;15371.077735335915;15485.690286194325;16195.109268990202;16770;2163.383435720828;2224.588451136545;2229.5763804877183;2278.350670059042;2286.8970896309706;118054.40972795167;120862;121724;122202;122686;14412.769466368134;15889;17776.555586110193;18074.728879066824;18083.909580452015;31868.521972170434;31992.200194994846;32023.199420014687;32075;32427.18932026718;10312.742181445525;10352.896471035343;10417.739556511147;10557.313774604627;10581.682549523526;8757.56212189388;8766.386352955233;8837.116288371111;8947.10528947113;8957.596908139149;8942.597583108776;8999.422092026905;9230.492322922304;9286.674966376144;9541.618335266512;3401.8809341672923;3517.2086280586664;3853.190829925747;3908.882733517942;3930.3711406174875;897.7351681254046;917.4816228830823;918.6233644205977;946.6260826973307;957.1337939165066;19612.70580941287;21126.154953801983;21133;21145.154193832383;21484.570308593742;930.6370515498961;934.7756538430727;949.2263804998904;952.5046975572664;955.3360414511848;10763.784724305626;11173.217874748852;11203;11227.438628068563;11264.221116550798;625275;636752;649327;679777;687047;82095.14799970078;85675.57162214149;105324;114824;116359.41820290845;1221.0170812495849;1232.0944106082022;1250.031225799994;1262.1543565810928;1268.5686866465262;13596.456141754219;17148.828511714724;17767.555811104827;19101.90449047746;19483.707744383562;46335.6832158384;49948;54043.45956540384;54264.45735542594;55197.44802551923;59629.10556341745;67729.66135169292;68499.97250041353;68828.65585672039;69084;11497.19519633651;11735.119866010255;12018.639440816789;12116.697082573006;12237.877621223673;12061.276323420623;12232.449539770909;12372;12613.49546018149;12789.104762666524;10931.453427328443;11268.154888383568;11433.828492572451;11692.064634829363;11772.646820595395;11107.38909359993;11536;11540.711482213012;11558.711032224262;11644.6506604802;11317.830232546354;11530.94234528822;11810.40947952616;11955.880441195824;12186.451609677408;11432.542698291974;11615.593454229062;11821.468033938665;12048.277103373826;12175.817362739743;11070.833937491105;11158.442077896236;11238.66284011481;11890.167688262085;12141.453634586289 09:24:18 INFO - PROCESS | 9846 | |3;mootools.html;1553.4795843392462;1575.2753733282689;1594.5216435069483;1607.6543543138223;1615.0390517642;11017.228793984414;11829.349385783778;11855.940720296398;11863.347515886622;11878.940605296983;11562.47968841402;11696.18126731129;11867.169298149132;12315.076369272296;12320.753584928296;2317.2700599311165;2345.108858633717;2352.3178278299274;2353.070537137838;2355.3640517060385;2282.7032485776826;2316.455632926261;2322.918697845576;2326.7091613548305;2327.976720232793;2273.897674604647;2316.698829152208;2323.2101085630884;2323.3610757041865;2324.9418764530938;2200.3288996855954;2218.1127548980376;2218.6450167973126;2220;2225.4547635829244;2213.579419910212;2257.593633146033;2259.4916143867663;2265.456290490287;2280.9657855132186;11797.941010294979;11884.821727674092;11903.583374581935;11909.642710718692;11927.582534611334;5547.1679248113105;5667.971660141714;5672.177534257509;5676.574256930706;5683.318001839764;3385.3906296866553;3410.2667926395943;3556.0754203906913;3589.587197472272;3601.531800865897;1348.4673553946234;1355.3697530648196;1373.7870630052357;1397.0639671420172;1453.978190327146;15144.469943551923;15548.067115973077;16601.335946562;16883.831161688347;17097.230624621796;4563.771811409416;4727.227289766338;4736.502667219892;4737.739424331626;4739.241721324572;13352.332383380986;13355.732885342433;13357.53248636293;13359.799603005962;13361.866381336062;4747.786349614275;4896.95103048972;5498.092814685532;5764.855878602984;5767.250257466502;5352.330958630171;5401.081816091274;5482.17767334895;5483.506484416342;5505.504504594605;3879.8642047528765;3900.6294402031763;3937.1731936293127;3962.8612998544913;3964.7819369934355;1061.3737894642045;1089.6894385100368;1103.27184058521;1106.4246591772232;1109.4064675398622;1033.4161198922584;1045.6340280901622;1054.5096530113533;1057.1648397765832;1067.8344856547249;6895.896561551581;7006.0892084029765;7033.964830175816;7127.144742630918;7228.38558722504;1036.9429681367446;1043.3270540501485;1051.6319288249051;1071.164491696478;1080.6172389880296;4669.859904202879;4697.78859951303;4727.078219747116;4807.687500312539;4896;14933.775993360108;15368.692626147638;15449.459268925533;15461;15475.845241547666;14215.928920355333;14790.778138327934;15227.314770835339;15237;15316.15761133126;10661.786764264827;10825.67522974312;10858.728531786768;10870.782584348426;10882.891171088346;7539.736109236151;7724.111727151225;7830.960845195737;7921.841563168819;7958.283754462126;13525.18848869071;13570.864291357355;13587.116837405538;13735.862641373458;13834.584962451143;11379.203455758348;11507.079433645456;13354.799678004643;13425.925925926098;13731.45074197021;9813.460259685786;9964.252681049094;10040.447775372424;10060.144887684335;10064.798704025732;11213.66359009231;11221.71945701364;11275.548978041115;11281;11286.322820630789;9831.115199632068;9870.457124857914;9934.403935763878;10003.399796012263;10202.795944081225;9569.425834449956;9708.5145742714;9711.854322185314;9800;9882.802343953224;8950.283977281671;8955.552222388986;9004.594793234452;9012.594433250388;9022.819543609223;6588.275289718223;6592.044153597605;6638.369354911276;6641.701123449553;6713.060171575886;6786.76246331376;6818.271977150064;6843.589384636938;6877.105976223059;6934.410575100971 09:24:18 INFO - PROCESS | 9846 | |4;prototype.html;373.7103744597936;376.6873494999151;385.7010816617121;397.39000634026763;399.06817580948484;5259.684418934862;5313.485656587874;5317.548008419284;5326.378062917215;5333.026780091372;5039.370078740158;5180.782516108711;5239.8996210795685;5263.526282634562;5265.262863199146;4204.516480604739;4212.452381190441;4212.620864122228;4216.156768646268;4239.724417912826;4222.218889505436;4227.429297044906;4237.0254841386495;4237.749863790174;4253.532111467736;4143.107380440266;4211.8525851595205;4216.114615930643;4219.978900105495;4226.429432026668;4068.9389659155136;4181.937270940908;4195.244855925932;4198.328267477189;4220.556841531657;3760.981195094007;3763.5860055393887;3763.9435408468894;3770.6794922431627;3794.9810250948844;5146.871328216787;5165.966806638688;5187.273781670531;5189.558887494568;5194.558462530689;4806.7836947337455;4851.781669824866;5011.5489605935645;5052.191649336089;5080.466551012128;5473.75368108436;5480.451954804527;5506.5870059745275;5509.614326997112;5518.633633483571;4550.249208880531;4557.703749256321;4562.133194692998;4588.646349326957;4590.449146102455;5459.69971651559;5468.7268598508845;5555.638883472561;5721.885562288772;5739.827805165852;4566.406367172246;4673.649476289292;4688.093002816476;4693.366395536627;4712.175369310357;4754.619630429557;4755.432066683952;4756.809727610926;4758.833440829554;4765.76171191446;4950.168437678082;5070.391553013662;5074.16276314404;5081.8729531762;5098.898022039539;5465.781368745285;5466.72666366688;5511;5541.810984661117;5549.611527193058;1630.9918450407672;1635.5175223309152;1640.4340502526609;1641.1712085397037;1642.6468309313555;1191.511480293093;1270.6632742323293;1275.9043071769654;1278.367208231931;1285.9035572332114;5446.9106178764405;5456.236126942231;5459.434065988979;5476.808311709071;5529.529989950819;5415.620906536505;5651;5677.041420709848;5682.971585142048;5704.3154821421695;5450.591205659592;5457.317835270591;5465.316835395575;5472.288602481652;5472.798412928481;2996;3002.084364268875;3007.4887269164296;3022.199117233935;3046.3602643444683;5617.43825617435;5924.022536281552;5942.70286485674;5964.612300200473;5966.552508561876;5827.184194212814;5871.64770113786;5876.471117599436;5884.176215329857;5902.793402230987;5613.522850557667;5777.422257774189;5881.206037185097;5947.405259474104;5947.910781338197;5641.802536911188;5666.660000399989;5668.716564171693;5669.858253543694;5691.7233106755975;5605.439456054362;5632.887342253214;5637.746301416528;5640.364294354591;5642.294713160855;5442.346918369821;5617.6910269933915;5785.652860828363;5799.333076696065;5817.447342502455;4700.153972285021;4700.45944716362;4704.224507540567;4704.647151463722;4734.100520901018;5473.917891231715;5681.4034526374135;5691.203231547669;5698.287714035746;5720.570957178145;5472.835814925558;5509.586780991362;5527.613067085426;5555.333359996826;5555.722213889208;5490.972545137249;5533.6403133797785;5538.47384498472;5553.722313884209;5555.472230138131;5352.866178345573;5436.184572314184;5479.479449452296;5497.5601951842955;5533.225348451139;5551.195076713934;5552.918130437646;5553.305836770403;5558.194061861089;5561.805336813192;5326.055989563859;5448.346198456211;5461.426550212171;5462.180672899097;5463.972680136574 09:24:18 INFO - PROCESS | 9846 | |5;yui.html;814.1858141858141;891.7592250092475;896.5293221058945;909.1272378516624;913.2191975860638;15549.479934623216;17645;17652.117394130273;17902.28390864364;17993.730094048584;16538.83461165388;16962.575935601617;17148.228329725192;17184.484465466056;17197.054162021082;890.3900827932854;911.6991392840347;912.1562554636968;912.4570880326195;912.6896855069275;873.8033942362981;896.4397251717677;898.4743924803964;904.6110172625769;905.868649045888;919.7516670498961;923.6628630549868;926.8239034583441;928.1553786054692;931.4039015030386;919.5126582911067;922.7969846633763;922.8661844032612;923.2152670230317;923.8152369526088;678.494521581425;681.560393546165;681.7443458702986;682.969266383014;683.2347770497025;15181;15285.006474579117;16027.104956748999;16270.51188464348;16348.346066157339;15634.530964071097;15743.527694169194;15854.841451585567;16011.919940400223;16244.02535847853;13332.802000468244;13989.720205595831;14004.22976736279;14045.157290562598;14122.92938535311;4000.579939106381;4036.5761595032686;4060.127072679388;4091.4476545666253;4213.747175169469;47896.760516197195;56451;65295.3470465294;87524.56237718834;88644.11355886488;12318.507259709511;12524.686882828002;12575.371231438392;12627.242365458102;12791.616251512469;22054.669179962315;22110.889445552668;22173.889130554566;22195.33413997583;22252.332430027123;6086.330503644595;7987.16134805837;8335.361704030141;8664.09027052163;8755.562221889008;4933.136701077297;4981.875453113701;4983.775730092155;5045.5459008689395;5122.052420302256;3640.7087433005295;3743.3074881147077;3745.9812700936322;3747.6252374762307;3747.793871337048;602.120903480914;610.2402508876477;621.2948303675271;623.3579413204316;625.140431906129;663.4029373563735;695.8399568099366;706.5831159615851;764.537454839825;774.194837369141;10558.366498010144;11016.283941543774;11305.547778088785;11458.54165833374;11765.588204412805;641.6727468990848;654.5254690349459;660.1648914123638;683.64365198668;831.1771346367174;5283.735813209401;5372.865678358073;5491.835244942658;5511.724413779295;5528;80659.59670201728;80859.74411663222;81899;81923.59038204771;82599.17400825914;43009.13981720348;60680.69659651762;65043.999999999054;71191.6440417805;74331;61146.69426652927;61604.38395616076;61850.381496185364;62143;62184.378156218765;11106.888931110909;11363.204575679623;11477.598284060017;11604.361760103275;11624.128190385924;42756;43144;43669;43948.780256098515;44278.77860610676;52129.739351303004;52311.215331769294;52536;52690;52706.20940685816;13060.346982650639;13126.671833204246;13150.408231629792;13192.868071319164;13297.069205155547;14817.925910370379;14941.103533788008;14949.959440023524;15007.17460539637;15336.846631533988;15091;15211.77182342288;15301.08193508393;15301.6174595636;15996.840031599535;14533.128012319296;14977.251137442867;14986.250687465365;15719.135447550494;15860.286287117338;14767;14942.701145977237;15327.693446131238;15446.922765386102;16306.429274975319;12870.420831062438;12895;13091.476340946256;13233.470661173831;13718.559551246975;12529.749405012031;12636.178648387826;12949;13167.967539800906;13322.400491978078 09:24:18 INFO - PROCESS | 9846 | __end_tp_report 09:24:18 INFO - PROCESS | 9846 | __start_cc_report 09:24:18 INFO - PROCESS | 9846 | _x_x_mozilla_cycle_collect,1396 09:24:18 INFO - PROCESS | 9846 | __end_cc_report 09:24:18 INFO - PROCESS | 9846 | __startTimestamp1490286258238__endTimestamp 09:24:18 INFO - PROCESS | 9846 | 09:24:18 INFO - PROCESS | 9846 | ------- Summary: start ------- 09:24:18 INFO - PROCESS | 9846 | Number of tests: 6 09:24:18 INFO - PROCESS | 9846 | 09:24:18 INFO - PROCESS | 9846 | [#0] dojo.html Cycles:165 Average:5854.19 Median:6114.88 stddev:674.45 (11.0%) stddev-sans-first:648.92 09:24:18 INFO - PROCESS | 9846 | Values: 3419.8 3424.4 3441.6 3450.7 3480.2 5853.6 5929.4 5937.9 5941.2 5943.0 5904.1 5968.2 5970.3 5972.6 5973.4 5381.2 5406.4 5437.9 5441.7 5491.0 5188.6 5225.9 5365.7 5479.3 5498.9 5381.7 5410.8 5416.9 5429.6 5464.1 5455.1 5464.0 5465.2 5469.6 5475.0 5200.4 5225.3 5312.0 5375.0 5469.0 5735.5 5762.3 5803.4 5822.5 5843.1 6263.2 6293.8 6327.2 6336.8 6338.8 6077.1 6354.2 6367.1 6382.6 6389.2 5760.1 5876.4 5881.1 5918.6 5937.3 6458.6 6462.5 6512.4 6523.9 6527.8 6248.7 6252.8 6264.9 6270.7 6273.4 6090.1 6122.5 6174.7 6186.2 6195.1 6288.8 6291.5 6294.6 6297.2 6298.9 6067.2 6132.1 6132.4 6134.9 6150.4 4548.5 4664.5 4670.0 4674.6 4674.8 4189.2 4262.6 4272.3 4285.0 4288.9 6010.4 6031.7 6061.7 6106.9 6125.6 6391.7 6397.7 6398.2 6405.8 6407.0 6111.3 6114.9 6121.9 6124.1 6138.0 5200.0 5228.9 5276.7 5287.3 5335.1 6551.0 6574.2 6577.2 6578.6 6586.3 6292.6 6299.0 6332.6 6338.7 6353.3 6282.5 6338.3 6422.0 6467.8 6572.1 6212.0 6225.6 6226.3 6226.5 6229.6 6381.1 6383.1 6384.1 6384.5 6385.9 5940.5 5993.3 6085.6 6116.8 6177.0 6118.8 6136.2 6151.3 6163.2 6204.0 6182.4 6183.0 6184.8 6189.4 6193.8 5983.9 5996.6 6050.5 6128.6 6198.3 6074.1 6074.7 6108.4 6116.1 6116.7 09:24:18 INFO - PROCESS | 9846 | 09:24:18 INFO - PROCESS | 9846 | [#1] ext.html Cycles:180 Average:43268.23 Median:33072.59 stddev:67294.04 (203.5%) stddev-sans-first:67407.11 09:24:18 INFO - PROCESS | 9846 | Values: 756.3 820.7 835.6 894.5 901.8 30537.4 43776.8 43784.6 43825.3 44059.3 40667.4 40930.2 40999.2 45688.0 45777.5 7572.4 7720.5 8996.6 9139.6 9160.5 10443.3 10663.5 10671.1 10676.8 11041.7 10825.7 10848.8 10864.3 10868.6 10875.6 10761.4 10879.4 10884.9 10887.6 10892.9 10442.7 10491.3 10507.6 10523.0 10536.9 41970.8 42289.6 42583.6 42618.0 42657.8 4131.1 4188.9 4196.7 4261.5 4343.6 28880.6 28913.1 29155.4 30219.0 30270.4 4177.8 4208.4 4251.1 4332.9 4361.3 219473.0 219964.0 220286.0 220362.0 221111.9 51066.5 51195.2 51473.5 51650.2 51676.7 52429.7 52480.0 52484.2 52528.7 52558.7 16487.0 16863.8 16902.2 16911.1 16911.9 12922.8 13172.7 14649.9 15189.8 15190.0 13146.3 13183.3 13189.4 13240.3 13330.7 5520.2 5575.4 5606.2 5618.4 5646.8 985.6 988.1 993.9 999.1 1004.7 27820.7 28138.3 28508.3 28579.0 28604.3 1045.3 1061.9 1063.0 1068.0 1095.0 14576.1 14909.9 14941.9 15017.5 15021.0 292101.0 293171.0 293224.0 293705.0 293757.0 54792.7 54794.7 54831.6 54834.5 54913.5 1505.0 1510.8 1539.5 1541.2 1546.4 25762.6 27243.3 27257.3 27350.2 27533.3 39791.8 39832.4 39880.0 39930.4 39959.0 258232.0 258506.0 258607.0 259069.0 259161.0 34167.8 34764.7 34767.1 34863.0 34880.8 42626.8 42972.4 43682.3 44054.3 44140.6 36069.6 36764.3 36812.4 36954.0 37029.4 35948.3 36069.1 36291.5 36313.8 36660.1 36779.0 36917.6 37500.6 37956.1 37980.6 30566.0 32771.7 33053.2 33068.8 33076.3 25199.0 25241.4 25380.7 25389.7 25822.1 09:24:18 INFO - PROCESS | 9846 | 09:24:18 INFO - PROCESS | 9846 | [#2] jquery.html Cycles:180 Average:37141.18 Median:12407.62 stddev:108123.43 (871.4%) stddev-sans-first:108391.58 09:24:18 INFO - PROCESS | 9846 | Values: 418.3 474.5 480.6 489.5 492.7 19375.4 19707.1 20717.7 21459.4 21781.7 22029.4 22195.3 22213.2 22255.7 22536.9 6557.6 6605.6 6732.2 6775.0 6877.0 4102.6 6622.1 6721.1 6724.3 6730.1 4267.2 4532.9 7744.0 7901.6 7920.4 7740.6 7851.8 7855.9 7886.7 7905.8 7639.4 7676.3 7683.4 7688.6 7695.0 25142.7 25278.6 25509.9 25540.0 25560.4 3000.4 3027.3 3120.1 3168.6 3168.7 15177.4 15371.1 15485.7 16195.1 16770.0 2163.4 2224.6 2229.6 2278.4 2286.9 118054.4 120862.0 121724.0 122202.0 122686.0 14412.8 15889.0 17776.6 18074.7 18083.9 31868.5 31992.2 32023.2 32075.0 32427.2 10312.7 10352.9 10417.7 10557.3 10581.7 8757.6 8766.4 8837.1 8947.1 8957.6 8942.6 8999.4 9230.5 9286.7 9541.6 3401.9 3517.2 3853.2 3908.9 3930.4 897.7 917.5 918.6 946.6 957.1 19612.7 21126.2 21133.0 21145.2 21484.6 930.6 934.8 949.2 952.5 955.3 10763.8 11173.2 11203.0 11227.4 11264.2 625275.0 636752.0 649327.0 679777.0 687047.0 82095.1 85675.6 105324.0 114824.0 116359.4 1221.0 1232.1 1250.0 1262.2 1268.6 13596.5 17148.8 17767.6 19101.9 19483.7 46335.7 49948.0 54043.5 54264.5 55197.4 59629.1 67729.7 68500.0 68828.7 69084.0 11497.2 11735.1 12018.6 12116.7 12237.9 12061.3 12232.4 12372.0 12613.5 12789.1 10931.5 11268.2 11433.8 11692.1 11772.6 11107.4 11536.0 11540.7 11558.7 11644.7 11317.8 11530.9 11810.4 11955.9 12186.5 11432.5 11615.6 11821.5 12048.3 12175.8 11070.8 11158.4 11238.7 11890.2 12141.5 09:24:18 INFO - PROCESS | 9846 | 09:24:18 INFO - PROCESS | 9846 | [#3] mootools.html Cycles:180 Average:7272.49 Median:2241.52 stddev:4681.03 (208.8%) stddev-sans-first:4674.44 09:24:18 INFO - PROCESS | 9846 | Values: 1553.5 1575.3 1594.5 1607.7 1615.0 11017.2 11829.3 11855.9 11863.3 11878.9 11562.5 11696.2 11867.2 12315.1 12320.8 2317.3 2345.1 2352.3 2353.1 2355.4 2282.7 2316.5 2322.9 2326.7 2328.0 2273.9 2316.7 2323.2 2323.4 2324.9 2200.3 2218.1 2218.6 2220.0 2225.5 2213.6 2257.6 2259.5 2265.5 2281.0 11797.9 11884.8 11903.6 11909.6 11927.6 5547.2 5668.0 5672.2 5676.6 5683.3 3385.4 3410.3 3556.1 3589.6 3601.5 1348.5 1355.4 1373.8 1397.1 1454.0 15144.5 15548.1 16601.3 16883.8 17097.2 4563.8 4727.2 4736.5 4737.7 4739.2 13352.3 13355.7 13357.5 13359.8 13361.9 4747.8 4897.0 5498.1 5764.9 5767.3 5352.3 5401.1 5482.2 5483.5 5505.5 3879.9 3900.6 3937.2 3962.9 3964.8 1061.4 1089.7 1103.3 1106.4 1109.4 1033.4 1045.6 1054.5 1057.2 1067.8 6895.9 7006.1 7034.0 7127.1 7228.4 1036.9 1043.3 1051.6 1071.2 1080.6 4669.9 4697.8 4727.1 4807.7 4896.0 14933.8 15368.7 15449.5 15461.0 15475.8 14215.9 14790.8 15227.3 15237.0 15316.2 10661.8 10825.7 10858.7 10870.8 10882.9 7539.7 7724.1 7831.0 7921.8 7958.3 13525.2 13570.9 13587.1 13735.9 13834.6 11379.2 11507.1 13354.8 13425.9 13731.5 9813.5 9964.3 10040.4 10060.1 10064.8 11213.7 11221.7 11275.5 11281.0 11286.3 9831.1 9870.5 9934.4 10003.4 10202.8 9569.4 9708.5 9711.9 9800.0 9882.8 8950.3 8955.6 9004.6 9012.6 9022.8 6588.3 6592.0 6638.4 6641.7 6713.1 6786.8 6818.3 6843.6 6877.1 6934.4 09:24:18 INFO - PROCESS | 9846 | 09:24:18 INFO - PROCESS | 9846 | [#4] prototype.html Cycles:180 Average:4783.39 Median:5342.95 stddev:1300.30 (24.3%) stddev-sans-first:1261.12 09:24:18 INFO - PROCESS | 9846 | Values: 373.7 376.7 385.7 397.4 399.1 5259.7 5313.5 5317.5 5326.4 5333.0 5039.4 5180.8 5239.9 5263.5 5265.3 4204.5 4212.5 4212.6 4216.2 4239.7 4222.2 4227.4 4237.0 4237.7 4253.5 4143.1 4211.9 4216.1 4220.0 4226.4 4068.9 4181.9 4195.2 4198.3 4220.6 3761.0 3763.6 3763.9 3770.7 3795.0 5146.9 5166.0 5187.3 5189.6 5194.6 4806.8 4851.8 5011.5 5052.2 5080.5 5473.8 5480.5 5506.6 5509.6 5518.6 4550.2 4557.7 4562.1 4588.6 4590.4 5459.7 5468.7 5555.6 5721.9 5739.8 4566.4 4673.6 4688.1 4693.4 4712.2 4754.6 4755.4 4756.8 4758.8 4765.8 4950.2 5070.4 5074.2 5081.9 5098.9 5465.8 5466.7 5511.0 5541.8 5549.6 1631.0 1635.5 1640.4 1641.2 1642.6 1191.5 1270.7 1275.9 1278.4 1285.9 5446.9 5456.2 5459.4 5476.8 5529.5 5415.6 5651.0 5677.0 5683.0 5704.3 5450.6 5457.3 5465.3 5472.3 5472.8 2996.0 3002.1 3007.5 3022.2 3046.4 5617.4 5924.0 5942.7 5964.6 5966.6 5827.2 5871.6 5876.5 5884.2 5902.8 5613.5 5777.4 5881.2 5947.4 5947.9 5641.8 5666.7 5668.7 5669.9 5691.7 5605.4 5632.9 5637.7 5640.4 5642.3 5442.3 5617.7 5785.7 5799.3 5817.4 4700.2 4700.5 4704.2 4704.6 4734.1 5473.9 5681.4 5691.2 5698.3 5720.6 5472.8 5509.6 5527.6 5555.3 5555.7 5491.0 5533.6 5538.5 5553.7 5555.5 5352.9 5436.2 5479.5 5497.6 5533.2 5551.2 5552.9 5553.3 5558.2 5561.8 5326.1 5448.3 5461.4 5462.2 5464.0 09:24:18 INFO - PROCESS | 9846 | 09:24:18 INFO - PROCESS | 9846 | [#5] yui.html Cycles:180 Average:17846.16 Median:42882.57 stddev:21518.58 (50.2%) stddev-sans-first:21540.93 09:24:18 INFO - PROCESS | 9846 | Values: 814.2 891.8 896.5 909.1 913.2 15549.5 17645.0 17652.1 17902.3 17993.7 16538.8 16962.6 17148.2 17184.5 17197.1 890.4 911.7 912.2 912.5 912.7 873.8 896.4 898.5 904.6 905.9 919.8 923.7 926.8 928.2 931.4 919.5 922.8 922.9 923.2 923.8 678.5 681.6 681.7 683.0 683.2 15181.0 15285.0 16027.1 16270.5 16348.3 15634.5 15743.5 15854.8 16011.9 16244.0 13332.8 13989.7 14004.2 14045.2 14122.9 4000.6 4036.6 4060.1 4091.4 4213.7 47896.8 56451.0 65295.3 87524.6 88644.1 12318.5 12524.7 12575.4 12627.2 12791.6 22054.7 22110.9 22173.9 22195.3 22252.3 6086.3 7987.2 8335.4 8664.1 8755.6 4933.1 4981.9 4983.8 5045.5 5122.1 3640.7 3743.3 3746.0 3747.6 3747.8 602.1 610.2 621.3 623.4 625.1 663.4 695.8 706.6 764.5 774.2 10558.4 11016.3 11305.5 11458.5 11765.6 641.7 654.5 660.2 683.6 831.2 5283.7 5372.9 5491.8 5511.7 5528.0 80659.6 80859.7 81899.0 81923.6 82599.2 43009.1 60680.7 65044.0 71191.6 74331.0 61146.7 61604.4 61850.4 62143.0 62184.4 11106.9 11363.2 11477.6 11604.4 11624.1 42756.0 43144.0 43669.0 43948.8 44278.8 52129.7 52311.2 52536.0 52690.0 52706.2 13060.3 13126.7 13150.4 13192.9 13297.1 14817.9 14941.1 14950.0 15007.2 15336.8 15091.0 15211.8 15301.1 15301.6 15996.8 14533.1 14977.3 14986.3 15719.1 15860.3 14767.0 14942.7 15327.7 15446.9 16306.4 12870.4 12895.0 13091.5 13233.5 13718.6 12529.7 12636.2 12949.0 13168.0 13322.4 09:24:18 INFO - PROCESS | 9846 | -------- Summary: end -------- 09:24:18 INFO - PROCESS | 9846 | 09:24:19 INFO - TEST-INFO | 9846: exit 0 09:24:19 INFO - TEST-OK | dromaeo_css | took 1115498ms 09:24:19 INFO - TEST-START | kraken 09:24:19 INFO - operating with platform_type : linux_ 09:24:19 INFO - Initialising browser for kraken test... 09:24:19 INFO - TEST-INFO | started process 10174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFq7uzR/profile http://localhost:37396/getInfo.html) 09:24:23 INFO - PROCESS | 10174 | __metrics Screen width/height:1600/1200 09:24:23 INFO - PROCESS | 10174 | colorDepth:24 09:24:23 INFO - PROCESS | 10174 | Browser inner width/height: 1024/697 09:24:23 INFO - PROCESS | 10174 | __metrics 09:24:24 INFO - PROCESS | 10174 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:24:24 INFO - PROCESS | 10174 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:24:24 INFO - PROCESS | 10174 | console.error: PushService: 09:24:24 INFO - PROCESS | 10174 | stateChangeProcessEnqueue: Error transitioning state 09:24:24 INFO - PROCESS | 10174 | UnknownError 09:24:25 INFO - TEST-INFO | 10174: exit 0 09:24:25 INFO - Browser initialized. 09:24:25 INFO - Running cycle 1/1 for kraken test... 09:24:25 INFO - TEST-INFO | started process 10264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFq7uzR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:36 INFO - PROCESS | 10264 | RSS: Main: 139341824 09:24:36 INFO - PROCESS | 10264 | 09:24:39 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37396/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:40 INFO - PROCESS | 10264 | RSS: Main: 182259712 09:24:40 INFO - PROCESS | 10264 | 09:24:42 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37396/tests/kraken/driver.html?testName=audio-dft) 09:24:43 INFO - PROCESS | 10264 | RSS: Main: 173735936 09:24:43 INFO - PROCESS | 10264 | 09:24:46 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37396/tests/kraken/driver.html?testName=audio-fft) 09:24:46 INFO - PROCESS | 10264 | RSS: Main: 265420800 09:24:46 INFO - PROCESS | 10264 | 09:24:48 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37396/tests/kraken/driver.html?testName=audio-oscillator) 09:24:49 INFO - PROCESS | 10264 | RSS: Main: 171360256 09:24:49 INFO - PROCESS | 10264 | 09:24:51 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:52 INFO - PROCESS | 10264 | RSS: Main: 173469696 09:24:52 INFO - PROCESS | 10264 | 09:24:55 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37396/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:55 INFO - PROCESS | 10264 | RSS: Main: 213143552 09:24:55 INFO - PROCESS | 10264 | 09:24:59 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37396/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:59 INFO - PROCESS | 10264 | RSS: Main: 211931136 09:24:59 INFO - PROCESS | 10264 | 09:25:02 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37396/tests/kraken/driver.html?testName=json-parse-financial) 09:25:02 INFO - PROCESS | 10264 | RSS: Main: 210722816 09:25:02 INFO - PROCESS | 10264 | 09:25:04 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:05 INFO - PROCESS | 10264 | RSS: Main: 172793856 09:25:05 INFO - PROCESS | 10264 | 09:25:06 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37396/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:07 INFO - PROCESS | 10264 | RSS: Main: 179638272 09:25:07 INFO - PROCESS | 10264 | 09:25:09 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:09 INFO - PROCESS | 10264 | RSS: Main: 188129280 09:25:09 INFO - PROCESS | 10264 | 09:25:12 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:13 INFO - PROCESS | 10264 | RSS: Main: 198422528 09:25:13 INFO - PROCESS | 10264 | 09:25:15 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:16 INFO - PROCESS | 10264 | RSS: Main: 194269184 09:25:16 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | Cycle 1(1): loaded http://localhost:37396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37396/tests/kraken/driver.html?testName=ai-astar) 09:25:18 INFO - PROCESS | 10264 | RSS: Main: 246263808 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | __start_tp_report 09:25:18 INFO - PROCESS | 10264 | _x_x_mozilla_page_load 09:25:18 INFO - PROCESS | 10264 | _x_x_mozilla_page_load_details 09:25:18 INFO - PROCESS | 10264 | |i|pagename|runs| 09:25:18 INFO - PROCESS | 10264 | |0;ai-astar;110;113;112;113;114;112;111;111;111;113 09:25:18 INFO - PROCESS | 10264 | |1;audio-beat-detection;144;115;119;159;121;117;115;122;135;117 09:25:18 INFO - PROCESS | 10264 | |2;audio-dft;161;160;160;161;160;162;161;162;160;161 09:25:18 INFO - PROCESS | 10264 | |3;audio-fft;76;77;75;102;77;76;76;76;90;77 09:25:18 INFO - PROCESS | 10264 | |4;audio-oscillator;82;82;101;81;81;81;104;82;81;104 09:25:18 INFO - PROCESS | 10264 | |5;imaging-gaussian-blur;113;113;113;114;114;113;113;113;113;113 09:25:18 INFO - PROCESS | 10264 | |6;imaging-darkroom;147;147;147;146;147;146;147;146;147;147 09:25:18 INFO - PROCESS | 10264 | |7;imaging-desaturate;95;94;95;95;94;94;94;94;94;95 09:25:18 INFO - PROCESS | 10264 | |8;json-parse-financial;55;55;59;56;56;57;57;55;56;56 09:25:18 INFO - PROCESS | 10264 | |9;json-stringify-tinderbox;52;53;52;55;52;51;52;53;52;52 09:25:18 INFO - PROCESS | 10264 | |10;stanford-crypto-aes;75;80;75;79;75;75;75;76;75;75 09:25:18 INFO - PROCESS | 10264 | |11;stanford-crypto-ccm;124;126;124;130;131;120;120;119;165;120 09:25:18 INFO - PROCESS | 10264 | |12;stanford-crypto-pbkdf2;169;160;163;159;162;159;158;161;159;159 09:25:18 INFO - PROCESS | 10264 | |13;stanford-crypto-sha256-iterative;62;60;61;59;63;59;60;62;64;60 09:25:18 INFO - PROCESS | 10264 | __end_tp_report 09:25:18 INFO - PROCESS | 10264 | __start_cc_report 09:25:18 INFO - PROCESS | 10264 | _x_x_mozilla_cycle_collect,1652 09:25:18 INFO - PROCESS | 10264 | __end_cc_report 09:25:18 INFO - PROCESS | 10264 | __startTimestamp1490286318400__endTimestamp 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | ------- Summary: start ------- 09:25:18 INFO - PROCESS | 10264 | Number of tests: 14 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:1.25 (1.1%) stddev-sans-first:1.09 09:25:18 INFO - PROCESS | 10264 | Values: 110.0 113.0 112.0 113.0 114.0 112.0 111.0 111.0 111.0 113.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:121.50 stddev:14.86 (12.2%) stddev-sans-first:14.33 09:25:18 INFO - PROCESS | 10264 | Values: 144.0 115.0 119.0 159.0 121.0 117.0 115.0 122.0 135.0 117.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:25:18 INFO - PROCESS | 10264 | Values: 161.0 160.0 160.0 161.0 160.0 162.0 161.0 162.0 160.0 161.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.50 stddev:8.82 (11.5%) stddev-sans-first:9.22 09:25:18 INFO - PROCESS | 10264 | Values: 76.0 77.0 75.0 102.0 77.0 76.0 76.0 76.0 90.0 77.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#4] audio-oscillator Cycles:10 Average:87.90 Median:81.00 stddev:10.46 (12.9%) stddev-sans-first:10.88 09:25:18 INFO - PROCESS | 10264 | Values: 82.0 82.0 101.0 81.0 81.0 81.0 104.0 82.0 81.0 104.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:25:18 INFO - PROCESS | 10264 | Values: 113.0 113.0 113.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:25:18 INFO - PROCESS | 10264 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:25:18 INFO - PROCESS | 10264 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.23 (2.2%) stddev-sans-first:1.22 09:25:18 INFO - PROCESS | 10264 | Values: 55.0 55.0 59.0 56.0 56.0 57.0 57.0 55.0 56.0 56.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#9] json-stringify-tinderbox Cycles:10 Average:52.40 Median:52.00 stddev:1.07 (2.1%) stddev-sans-first:1.13 09:25:18 INFO - PROCESS | 10264 | Values: 52.0 53.0 52.0 55.0 52.0 51.0 52.0 53.0 52.0 52.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.00 stddev:1.89 (2.5%) stddev-sans-first:1.96 09:25:18 INFO - PROCESS | 10264 | Values: 75.0 80.0 75.0 79.0 75.0 75.0 75.0 76.0 75.0 75.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:125.00 stddev:13.71 (11.0%) stddev-sans-first:14.47 09:25:18 INFO - PROCESS | 10264 | Values: 124.0 126.0 124.0 130.0 131.0 120.0 120.0 119.0 165.0 120.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:160.50 stddev:3.25 (2.0%) stddev-sans-first:1.66 09:25:18 INFO - PROCESS | 10264 | Values: 169.0 160.0 163.0 159.0 162.0 159.0 158.0 161.0 159.0 159.0 09:25:18 INFO - PROCESS | 10264 | 09:25:18 INFO - PROCESS | 10264 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.50 stddev:1.70 (2.8%) stddev-sans-first:1.76 09:25:18 INFO - PROCESS | 10264 | Values: 62.0 60.0 61.0 59.0 63.0 59.0 60.0 62.0 64.0 60.0 09:25:18 INFO - PROCESS | 10264 | -------- Summary: end -------- 09:25:18 INFO - PROCESS | 10264 | 09:25:19 INFO - TEST-INFO | 10264: exit 0 09:25:19 INFO - TEST-OK | kraken | took 60440ms 09:25:19 INFO - SUITE-END | took 1175s 09:25:19 INFO - Completed test suite (00:19:36) 09:25:19 INFO - javascript benchmark 09:25:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7812.655607856057, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.794812311261, 3424.4349682302422, 3441.5698037745283, 3450.7411944104197, 3480.1995541025562, 5853.560982926277, 5929.43670351317, 5937.85155371116, 5941.168236446901, 5942.970285148574, 5904.114382842576, 5968.224130862993, 5970.313413957396, 5972.581919265654, 5973.372795856427, 5381.165919282507, 5406.432324605918, 5437.870707272085, 5441.727913604304, 5491.0, 5188.6367954243215, 5225.8954820903555, 5365.678059316453, 5479.287692599956, 5498.945010549904, 5381.730913454331, 5410.783568657269, 5416.864578385533, 5429.619926605139, 5464.0711079116445, 5455.099908515091, 5464.043792336365, 5465.180222966547, 5469.589780766419, 5475.0, 5200.3759548854005, 5225.268462415227, 5312.0, 5374.973125134349, 5468.972655136698, 5735.4551317624755, 5762.3373312069225, 5803.361630220672, 5822.505087067604, 5843.123531470271, 6263.1544741459775, 6293.842653933642, 6327.24073111225, 6336.778212762577, 6338.778142765027, 6077.118817771443, 6354.17395738551, 6367.140436041122, 6382.648954307511, 6389.233292004943, 5760.0783874579865, 5876.4123587641325, 5881.088431293157, 5918.585699001114, 5937.2578427696535, 6458.580192287486, 6462.547621666438, 6512.446442052384, 6523.8695226095215, 6527.836804079841, 6248.718807653667, 6252.781152659635, 6264.906026409608, 6270.655113968684, 6273.404026617464, 6090.147379366892, 6122.510199184055, 6174.722137503823, 6186.19579454668, 6195.101710252078, 6288.811335659938, 6291.496680265659, 6294.622322660655, 6297.2128483939505, 6298.905516417258, 6067.150598916155, 6132.110843927606, 6132.386761323832, 6134.938650613526, 6150.384961503813, 4548.499665036909, 4664.486906440289, 4669.9726060266685, 4674.579287864109, 4674.813007479731, 4189.2459357315975, 4262.595053469915, 4272.29507131326, 4284.957150428456, 4288.871333859989, 6010.3689112643415, 6031.728572214261, 6061.666608336495, 6106.938930610637, 6125.571219981323, 6391.680415979183, 6397.6801159941815, 6398.168238129014, 6405.839854003687, 6407.038944158414, 6111.297200821962, 6114.877702446015, 6121.938780612226, 6124.142620033199, 6138.048602466625, 5199.974000129975, 5228.869278268074, 5276.683398996072, 5287.259783630295, 5335.146376579806, 6551.0173473979285, 6574.178227721535, 6577.177852768404, 6578.638174900427, 6586.27550969393, 6292.590981586182, 6298.968505157445, 6332.620042797447, 6338.746450141943, 6353.269374021862, 6282.497400207881, 6338.302786693553, 6422.0, 6467.838304042437, 6572.079908812866, 6212.0371342441995, 6225.595336303126, 6226.346233645583, 6226.533010024175, 6229.595076320024, 6381.138546296191, 6383.1382763326355, 6384.106225128578, 6384.457321127757, 6385.936140638534, 5940.495057919952, 5993.250843644544, 6085.57400981927, 6116.785912493041, 6177.0, 6118.771466972081, 6136.171616831671, 6151.32335443092, 6163.1679723238585, 6204.0, 6182.443580077635, 6183.041628547402, 6184.81445556634, 6189.35011823752, 6193.752249910133, 5983.850403739942, 5996.610220335664, 6050.45545900871, 6128.63228206309, 6198.256209254738, 6074.058520929263, 6074.696265186812, 6108.419700128481, 6116.113163591165, 6116.66358350295], "value": 5808.096574033926, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.2588663110151, 820.6799348254181, 835.6156168162645, 894.4543828264757, 901.7970956534776, 30537.389252214944, 43776.78111609441, 43784.562154378444, 43825.34261986073, 44059.33910991338, 40667.38998915011, 40930.18139637213, 40999.18001639973, 45688.0, 45777.542224577744, 7572.432067594925, 7720.536767793922, 8996.550172491381, 9139.58871850765, 9160.541972901361, 10443.321184123046, 10663.520141593608, 10671.092957098655, 10676.78646427071, 11041.723956901062, 10825.729356766104, 10848.78302433951, 10864.293820901656, 10868.565257389695, 10875.619353322636, 10761.408122553257, 10879.401632910187, 10884.891151088466, 10887.618933337295, 10892.945535272353, 10442.738931526697, 10491.318064325795, 10507.579696812194, 10523.0, 10536.947315263375, 41970.79014604938, 42289.57710422918, 42583.57416425858, 42618.0, 42657.786711066554, 4131.088155092456, 4188.874333769992, 4196.727212731163, 4261.531231564525, 4343.587359200871, 28880.566791498146, 28913.132606021853, 29155.41689166226, 30219.0, 30270.394592108256, 4177.770222637754, 4208.389783481409, 4251.149770046003, 4332.891677708051, 4361.3457981302745, 219473.0, 219964.0, 220286.0, 220362.0, 221111.89444052838, 51066.48933510618, 51195.232071518956, 51473.48526514762, 51650.22524662133, 51676.74161629168, 52429.73785131126, 52480.0, 52484.21273680898, 52528.73735631374, 52558.73720631449, 16487.0, 16863.831361686225, 16902.154892255337, 16911.069891156105, 16911.91544042272, 12922.806157907638, 13172.670683232804, 14649.853501465062, 15189.848101519065, 15190.0, 13146.276954767389, 13183.340832958314, 13189.406476708571, 13240.337983100999, 13330.733385332433, 5520.227168196456, 5575.4424557544735, 5606.243157173811, 5618.410066942994, 5646.830595082154, 985.5811280205884, 988.0564061321421, 993.9006099390003, 999.065873408351, 1004.7186787699455, 27820.721792782217, 28138.2965425866, 28508.28729281743, 28579.0, 28604.284892877844, 1045.3048722599538, 1061.91504679627, 1063.0167095436846, 1067.9733006674896, 1095.0473088412973, 14576.052556583789, 14909.850901490847, 14941.850581494264, 15017.474388396573, 15021.0, 292101.0, 293171.0, 293224.0, 293705.0, 293757.0, 54792.72603636956, 54794.726026369615, 54831.62920927009, 54834.45165548293, 54913.450865491635, 1504.9849501505064, 1510.7507261301982, 1539.468883235282, 1541.1600677630718, 1546.3737186439284, 25762.613560796977, 27243.318917027234, 27257.31856703598, 27350.179494615193, 27533.31166720848, 39791.80104099461, 39832.402513962894, 39880.0, 39930.401043984944, 39959.0, 258232.0, 258506.0, 258607.0, 259069.0, 259161.0, 34167.82916085404, 34764.65235347614, 34767.13082172865, 34863.0, 34880.82559587288, 42626.78686606547, 42972.35541466818, 43682.34476482792, 44054.3391849129, 44140.55859441365, 36069.63930360663, 36764.26471470609, 36812.447813282284, 36954.0, 37029.44455833219, 35948.28103437864, 36069.098272542346, 36291.45562816613, 36313.818430907675, 36660.08349791277, 36779.0, 36917.63082369142, 37500.62499374971, 37956.05109872275, 37980.62019379771, 30566.0, 32771.67228327782, 33053.17367065747, 33068.83465582753, 33076.33847322992, 25199.0, 25241.36896577527, 25380.746192538576, 25389.74610253874, 25822.096226631977], "value": 18812.66255304365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.3181414294699, 474.45674702465675, 480.6011010860986, 489.52271535253124, 492.67729637087706, 19375.418737437863, 19707.113179906904, 20717.68923466149, 21459.356219313406, 21781.673274900888, 22029.449263768412, 22195.334139975785, 22213.2225372112, 22255.666165007537, 22536.8873155634, 6557.639329836857, 6605.603663780164, 6732.225794033675, 6775.0, 6876.965615171917, 4102.5692302308125, 6622.072909792633, 6721.0926524919, 6724.293949135344, 6730.091437655903, 4267.189234045537, 4532.91210109573, 7744.0, 7901.565413902233, 7920.366370690331, 7740.574268415235, 7851.764447066597, 7855.921440785633, 7886.6845326186885, 7905.802354941115, 7639.427042971799, 7676.347510461617, 7683.385329173652, 7688.6155692215725, 7694.961525192394, 25142.748572514407, 25278.620820687705, 25509.872450637813, 25540.0, 25560.360990975187, 3000.384921091193, 3027.2583217111946, 3120.1419609607315, 3168.6356069051894, 3168.651448340681, 15177.392904283926, 15371.077735335915, 15485.690286194325, 16195.109268990202, 16770.0, 2163.383435720828, 2224.588451136545, 2229.5763804877183, 2278.350670059042, 2286.8970896309706, 118054.40972795167, 120862.0, 121724.0, 122202.0, 122686.0, 14412.769466368134, 15889.0, 17776.555586110193, 18074.728879066824, 18083.909580452015, 31868.521972170434, 31992.200194994846, 32023.199420014687, 32075.0, 32427.18932026718, 10312.742181445525, 10352.896471035343, 10417.739556511147, 10557.313774604627, 10581.682549523526, 8757.56212189388, 8766.386352955233, 8837.116288371111, 8947.10528947113, 8957.596908139149, 8942.597583108776, 8999.422092026905, 9230.492322922304, 9286.674966376144, 9541.618335266512, 3401.8809341672923, 3517.2086280586664, 3853.190829925747, 3908.882733517942, 3930.3711406174875, 897.7351681254046, 917.4816228830823, 918.6233644205977, 946.6260826973307, 957.1337939165066, 19612.70580941287, 21126.154953801983, 21133.0, 21145.154193832383, 21484.570308593742, 930.6370515498961, 934.7756538430727, 949.2263804998904, 952.5046975572664, 955.3360414511848, 10763.784724305626, 11173.217874748852, 11203.0, 11227.438628068563, 11264.221116550798, 625275.0, 636752.0, 649327.0, 679777.0, 687047.0, 82095.14799970078, 85675.57162214149, 105324.0, 114824.0, 116359.41820290845, 1221.0170812495849, 1232.0944106082022, 1250.031225799994, 1262.1543565810928, 1268.5686866465262, 13596.456141754219, 17148.828511714724, 17767.555811104827, 19101.90449047746, 19483.707744383562, 46335.6832158384, 49948.0, 54043.45956540384, 54264.45735542594, 55197.44802551923, 59629.10556341745, 67729.66135169292, 68499.97250041353, 68828.65585672039, 69084.0, 11497.19519633651, 11735.119866010255, 12018.639440816789, 12116.697082573006, 12237.877621223673, 12061.276323420623, 12232.449539770909, 12372.0, 12613.49546018149, 12789.104762666524, 10931.453427328443, 11268.154888383568, 11433.828492572451, 11692.064634829363, 11772.646820595395, 11107.38909359993, 11536.0, 11540.711482213012, 11558.711032224262, 11644.6506604802, 11317.830232546354, 11530.94234528822, 11810.40947952616, 11955.880441195824, 12186.451609677408, 11432.542698291974, 11615.593454229062, 11821.468033938665, 12048.277103373826, 12175.817362739743, 11070.833937491105, 11158.442077896236, 11238.66284011481, 11890.167688262085, 12141.453634586289], "value": 11222.844100725983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1553.4795843392462, 1575.2753733282689, 1594.5216435069483, 1607.6543543138223, 1615.0390517642, 11017.228793984414, 11829.349385783778, 11855.940720296398, 11863.347515886622, 11878.940605296983, 11562.47968841402, 11696.18126731129, 11867.169298149132, 12315.076369272296, 12320.753584928296, 2317.2700599311165, 2345.108858633717, 2352.3178278299274, 2353.070537137838, 2355.3640517060385, 2282.7032485776826, 2316.455632926261, 2322.918697845576, 2326.7091613548305, 2327.976720232793, 2273.897674604647, 2316.698829152208, 2323.2101085630884, 2323.3610757041865, 2324.9418764530938, 2200.3288996855954, 2218.1127548980376, 2218.6450167973126, 2220.0, 2225.4547635829244, 2213.579419910212, 2257.593633146033, 2259.4916143867663, 2265.456290490287, 2280.9657855132186, 11797.941010294979, 11884.821727674092, 11903.583374581935, 11909.642710718692, 11927.582534611334, 5547.1679248113105, 5667.971660141714, 5672.177534257509, 5676.574256930706, 5683.318001839764, 3385.3906296866553, 3410.2667926395943, 3556.0754203906913, 3589.587197472272, 3601.531800865897, 1348.4673553946234, 1355.3697530648196, 1373.7870630052357, 1397.0639671420172, 1453.978190327146, 15144.469943551923, 15548.067115973077, 16601.335946562, 16883.831161688347, 17097.230624621796, 4563.771811409416, 4727.227289766338, 4736.502667219892, 4737.739424331626, 4739.241721324572, 13352.332383380986, 13355.732885342433, 13357.53248636293, 13359.799603005962, 13361.866381336062, 4747.786349614275, 4896.95103048972, 5498.092814685532, 5764.855878602984, 5767.250257466502, 5352.330958630171, 5401.081816091274, 5482.17767334895, 5483.506484416342, 5505.504504594605, 3879.8642047528765, 3900.6294402031763, 3937.1731936293127, 3962.8612998544913, 3964.7819369934355, 1061.3737894642045, 1089.6894385100368, 1103.27184058521, 1106.4246591772232, 1109.4064675398622, 1033.4161198922584, 1045.6340280901622, 1054.5096530113533, 1057.1648397765832, 1067.8344856547249, 6895.896561551581, 7006.0892084029765, 7033.964830175816, 7127.144742630918, 7228.38558722504, 1036.9429681367446, 1043.3270540501485, 1051.6319288249051, 1071.164491696478, 1080.6172389880296, 4669.859904202879, 4697.78859951303, 4727.078219747116, 4807.687500312539, 4896.0, 14933.775993360108, 15368.692626147638, 15449.459268925533, 15461.0, 15475.845241547666, 14215.928920355333, 14790.778138327934, 15227.314770835339, 15237.0, 15316.15761133126, 10661.786764264827, 10825.67522974312, 10858.728531786768, 10870.782584348426, 10882.891171088346, 7539.736109236151, 7724.111727151225, 7830.960845195737, 7921.841563168819, 7958.283754462126, 13525.18848869071, 13570.864291357355, 13587.116837405538, 13735.862641373458, 13834.584962451143, 11379.203455758348, 11507.079433645456, 13354.799678004643, 13425.925925926098, 13731.45074197021, 9813.460259685786, 9964.252681049094, 10040.447775372424, 10060.144887684335, 10064.798704025732, 11213.66359009231, 11221.71945701364, 11275.548978041115, 11281.0, 11286.322820630789, 9831.115199632068, 9870.457124857914, 9934.403935763878, 10003.399796012263, 10202.795944081225, 9569.425834449956, 9708.5145742714, 9711.854322185314, 9800.0, 9882.802343953224, 8950.283977281671, 8955.552222388986, 9004.594793234452, 9012.594433250388, 9022.819543609223, 6588.275289718223, 6592.044153597605, 6638.369354911276, 6641.701123449553, 6713.060171575886, 6786.76246331376, 6818.271977150064, 6843.589384636938, 6877.105976223059, 6934.410575100971], "value": 5450.17737814378, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7103744597936, 376.6873494999151, 385.7010816617121, 397.39000634026763, 399.06817580948484, 5259.684418934862, 5313.485656587874, 5317.548008419284, 5326.378062917215, 5333.026780091372, 5039.370078740158, 5180.782516108711, 5239.8996210795685, 5263.526282634562, 5265.262863199146, 4204.516480604739, 4212.452381190441, 4212.620864122228, 4216.156768646268, 4239.724417912826, 4222.218889505436, 4227.429297044906, 4237.0254841386495, 4237.749863790174, 4253.532111467736, 4143.107380440266, 4211.8525851595205, 4216.114615930643, 4219.978900105495, 4226.429432026668, 4068.9389659155136, 4181.937270940908, 4195.244855925932, 4198.328267477189, 4220.556841531657, 3760.981195094007, 3763.5860055393887, 3763.9435408468894, 3770.6794922431627, 3794.9810250948844, 5146.871328216787, 5165.966806638688, 5187.273781670531, 5189.558887494568, 5194.558462530689, 4806.7836947337455, 4851.781669824866, 5011.5489605935645, 5052.191649336089, 5080.466551012128, 5473.75368108436, 5480.451954804527, 5506.5870059745275, 5509.614326997112, 5518.633633483571, 4550.249208880531, 4557.703749256321, 4562.133194692998, 4588.646349326957, 4590.449146102455, 5459.69971651559, 5468.7268598508845, 5555.638883472561, 5721.885562288772, 5739.827805165852, 4566.406367172246, 4673.649476289292, 4688.093002816476, 4693.366395536627, 4712.175369310357, 4754.619630429557, 4755.432066683952, 4756.809727610926, 4758.833440829554, 4765.76171191446, 4950.168437678082, 5070.391553013662, 5074.16276314404, 5081.8729531762, 5098.898022039539, 5465.781368745285, 5466.72666366688, 5511.0, 5541.810984661117, 5549.611527193058, 1630.9918450407672, 1635.5175223309152, 1640.4340502526609, 1641.1712085397037, 1642.6468309313555, 1191.511480293093, 1270.6632742323293, 1275.9043071769654, 1278.367208231931, 1285.9035572332114, 5446.9106178764405, 5456.236126942231, 5459.434065988979, 5476.808311709071, 5529.529989950819, 5415.620906536505, 5651.0, 5677.041420709848, 5682.971585142048, 5704.3154821421695, 5450.591205659592, 5457.317835270591, 5465.316835395575, 5472.288602481652, 5472.798412928481, 2996.0, 3002.084364268875, 3007.4887269164296, 3022.199117233935, 3046.3602643444683, 5617.43825617435, 5924.022536281552, 5942.70286485674, 5964.612300200473, 5966.552508561876, 5827.184194212814, 5871.64770113786, 5876.471117599436, 5884.176215329857, 5902.793402230987, 5613.522850557667, 5777.422257774189, 5881.206037185097, 5947.405259474104, 5947.910781338197, 5641.802536911188, 5666.660000399989, 5668.716564171693, 5669.858253543694, 5691.7233106755975, 5605.439456054362, 5632.887342253214, 5637.746301416528, 5640.364294354591, 5642.294713160855, 5442.346918369821, 5617.6910269933915, 5785.652860828363, 5799.333076696065, 5817.447342502455, 4700.153972285021, 4700.45944716362, 4704.224507540567, 4704.647151463722, 4734.100520901018, 5473.917891231715, 5681.4034526374135, 5691.203231547669, 5698.287714035746, 5720.570957178145, 5472.835814925558, 5509.586780991362, 5527.613067085426, 5555.333359996826, 5555.722213889208, 5490.972545137249, 5533.6403133797785, 5538.47384498472, 5553.722313884209, 5555.472230138131, 5352.866178345573, 5436.184572314184, 5479.479449452296, 5497.5601951842955, 5533.225348451139, 5551.195076713934, 5552.918130437646, 5553.305836770403, 5558.194061861089, 5561.805336813192, 5326.055989563859, 5448.346198456211, 5461.426550212171, 5462.180672899097, 5463.972680136574], "value": 4399.0586752336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.1858141858141, 891.7592250092475, 896.5293221058945, 909.1272378516624, 913.2191975860638, 15549.479934623216, 17645.0, 17652.117394130273, 17902.28390864364, 17993.730094048584, 16538.83461165388, 16962.575935601617, 17148.228329725192, 17184.484465466056, 17197.054162021082, 890.3900827932854, 911.6991392840347, 912.1562554636968, 912.4570880326195, 912.6896855069275, 873.8033942362981, 896.4397251717677, 898.4743924803964, 904.6110172625769, 905.868649045888, 919.7516670498961, 923.6628630549868, 926.8239034583441, 928.1553786054692, 931.4039015030386, 919.5126582911067, 922.7969846633763, 922.8661844032612, 923.2152670230317, 923.8152369526088, 678.494521581425, 681.560393546165, 681.7443458702986, 682.969266383014, 683.2347770497025, 15181.0, 15285.006474579117, 16027.104956748999, 16270.51188464348, 16348.346066157339, 15634.530964071097, 15743.527694169194, 15854.841451585567, 16011.919940400223, 16244.02535847853, 13332.802000468244, 13989.720205595831, 14004.22976736279, 14045.157290562598, 14122.92938535311, 4000.579939106381, 4036.5761595032686, 4060.127072679388, 4091.4476545666253, 4213.747175169469, 47896.760516197195, 56451.0, 65295.3470465294, 87524.56237718834, 88644.11355886488, 12318.507259709511, 12524.686882828002, 12575.371231438392, 12627.242365458102, 12791.616251512469, 22054.669179962315, 22110.889445552668, 22173.889130554566, 22195.33413997583, 22252.332430027123, 6086.330503644595, 7987.16134805837, 8335.361704030141, 8664.09027052163, 8755.562221889008, 4933.136701077297, 4981.875453113701, 4983.775730092155, 5045.5459008689395, 5122.052420302256, 3640.7087433005295, 3743.3074881147077, 3745.9812700936322, 3747.6252374762307, 3747.793871337048, 602.120903480914, 610.2402508876477, 621.2948303675271, 623.3579413204316, 625.140431906129, 663.4029373563735, 695.8399568099366, 706.5831159615851, 764.537454839825, 774.194837369141, 10558.366498010144, 11016.283941543774, 11305.547778088785, 11458.54165833374, 11765.588204412805, 641.6727468990848, 654.5254690349459, 660.1648914123638, 683.64365198668, 831.1771346367174, 5283.735813209401, 5372.865678358073, 5491.835244942658, 5511.724413779295, 5528.0, 80659.59670201728, 80859.74411663222, 81899.0, 81923.59038204771, 82599.17400825914, 43009.13981720348, 60680.69659651762, 65043.999999999054, 71191.6440417805, 74331.0, 61146.69426652927, 61604.38395616076, 61850.381496185364, 62143.0, 62184.378156218765, 11106.888931110909, 11363.204575679623, 11477.598284060017, 11604.361760103275, 11624.128190385924, 42756.0, 43144.0, 43669.0, 43948.780256098515, 44278.77860610676, 52129.739351303004, 52311.215331769294, 52536.0, 52690.0, 52706.20940685816, 13060.346982650639, 13126.671833204246, 13150.408231629792, 13192.868071319164, 13297.069205155547, 14817.925910370379, 14941.103533788008, 14949.959440023524, 15007.17460539637, 15336.846631533988, 15091.0, 15211.77182342288, 15301.08193508393, 15301.6174595636, 15996.840031599535, 14533.128012319296, 14977.251137442867, 14986.250687465365, 15719.135447550494, 15860.286287117338, 14767.0, 14942.701145977237, 15327.693446131238, 15446.922765386102, 16306.429274975319, 12870.420831062438, 12895.0, 13091.476340946256, 13233.470661173831, 13718.559551246975, 12529.749405012031, 12636.178648387826, 12949.0, 13167.967539800906, 13322.400491978078], "value": 7733.873915156896, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 112.0, 113.0, 114.0, 112.0, 111.0, 111.0, 111.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 119.0, 159.0, 121.0, 117.0, 115.0, 122.0, 135.0, 117.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 160.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 102.0, 77.0, 76.0, 76.0, 76.0, 90.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 101.0, 81.0, 81.0, 81.0, 104.0, 82.0, 81.0, 104.0], "value": 87.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 59.0, 56.0, 56.0, 57.0, 57.0, 55.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 55.0, 52.0, 51.0, 52.0, 53.0, 52.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 75.0, 79.0, 75.0, 75.0, 75.0, 76.0, 75.0, 75.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 126.0, 124.0, 130.0, 131.0, 120.0, 120.0, 119.0, 165.0, 120.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 160.0, 163.0, 159.0, 162.0, 159.0, 158.0, 161.0, 159.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 59.0, 63.0, 59.0, 60.0, 62.0, 64.0, 60.0], "value": 61.0, "unit": "score"}]}]} 09:25:19 INFO - Return code: 0 09:25:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:19 ERROR - # TBPL SUCCESS # 09:25:19 INFO - Running post-action listener: _resource_record_post_action 09:25:19 INFO - [mozharness: 2017-03-23 16:25:19.722479Z] Finished run-tests step (success) 09:25:19 INFO - Running post-run listener: _resource_record_post_run 09:25:19 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370704384; Read time: 4; Write time: 251448 09:25:19 INFO - TinderboxPrint: CPU usage
13.1% 09:25:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 09:25:19 INFO - TinderboxPrint: I/O write bytes / time
370,704,384 / 251,448 09:25:19 INFO - TinderboxPrint: CPU idle
8,270.5 (86.8%) 09:25:19 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 09:25:19 INFO - TinderboxPrint: Swap in / out
0 / 0 09:25:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117350400; Read time: 0; Write time: 107176 09:25:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253353984; Read time: 4; Write time: 144272 09:25:20 INFO - Running post-run listener: _upload_blobber_files 09:25:20 INFO - Blob upload gear active. 09:25:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:25:20 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'] 09:25:20 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 09:25:20 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:25:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:25:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:23 INFO - (blobuploader) - INFO - Done attempting. 09:25:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:25:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:25:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:24 INFO - (blobuploader) - INFO - Done attempting. 09:25:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:25:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:25:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:25 INFO - (blobuploader) - INFO - Done attempting. 09:25:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:25:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:25:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:26 INFO - (blobuploader) - INFO - Done attempting. 09:25:26 INFO - (blobuploader) - INFO - Iteration through files over. 09:25:26 INFO - Return code: 0 09:25:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:25:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:25:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/992093e492e21cee8140835c5031a3f3db196ea892368dbb9bc26e3e3ef463399cf98cd3991af8492de02356933b77b903e617c3e1eb48dac52390ab26673e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/031a72534827221dfd961c9d153a46f889352ba520052f874691992a85beeb0324bbdfdcff49e9a9b5eae7be93e09cc039bb46e960462f7f9f5049886cd4590e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e3f295df9b3d3f96343392c820b59b4bf0293984fadddf81cf1fe2bca16acf46bf29d23cd52b557923029a1ffbe62fc630d49c99c96507339d8f6e3a46985c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40dff12434151045a83d501b49324646e15f7833941181bc820ef8794ddcf9bb3391eaba3921ef3c214cbb206021d6ef8f5dcc2e808413bfe61f4458811e1e6"} 09:25:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:25:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:25:26 INFO - Contents: 09:25:26 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/992093e492e21cee8140835c5031a3f3db196ea892368dbb9bc26e3e3ef463399cf98cd3991af8492de02356933b77b903e617c3e1eb48dac52390ab26673e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/031a72534827221dfd961c9d153a46f889352ba520052f874691992a85beeb0324bbdfdcff49e9a9b5eae7be93e09cc039bb46e960462f7f9f5049886cd4590e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e3f295df9b3d3f96343392c820b59b4bf0293984fadddf81cf1fe2bca16acf46bf29d23cd52b557923029a1ffbe62fc630d49c99c96507339d8f6e3a46985c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40dff12434151045a83d501b49324646e15f7833941181bc820ef8794ddcf9bb3391eaba3921ef3c214cbb206021d6ef8f5dcc2e808413bfe61f4458811e1e6"} 09:25:26 INFO - Running post-run listener: copy_logs_to_upload_dir 09:25:26 INFO - Copying logs to upload dir... 09:25:26 INFO - mkdir: /builds/slave/test/build/upload/logs 09:25:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.199450 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-23 09:25:26.744205) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 09:25:26.747725) ========= 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-1490285072.505970-148446718 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/992093e492e21cee8140835c5031a3f3db196ea892368dbb9bc26e3e3ef463399cf98cd3991af8492de02356933b77b903e617c3e1eb48dac52390ab26673e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/031a72534827221dfd961c9d153a46f889352ba520052f874691992a85beeb0324bbdfdcff49e9a9b5eae7be93e09cc039bb46e960462f7f9f5049886cd4590e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e3f295df9b3d3f96343392c820b59b4bf0293984fadddf81cf1fe2bca16acf46bf29d23cd52b557923029a1ffbe62fc630d49c99c96507339d8f6e3a46985c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40dff12434151045a83d501b49324646e15f7833941181bc820ef8794ddcf9bb3391eaba3921ef3c214cbb206021d6ef8f5dcc2e808413bfe61f4458811e1e6"} build_url:https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011508 build_url: 'https://queue.taskcluster.net/v1/task/XnpvdJqNT8-kRjsUsUY7vQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/992093e492e21cee8140835c5031a3f3db196ea892368dbb9bc26e3e3ef463399cf98cd3991af8492de02356933b77b903e617c3e1eb48dac52390ab26673e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/031a72534827221dfd961c9d153a46f889352ba520052f874691992a85beeb0324bbdfdcff49e9a9b5eae7be93e09cc039bb46e960462f7f9f5049886cd4590e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e3f295df9b3d3f96343392c820b59b4bf0293984fadddf81cf1fe2bca16acf46bf29d23cd52b557923029a1ffbe62fc630d49c99c96507339d8f6e3a46985c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40dff12434151045a83d501b49324646e15f7833941181bc820ef8794ddcf9bb3391eaba3921ef3c214cbb206021d6ef8f5dcc2e808413bfe61f4458811e1e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 09:25:26.775972) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:25:26.776533) ========= 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-1490285072.505970-148446718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:25:26.859712) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 09:25:26.860083) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 09:25:26.860404) ========= ========= Total master_lag: 0.19 =========