builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1489188165.61 results: success (0) revision: 858b0ab812dfd88fa701a3e4f307f56bb1246e80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:45.614064) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:45.614654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:45.615009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:45.629789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:45.630251) ========= 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=c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-10 15:22:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.1M=0.001s 2017-03-10 15:22:45 (23.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086298 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:45.731303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:45.731973) ========= 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=c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019710 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:45.782466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 15:22:45.782843) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 858b0ab812dfd88fa701a3e4f307f56bb1246e80 --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 858b0ab812dfd88fa701a3e4f307f56bb1246e80 --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=c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-10 15:22:45,912 truncating revision to first 12 chars 2017-03-10 15:22:45,912 Setting DEBUG logging. 2017-03-10 15:22:45,912 attempt 1/10 2017-03-10 15:22:45,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/858b0ab812df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 15:22:46,995 unpacking tar archive at: mozilla-aurora-858b0ab812df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.413652 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 15:22:47.209644) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:47.209958) ========= script_repo_revision: 858b0ab812dfd88fa701a3e4f307f56bb1246e80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:47.210337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:47.210598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 15:22:47.221912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-10 15:22:47.222201) ========= /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=c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:22:47 INFO - MultiFileLogger online at 20170310 15:22:47 in /builds/slave/test 15:22:47 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 15:22:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:22:47 INFO - {'append_to_log': False, 15:22:47 INFO - 'base_work_dir': '/builds/slave/test', 15:22:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:22:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:22:47 INFO - 'branch': 'Mozilla-Aurora', 15:22:47 INFO - 'buildbot_json_path': 'buildprops.json', 15:22:47 INFO - 'config_files': ('talos/linux_config.py',), 15:22:47 INFO - 'default_actions': ('clobber', 15:22:47 INFO - 'read-buildbot-config', 15:22:47 INFO - 'download-and-extract', 15:22:47 INFO - 'populate-webroot', 15:22:47 INFO - 'create-virtualenv', 15:22:47 INFO - 'install', 15:22:47 INFO - 'run-tests'), 15:22:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:22:47 INFO - 'download_minidump_stackwalk': True, 15:22:47 INFO - 'download_symbols': 'ondemand', 15:22:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:22:47 INFO - 'tooltool.py': '/tools/tooltool.py', 15:22:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:22:47 INFO - '/tools/misc-python/virtualenv.py')}, 15:22:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:22:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:22:47 INFO - 'gecko_profile': False, 15:22:47 INFO - 'gecko_profile_interval': 0, 15:22:47 INFO - 'installer_path': 'installer.exe', 15:22:47 INFO - 'log_level': 'info', 15:22:47 INFO - 'log_name': 'talos', 15:22:47 INFO - 'log_to_console': True, 15:22:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:22:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:22:47 INFO - 'opt_config_files': (), 15:22:47 INFO - 'pip_index': False, 15:22:47 INFO - 'suite': 'dromaeojs', 15:22:47 INFO - 'system_bits': '32', 15:22:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:22:47 INFO - 'title': 'talos-linux64-ix-004', 15:22:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:22:47 INFO - 'use_talos_json': True, 15:22:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:22:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:22:47 INFO - 'work_dir': 'build'} 15:22:47 INFO - [mozharness: 2017-03-10 23:22:47.457852Z] Running clobber step. 15:22:47 INFO - Running pre-action listener: _resource_record_pre_action 15:22:47 INFO - Running main action method: clobber 15:22:47 INFO - rmtree: /builds/slave/test/build 15:22:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:22:48 INFO - Running post-action listener: _resource_record_post_action 15:22:48 INFO - [mozharness: 2017-03-10 23:22:48.377846Z] Finished clobber step (success) 15:22:48 INFO - [mozharness: 2017-03-10 23:22:48.377945Z] Running read-buildbot-config step. 15:22:48 INFO - Running pre-action listener: _resource_record_pre_action 15:22:48 INFO - Running main action method: read_buildbot_config 15:22:48 INFO - Using buildbot properties: 15:22:48 INFO - { 15:22:48 INFO - "project": "", 15:22:48 INFO - "product": "firefox", 15:22:48 INFO - "who": "ryanvm@gmail.com", 15:22:48 INFO - "installer_path": "public/build/target.tar.bz2", 15:22:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:22:48 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 15:22:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:22:48 INFO - "stage_platform": "linux64-pgo", 15:22:48 INFO - "basedir": "/builds/slave/test", 15:22:48 INFO - "buildnumber": 1094, 15:22:48 INFO - "platform": "ubuntu64_hw", 15:22:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:22:48 INFO - "slavebuilddir": "test", 15:22:48 INFO - "taskId": "JTeYd8K4QqW_o4_NSdYKWg", 15:22:48 INFO - "branch": "mozilla-aurora", 15:22:48 INFO - "script_repo_revision": "production", 15:22:48 INFO - "revision": "858b0ab812dfd88fa701a3e4f307f56bb1246e80", 15:22:48 INFO - "slavename": "talos-linux64-ix-004", 15:22:48 INFO - "repo_path": "releases/mozilla-aurora" 15:22:48 INFO - } 15:22:48 INFO - Finding installer, test and symbols from parent task. 15:22:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JTeYd8K4QqW_o4_NSdYKWg'}, attempt #1 15:22:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JTeYd8K4QqW_o4_NSdYKWg'}, attempt #1 15:22:49 INFO - Task dependencies: P4LUcqdiSdmLFWaxlvVytw 15:22:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw'}, attempt #1 15:22:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.tar.bz2 15:22:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/test_packages.json 15:22:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.crashreporter-symbols.zip 15:22:49 INFO - Running post-action listener: _resource_record_post_action 15:22:49 INFO - [mozharness: 2017-03-10 23:22:49.749312Z] Finished read-buildbot-config step (success) 15:22:49 INFO - [mozharness: 2017-03-10 23:22:49.749538Z] Running download-and-extract step. 15:22:49 INFO - Running pre-action listener: _resource_record_pre_action 15:22:49 INFO - Running main action method: download_and_extract 15:22:49 INFO - mkdir: /builds/slave/test/build/tests 15:22:49 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')]} 15:22:49 INFO - trying https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.test_packages.json 15:22:49 INFO - Downloading https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:22:50 INFO - Downloaded 896 bytes. 15:22:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:22:50 INFO - Using the following test package requirements: 15:22:50 INFO - {u'common': [u'target.common.tests.zip'], 15:22:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:22:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:22:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:22:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:22:50 INFO - u'mozbase': [u'target.common.tests.zip'], 15:22:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:22:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:22:50 INFO - u'web-platform': [u'target.common.tests.zip', 15:22:50 INFO - u'target.web-platform.tests.zip'], 15:22:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:22:50 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:22:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.common.tests.zip 15:22:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:22:50 INFO - Fetch https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.common.tests.zip into memory 15:22:51 INFO - Expected file size: 59528409 15:22:51 INFO - Obtained file size: 59528409 15:23:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:23:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.common.tests.zip 15:23:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:23:01 INFO - Fetch https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.common.tests.zip into memory 15:23:02 INFO - Expected file size: 59528409 15:23:02 INFO - Obtained file size: 59528409 15:23:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.talos.tests.zip 15:23:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:23:12 INFO - Fetch https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.talos.tests.zip into memory 15:23:13 INFO - Expected file size: 14404424 15:23:13 INFO - Obtained file size: 14404424 15:23:13 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')]} 15:23:13 INFO - trying https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.tar.bz2 15:23:13 INFO - Downloading https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:23:14 INFO - Downloaded 66656030 bytes. 15:23:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.tar.bz2 15:23:14 INFO - mkdir: /builds/slave/test/properties 15:23:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:23:14 INFO - Writing to file /builds/slave/test/properties/build_url 15:23:14 INFO - Contents: 15:23:14 INFO - build_url:https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.tar.bz2 15:23:14 INFO - Running post-action listener: _resource_record_post_action 15:23:14 INFO - Running post-action listener: set_extra_try_arguments 15:23:14 INFO - [mozharness: 2017-03-10 23:23:14.951956Z] Finished download-and-extract step (success) 15:23:14 INFO - [mozharness: 2017-03-10 23:23:14.952052Z] Running populate-webroot step. 15:23:14 INFO - Running pre-action listener: _resource_record_pre_action 15:23:14 INFO - Running main action method: populate_webroot 15:23:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:23:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:23:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:23:14 INFO - '--tppagecycles', 15:23:14 INFO - '7'], 15:23:14 INFO - 'tests': ['tsvgm']}}, 15:23:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:23:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:23:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:23:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:23:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:23:14 INFO - 'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:23:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:23:14 INFO - 'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['damp', 'tps']}, 15:23:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:23:14 INFO - 'tests': ['damp', 'tps']}, 15:23:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['dromaeo_dom']}, 15:23:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:23:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['basic_compositor_video']}, 15:23:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:23:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['a11yr', 15:23:14 INFO - 'ts_paint', 15:23:14 INFO - 'tpaint', 15:23:14 INFO - 'sessionrestore', 15:23:14 INFO - 'sessionrestore_no_auto_restore', 15:23:14 INFO - 'tabpaint']}, 15:23:14 INFO - 'other-e10s': {'tests': ['a11yr', 15:23:14 INFO - 'ts_paint', 15:23:14 INFO - 'tpaint', 15:23:14 INFO - 'sessionrestore', 15:23:14 INFO - 'sessionrestore_no_auto_restore', 15:23:14 INFO - 'tabpaint']}, 15:23:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:23:14 INFO - 'ts_paint', 15:23:14 INFO - 'tpaint', 15:23:14 INFO - 'sessionrestore', 15:23:14 INFO - 'sessionrestore_no_auto_restore', 15:23:14 INFO - 'tabpaint']}, 15:23:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:23:14 INFO - 'ts_paint', 15:23:14 INFO - 'tpaint', 15:23:14 INFO - 'sessionrestore', 15:23:14 INFO - 'sessionrestore_no_auto_restore', 15:23:14 INFO - 'tabpaint']}, 15:23:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['a11yr', 15:23:14 INFO - 'ts_paint', 15:23:14 INFO - 'tpaint', 15:23:14 INFO - 'sessionrestore', 15:23:14 INFO - 'sessionrestore_no_auto_restore', 15:23:14 INFO - 'tabpaint']}, 15:23:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['a11yr', 15:23:14 INFO - 'ts_paint', 15:23:14 INFO - 'tpaint', 15:23:14 INFO - 'sessionrestore', 15:23:14 INFO - 'sessionrestore_no_auto_restore', 15:23:14 INFO - 'tabpaint']}, 15:23:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['tsvgx', 15:23:14 INFO - 'tsvgr_opacity', 15:23:14 INFO - 'tart', 15:23:14 INFO - 'tscrollx', 15:23:14 INFO - 'cart', 15:23:14 INFO - 'tsvg_static']}, 15:23:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:23:14 INFO - 'tsvgr_opacity', 15:23:14 INFO - 'tart', 15:23:14 INFO - 'tscrollx', 15:23:14 INFO - 'cart', 15:23:14 INFO - 'tsvg_static']}, 15:23:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:23:14 INFO - 'talos_options': ['--disable-e10s'], 15:23:14 INFO - 'tests': ['tp5o']}, 15:23:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:23:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:23:14 INFO - 'talos_options': ['--disable-e10s', 15:23:14 INFO - '--xperf_path', 15:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:14 INFO - 'tests': ['tp5n']}, 15:23:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:23:14 INFO - 'talos_options': ['--xperf_path', 15:23:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:14 INFO - 'tests': ['tp5n']}}, 15:23:14 INFO - 'talos.zip': {'path': '', 15:23:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:23:14 INFO - Running post-action listener: _resource_record_post_action 15:23:14 INFO - [mozharness: 2017-03-10 23:23:14.965204Z] Finished populate-webroot step (success) 15:23:14 INFO - [mozharness: 2017-03-10 23:23:14.965298Z] Running create-virtualenv step. 15:23:14 INFO - Running pre-action listener: _resource_record_pre_action 15:23:14 INFO - Running main action method: create_virtualenv 15:23:14 INFO - Creating virtualenv /builds/slave/test/build/venv 15:23:14 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 15:23:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:23:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:23:15 INFO - Using real prefix '/usr' 15:23:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:23:15 INFO - Installing distribute.............................................................................................................................................................................................done. 15:23:17 INFO - Installing pip.................done. 15:23:17 INFO - Return code: 0 15:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:23:17 INFO - Reading from file tmpfile_stdout 15:23:17 INFO - Output received: 15:23:17 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) 15:23:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:23:17 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')]} 15:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:17 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')]} 15:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:17 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 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23:17 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 15:23:17 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 15:23:17 INFO - Using env: {'DISPLAY': ':0', 15:23:17 INFO - 'HOME': '/home/cltbld', 15:23:17 INFO - 'LANG': 'en_US.UTF-8', 15:23:17 INFO - 'LANGUAGE': 'en_US:en', 15:23:17 INFO - 'LOGNAME': 'cltbld', 15:23:17 INFO - 'MAIL': '/var/mail/cltbld', 15:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:17 INFO - 'MOZ_NO_REMOTE': '1', 15:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:17 INFO - 'NO_EM_RESTART': '1', 15:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:17 INFO - 'PWD': '/builds/slave/test', 15:23:17 INFO - 'SHELL': '/bin/bash', 15:23:17 INFO - 'SHLVL': '1', 15:23:17 INFO - 'TERM': 'linux', 15:23:17 INFO - 'TMOUT': '86400', 15:23:17 INFO - 'USER': 'cltbld', 15:23:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:17 INFO - '_': '/tools/buildbot/bin/python'} 15:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:17 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 15:23:17 INFO - Cleaning up... 15:23:17 INFO - Return code: 0 15:23:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:23:17 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')]} 15:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:17 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')]} 15:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:18 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 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23:18 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 15:23:18 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 15:23:18 INFO - Using env: {'DISPLAY': ':0', 15:23:18 INFO - 'HOME': '/home/cltbld', 15:23:18 INFO - 'LANG': 'en_US.UTF-8', 15:23:18 INFO - 'LANGUAGE': 'en_US:en', 15:23:18 INFO - 'LOGNAME': 'cltbld', 15:23:18 INFO - 'MAIL': '/var/mail/cltbld', 15:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:18 INFO - 'MOZ_NO_REMOTE': '1', 15:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:18 INFO - 'NO_EM_RESTART': '1', 15:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:18 INFO - 'PWD': '/builds/slave/test', 15:23:18 INFO - 'SHELL': '/bin/bash', 15:23:18 INFO - 'SHLVL': '1', 15:23:18 INFO - 'TERM': 'linux', 15:23:18 INFO - 'TMOUT': '86400', 15:23:18 INFO - 'USER': 'cltbld', 15:23:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:18 INFO - '_': '/tools/buildbot/bin/python'} 15:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:18 INFO - Downloading/unpacking psutil>=3.1.1 15:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:23:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:20 INFO - Installing collected packages: psutil 15:23:20 INFO - Running setup.py install for psutil 15:23:20 INFO - building 'psutil._psutil_linux' extension 15:23:20 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 15:23:20 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 15:23:20 INFO - building 'psutil._psutil_posix' extension 15:23:20 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 15:23:20 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 15:23:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:20 INFO - Successfully installed psutil 15:23:20 INFO - Cleaning up... 15:23:20 INFO - Return code: 0 15:23:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:23:20 INFO - Using env: {'DISPLAY': ':0', 15:23:20 INFO - 'HOME': '/home/cltbld', 15:23:20 INFO - 'LANG': 'en_US.UTF-8', 15:23:20 INFO - 'LANGUAGE': 'en_US:en', 15:23:20 INFO - 'LOGNAME': 'cltbld', 15:23:20 INFO - 'MAIL': '/var/mail/cltbld', 15:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:20 INFO - 'MOZ_NO_REMOTE': '1', 15:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:20 INFO - 'NO_EM_RESTART': '1', 15:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:20 INFO - 'PWD': '/builds/slave/test', 15:23:20 INFO - 'SHELL': '/bin/bash', 15:23:20 INFO - 'SHLVL': '1', 15:23:20 INFO - 'TERM': 'linux', 15:23:20 INFO - 'TMOUT': '86400', 15:23:20 INFO - 'USER': 'cltbld', 15:23:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:20 INFO - '_': '/tools/buildbot/bin/python'} 15:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:23:23 INFO - Installing collected packages: mozsystemmonitor 15:23:23 INFO - Running setup.py install for mozsystemmonitor 15:23:23 INFO - Successfully installed mozsystemmonitor 15:23:23 INFO - Cleaning up... 15:23:23 INFO - Return code: 0 15:23:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:23 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 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23:23 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 15:23:23 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 15:23:23 INFO - Using env: {'DISPLAY': ':0', 15:23:23 INFO - 'HOME': '/home/cltbld', 15:23:23 INFO - 'LANG': 'en_US.UTF-8', 15:23:23 INFO - 'LANGUAGE': 'en_US:en', 15:23:23 INFO - 'LOGNAME': 'cltbld', 15:23:23 INFO - 'MAIL': '/var/mail/cltbld', 15:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:23 INFO - 'MOZ_NO_REMOTE': '1', 15:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:23 INFO - 'NO_EM_RESTART': '1', 15:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:23 INFO - 'PWD': '/builds/slave/test', 15:23:23 INFO - 'SHELL': '/bin/bash', 15:23:23 INFO - 'SHLVL': '1', 15:23:23 INFO - 'TERM': 'linux', 15:23:23 INFO - 'TMOUT': '86400', 15:23:23 INFO - 'USER': 'cltbld', 15:23:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:23 INFO - '_': '/tools/buildbot/bin/python'} 15:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:23 INFO - Downloading/unpacking jsonschema==2.5.1 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:23:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:25 INFO - Downloading functools32-3.2.3-2.tar.gz 15:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:23:25 INFO - warning: no files found matching '*.txt' 15:23:25 INFO - no previously-included directories found matching 'build' 15:23:25 INFO - no previously-included directories found matching 'dist' 15:23:25 INFO - no previously-included directories found matching '.git*' 15:23:25 INFO - Installing collected packages: jsonschema, functools32 15:23:25 INFO - Running setup.py install for functools32 15:23:26 INFO - warning: no files found matching '*.txt' 15:23:26 INFO - no previously-included directories found matching 'build' 15:23:26 INFO - no previously-included directories found matching 'dist' 15:23:26 INFO - no previously-included directories found matching '.git*' 15:23:26 INFO - Successfully installed jsonschema functools32 15:23:26 INFO - Cleaning up... 15:23:26 INFO - Return code: 0 15:23:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:23: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')]} 15:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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')]} 15:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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', '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 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:23: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 functools32==3.2.3-2 15:23:26 INFO - Using env: {'DISPLAY': ':0', 15:23:26 INFO - 'HOME': '/home/cltbld', 15:23:26 INFO - 'LANG': 'en_US.UTF-8', 15:23:26 INFO - 'LANGUAGE': 'en_US:en', 15:23:26 INFO - 'LOGNAME': 'cltbld', 15:23:26 INFO - 'MAIL': '/var/mail/cltbld', 15:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:26 INFO - 'MOZ_NO_REMOTE': '1', 15:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:26 INFO - 'NO_EM_RESTART': '1', 15:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:26 INFO - 'PWD': '/builds/slave/test', 15:23:26 INFO - 'SHELL': '/bin/bash', 15:23:26 INFO - 'SHLVL': '1', 15:23:26 INFO - 'TERM': 'linux', 15:23:26 INFO - 'TMOUT': '86400', 15:23:26 INFO - 'USER': 'cltbld', 15:23:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:26 INFO - '_': '/tools/buildbot/bin/python'} 15:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:23:26 INFO - Cleaning up... 15:23:26 INFO - Return code: 0 15:23:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:23: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')]} 15:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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')]} 15:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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', '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 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:23: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 blobuploader==1.2.4 15:23:26 INFO - Using env: {'DISPLAY': ':0', 15:23:26 INFO - 'HOME': '/home/cltbld', 15:23:26 INFO - 'LANG': 'en_US.UTF-8', 15:23:26 INFO - 'LANGUAGE': 'en_US:en', 15:23:26 INFO - 'LOGNAME': 'cltbld', 15:23:26 INFO - 'MAIL': '/var/mail/cltbld', 15:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:26 INFO - 'MOZ_NO_REMOTE': '1', 15:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:26 INFO - 'NO_EM_RESTART': '1', 15:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:26 INFO - 'PWD': '/builds/slave/test', 15:23:26 INFO - 'SHELL': '/bin/bash', 15:23:26 INFO - 'SHLVL': '1', 15:23:26 INFO - 'TERM': 'linux', 15:23:26 INFO - 'TMOUT': '86400', 15:23:26 INFO - 'USER': 'cltbld', 15:23:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:26 INFO - '_': '/tools/buildbot/bin/python'} 15:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:23:26 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 15:23:26 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 15:23:26 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 15:23:26 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 15:23:26 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 15:23:26 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 15:23:28 INFO - Downloading blobuploader-1.2.4.tar.gz 15:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:23:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:23:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:29 INFO - Downloading docopt-0.6.1.tar.gz 15:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:23:29 INFO - Installing collected packages: blobuploader, requests, docopt 15:23:29 INFO - Running setup.py install for blobuploader 15:23:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:23:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:23:29 INFO - Running setup.py install for requests 15:23:29 INFO - Running setup.py install for docopt 15:23:29 INFO - Successfully installed blobuploader requests docopt 15:23:29 INFO - Cleaning up... 15:23:29 INFO - Return code: 0 15:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:29 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 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23:29 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 15:23:29 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 15:23:29 INFO - Using env: {'DISPLAY': ':0', 15:23:29 INFO - 'HOME': '/home/cltbld', 15:23:29 INFO - 'LANG': 'en_US.UTF-8', 15:23:29 INFO - 'LANGUAGE': 'en_US:en', 15:23:29 INFO - 'LOGNAME': 'cltbld', 15:23:29 INFO - 'MAIL': '/var/mail/cltbld', 15:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:29 INFO - 'MOZ_NO_REMOTE': '1', 15:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:29 INFO - 'NO_EM_RESTART': '1', 15:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:29 INFO - 'PWD': '/builds/slave/test', 15:23:29 INFO - 'SHELL': '/bin/bash', 15:23:29 INFO - 'SHLVL': '1', 15:23:29 INFO - 'TERM': 'linux', 15:23:29 INFO - 'TMOUT': '86400', 15:23:29 INFO - 'USER': 'cltbld', 15:23:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:29 INFO - '_': '/tools/buildbot/bin/python'} 15:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:30 INFO - Running setup.py (path:/tmp/pip-jmd20r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:30 INFO - Running setup.py (path:/tmp/pip-ZSpgjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:30 INFO - Running setup.py (path:/tmp/pip-kKueuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:30 INFO - Running setup.py (path:/tmp/pip-8jSWAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:30 INFO - Running setup.py (path:/tmp/pip-nhT63b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:30 INFO - Running setup.py (path:/tmp/pip-OdcLM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:30 INFO - Running setup.py (path:/tmp/pip-wGTf_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:30 INFO - Running setup.py (path:/tmp/pip-qNefLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:30 INFO - Running setup.py (path:/tmp/pip-aXWMBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:30 INFO - Running setup.py (path:/tmp/pip-MRDmuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:30 INFO - Running setup.py (path:/tmp/pip-n5vb7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:30 INFO - Running setup.py (path:/tmp/pip-P7IhJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:31 INFO - Running setup.py (path:/tmp/pip-VgSKsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:31 INFO - Running setup.py (path:/tmp/pip-AbOh6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:31 INFO - Running setup.py (path:/tmp/pip-smblqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:31 INFO - Running setup.py (path:/tmp/pip-ESf44G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:31 INFO - Running setup.py (path:/tmp/pip-VCrdfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:23:31 INFO - Running setup.py install for manifestparser 15:23:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:23:31 INFO - Running setup.py install for mozcrash 15:23:31 INFO - Running setup.py install for mozdebug 15:23:31 INFO - Running setup.py install for mozdevice 15:23:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:23:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:23:31 INFO - Running setup.py install for mozfile 15:23:31 INFO - Running setup.py install for mozhttpd 15:23:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Running setup.py install for mozinfo 15:23:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Running setup.py install for mozInstall 15:23:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Running setup.py install for mozleak 15:23:32 INFO - Running setup.py install for mozlog 15:23:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Running setup.py install for moznetwork 15:23:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Running setup.py install for mozprocess 15:23:32 INFO - Running setup.py install for mozprofile 15:23:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Running setup.py install for mozrunner 15:23:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:23:32 INFO - Running setup.py install for mozscreenshot 15:23:33 INFO - Running setup.py install for moztest 15:23:33 INFO - Running setup.py install for mozversion 15:23:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:23:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:23:33 INFO - Cleaning up... 15:23:33 INFO - Return code: 0 15:23:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:33 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 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23:33 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 15:23:33 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 15:23:33 INFO - Using env: {'DISPLAY': ':0', 15:23:33 INFO - 'HOME': '/home/cltbld', 15:23:33 INFO - 'LANG': 'en_US.UTF-8', 15:23:33 INFO - 'LANGUAGE': 'en_US:en', 15:23:33 INFO - 'LOGNAME': 'cltbld', 15:23:33 INFO - 'MAIL': '/var/mail/cltbld', 15:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:33 INFO - 'MOZ_NO_REMOTE': '1', 15:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:33 INFO - 'NO_EM_RESTART': '1', 15:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:33 INFO - 'PWD': '/builds/slave/test', 15:23:33 INFO - 'SHELL': '/bin/bash', 15:23:33 INFO - 'SHLVL': '1', 15:23:33 INFO - 'TERM': 'linux', 15:23:33 INFO - 'TMOUT': '86400', 15:23:33 INFO - 'USER': 'cltbld', 15:23:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:33 INFO - '_': '/tools/buildbot/bin/python'} 15:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:33 INFO - Running setup.py (path:/tmp/pip-YgN3KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:33 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)) 15:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:33 INFO - Running setup.py (path:/tmp/pip-pchpSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:33 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)) 15:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:33 INFO - Running setup.py (path:/tmp/pip-yLpjMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:33 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)) 15:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:33 INFO - Running setup.py (path:/tmp/pip-QPEkIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:33 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)) 15:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:33 INFO - Running setup.py (path:/tmp/pip-WGp59K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:33 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)) 15:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:33 INFO - Running setup.py (path:/tmp/pip-1ryatM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:33 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)) 15:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:33 INFO - Running setup.py (path:/tmp/pip-7vf3aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:33 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)) 15:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:33 INFO - Running setup.py (path:/tmp/pip-wcr2we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:34 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)) 15:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:34 INFO - Running setup.py (path:/tmp/pip-tkD4cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:34 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)) 15:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:34 INFO - Running setup.py (path:/tmp/pip-cL_plI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:34 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)) 15:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:34 INFO - Running setup.py (path:/tmp/pip-on3uhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:34 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)) 15:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:34 INFO - Running setup.py (path:/tmp/pip-ygnmk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:34 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)) 15:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:34 INFO - Running setup.py (path:/tmp/pip-XwOZZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:34 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)) 15:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:34 INFO - Running setup.py (path:/tmp/pip-JXaw1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:34 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)) 15:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:34 INFO - Running setup.py (path:/tmp/pip-dLwawL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:34 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)) 15:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:34 INFO - Running setup.py (path:/tmp/pip-o44ylH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:34 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)) 15:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:34 INFO - Running setup.py (path:/tmp/pip-MnGBlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:34 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)) 15:23:34 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)) 15:23:34 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)) 15:23:34 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)) 15:23:34 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)) 15:23:34 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)) 15:23:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:23:34 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 15:23:34 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 15:23:34 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 15:23:34 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 15:23:34 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 15:23:34 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 15:23:36 INFO - Downloading blessings-1.6.tar.gz 15:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:23:36 INFO - Installing collected packages: blessings 15:23:36 INFO - Running setup.py install for blessings 15:23:36 INFO - Successfully installed blessings 15:23:36 INFO - Cleaning up... 15:23:36 INFO - Return code: 0 15:23:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:23:37 INFO - Reading from file tmpfile_stdout 15:23:37 INFO - Current package versions: 15:23:37 INFO - argparse == 1.2.1 15:23:37 INFO - blessings == 1.6 15:23:37 INFO - blobuploader == 1.2.4 15:23:37 INFO - docopt == 0.6.1 15:23:37 INFO - functools32 == 3.2.3-2 15:23:37 INFO - jsonschema == 2.5.1 15:23:37 INFO - manifestparser == 1.1 15:23:37 INFO - mozInstall == 1.12 15:23:37 INFO - mozcrash == 1.0 15:23:37 INFO - mozdebug == 0.1 15:23:37 INFO - mozdevice == 0.49 15:23:37 INFO - mozfile == 1.2 15:23:37 INFO - mozhttpd == 0.7 15:23:37 INFO - mozinfo == 0.9 15:23:37 INFO - mozleak == 0.1 15:23:37 INFO - mozlog == 3.4 15:23:37 INFO - moznetwork == 0.27 15:23:37 INFO - mozprocess == 0.25 15:23:37 INFO - mozprofile == 0.28 15:23:37 INFO - mozrunner == 6.13 15:23:37 INFO - mozscreenshot == 0.1 15:23:37 INFO - mozsystemmonitor == 0.3 15:23:37 INFO - moztest == 0.8 15:23:37 INFO - mozversion == 1.4 15:23:37 INFO - psutil == 3.1.1 15:23:37 INFO - requests == 1.2.3 15:23:37 INFO - wsgiref == 0.1.2 15:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23: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')]} 15:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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')]} 15:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:37 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 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23:37 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 15:23:37 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 15:23:37 INFO - Using env: {'DISPLAY': ':0', 15:23:37 INFO - 'HOME': '/home/cltbld', 15:23:37 INFO - 'LANG': 'en_US.UTF-8', 15:23:37 INFO - 'LANGUAGE': 'en_US:en', 15:23:37 INFO - 'LOGNAME': 'cltbld', 15:23:37 INFO - 'MAIL': '/var/mail/cltbld', 15:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:37 INFO - 'MOZ_NO_REMOTE': '1', 15:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:37 INFO - 'NO_EM_RESTART': '1', 15:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:37 INFO - 'PWD': '/builds/slave/test', 15:23:37 INFO - 'SHELL': '/bin/bash', 15:23:37 INFO - 'SHLVL': '1', 15:23:37 INFO - 'TERM': 'linux', 15:23:37 INFO - 'TMOUT': '86400', 15:23:37 INFO - 'USER': 'cltbld', 15:23:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:37 INFO - '_': '/tools/buildbot/bin/python'} 15:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:37 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)) 15:23:37 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)) 15:23:37 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)) 15:23:37 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)) 15:23:37 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)) 15:23:37 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)) 15:23:37 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)) 15:23:37 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)) 15:23:37 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)) 15:23:37 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)) 15:23:37 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)) 15:23:37 INFO - Cleaning up... 15:23:37 INFO - Return code: 0 15:23:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:23: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')]} 15:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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')]} 15:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:37 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 0xccf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', '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 15:23:37 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 15:23:37 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 15:23:37 INFO - Using env: {'DISPLAY': ':0', 15:23:37 INFO - 'HOME': '/home/cltbld', 15:23:37 INFO - 'LANG': 'en_US.UTF-8', 15:23:37 INFO - 'LANGUAGE': 'en_US:en', 15:23:37 INFO - 'LOGNAME': 'cltbld', 15:23:37 INFO - 'MAIL': '/var/mail/cltbld', 15:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:37 INFO - 'MOZ_NO_REMOTE': '1', 15:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:37 INFO - 'NO_EM_RESTART': '1', 15:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:37 INFO - 'PWD': '/builds/slave/test', 15:23:37 INFO - 'SHELL': '/bin/bash', 15:23:37 INFO - 'SHLVL': '1', 15:23:37 INFO - 'TERM': 'linux', 15:23:37 INFO - 'TMOUT': '86400', 15:23:37 INFO - 'USER': 'cltbld', 15:23:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:37 INFO - '_': '/tools/buildbot/bin/python'} 15:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:23:37 INFO - Cleaning up... 15:23:37 INFO - Return code: 0 15:23:37 INFO - Running post-action listener: _resource_record_post_action 15:23:37 INFO - Running post-action listener: _start_resource_monitoring 15:23:37 INFO - Starting resource monitoring. 15:23:37 INFO - [mozharness: 2017-03-10 23:23:37.674505Z] Finished create-virtualenv step (success) 15:23:37 INFO - [mozharness: 2017-03-10 23:23:37.675010Z] Running install step. 15:23:37 INFO - Running pre-action listener: _resource_record_pre_action 15:23:37 INFO - Running main action method: install 15:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:23:37 INFO - Reading from file tmpfile_stdout 15:23:37 INFO - Detecting whether we're running mozinstall >=1.0... 15:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:23:37 INFO - Reading from file tmpfile_stdout 15:23:37 INFO - Output received: 15:23:37 INFO - Usage: mozinstall [options] installer 15:23:37 INFO - Options: 15:23:37 INFO - -h, --help show this help message and exit 15:23:37 INFO - -d DEST, --destination=DEST 15:23:37 INFO - Directory to install application into. [default: 15:23:37 INFO - "/builds/slave/test"] 15:23:37 INFO - --app=APP Application being installed. [default: firefox] 15:23:37 INFO - mkdir: /builds/slave/test/build/application 15:23:37 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'] 15:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:23:54 INFO - Reading from file tmpfile_stdout 15:23:54 INFO - Output received: 15:23:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:23:54 INFO - Running post-action listener: _resource_record_post_action 15:23:54 INFO - [mozharness: 2017-03-10 23:23:54.507139Z] Finished install step (success) 15:23:54 INFO - [mozharness: 2017-03-10 23:23:54.507409Z] Running run-tests step. 15:23:54 INFO - Running pre-action listener: _resource_record_pre_action 15:23:54 INFO - Running main action method: run_tests 15:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:23:54 INFO - Python 2.7.3 15:23:54 INFO - Return code: 0 15:23:54 INFO - grabbing minidump binary from tooltool 15:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:54 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 0xf6a290>, '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 0xf6ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6b040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:23:54 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 15:23:54 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 15:23:54 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 15:23:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:23:54 INFO - Return code: 0 15:23:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:23:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:23:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:23:54 INFO - ENV: RUST_BACKTRACE is now 1 15:23:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:23:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:23:54 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/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 15:23:54 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/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 15:23:54 INFO - Using env: {'DISPLAY': ':0', 15:23:54 INFO - 'HOME': '/home/cltbld', 15:23:54 INFO - 'LANG': 'en_US.UTF-8', 15:23:54 INFO - 'LANGUAGE': 'en_US:en', 15:23:54 INFO - 'LOGNAME': 'cltbld', 15:23:54 INFO - 'MAIL': '/var/mail/cltbld', 15:23:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:23:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:54 INFO - 'MOZ_NO_REMOTE': '1', 15:23:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:54 INFO - 'NO_EM_RESTART': '1', 15:23:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:54 INFO - 'PWD': '/builds/slave/test', 15:23:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:23:54 INFO - 'RUST_BACKTRACE': '1', 15:23:54 INFO - 'SHELL': '/bin/bash', 15:23:54 INFO - 'SHLVL': '1', 15:23:54 INFO - 'TERM': 'linux', 15:23:54 INFO - 'TMOUT': '86400', 15:23:54 INFO - 'USER': 'cltbld', 15:23:54 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725', 15:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:54 INFO - '_': '/tools/buildbot/bin/python'} 15:23:54 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/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 15:23:54 INFO - mozversion application_buildid: 20170310222807 15:23:54 INFO - mozversion application_changeset: 858b0ab812dfd88fa701a3e4f307f56bb1246e80 15:23:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:23:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:23:54 INFO - mozversion application_name: Firefox 15:23:54 INFO - mozversion application_remotingname: firefox-dev 15:23:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:23:54 INFO - mozversion application_vendor: Mozilla 15:23:54 INFO - mozversion application_version: 54.0a2 15:23:54 INFO - mozversion platform_buildid: 20170310222807 15:23:54 INFO - mozversion platform_changeset: 858b0ab812dfd88fa701a3e4f307f56bb1246e80 15:23:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:23:54 INFO - mozversion platform_version: 54.0a2 15:23:54 INFO - using testdate: 1489188234 15:23:54 INFO - actual date: 1489188234 15:23:54 INFO - starting webserver on 'localhost:37293' 15:23:54 INFO - SUITE-START | Running 2 tests 15:23:54 INFO - TEST-START | dromaeo_css 15:23:54 INFO - operating with platform_type : linux_ 15:23:54 INFO - Initialising browser for dromaeo_css test... 15:23:54 INFO - TEST-INFO | started process 30919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcFqy8H/profile http://localhost:37293/getInfo.html) 15:23:58 INFO - PROCESS | 30919 | __metrics Screen width/height:1600/1200 15:23:58 INFO - PROCESS | 30919 | colorDepth:24 15:23:58 INFO - PROCESS | 30919 | Browser inner width/height: 1024/697 15:23:58 INFO - PROCESS | 30919 | __metrics 15:23:59 INFO - PROCESS | 30919 | 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" 15:23:59 INFO - PROCESS | 30919 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:24:00 INFO - TEST-INFO | 30919: exit 0 15:24:00 INFO - Browser initialized. 15:24:00 INFO - Running cycle 1/1 for dromaeo_css test... 15:24:00 INFO - TEST-INFO | started process 31010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcFqy8H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:12 INFO - PROCESS | 31010 | RSS: Main: 139358208 15:24:12 INFO - PROCESS | 31010 | 15:27:13 INFO - PROCESS | 31010 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37293/tests/dromaeo/cssquery-ext.html) 15:27:15 INFO - PROCESS | 31010 | RSS: Main: 282406912 15:27:15 INFO - PROCESS | 31010 | 15:29:02 INFO - PROCESS | 31010 | ************************* 15:29:02 INFO - PROCESS | 31010 | A coding exception was thrown and uncaught in a Task. 15:29:02 INFO - PROCESS | 31010 | 15:29:02 ERROR - PROCESS | 31010 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:29:02 INFO - PROCESS | 31010 | Full stack: 15:29:02 INFO - PROCESS | 31010 | ************************* 15:30:17 INFO - PROCESS | 31010 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-ext.html (next: http://localhost:37293/tests/dromaeo/cssquery-jquery.html) 15:30:17 INFO - PROCESS | 31010 | RSS: Main: 220938240 15:30:17 INFO - PROCESS | 31010 | 15:33:19 INFO - PROCESS | 31010 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37293/tests/dromaeo/cssquery-mootools.html) 15:33:20 INFO - PROCESS | 31010 | RSS: Main: 195919872 15:33:20 INFO - PROCESS | 31010 | 15:36:22 INFO - PROCESS | 31010 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37293/tests/dromaeo/cssquery-prototype.html) 15:36:23 INFO - PROCESS | 31010 | RSS: Main: 169803776 15:36:23 INFO - PROCESS | 31010 | 15:39:25 INFO - PROCESS | 31010 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37293/tests/dromaeo/cssquery-yui.html) 15:39:26 INFO - PROCESS | 31010 | RSS: Main: 176996352 15:39:26 INFO - PROCESS | 31010 | 15:42:28 INFO - PROCESS | 31010 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-yui.html (next: http://localhost:37293/tests/dromaeo/cssquery-dojo.html) 15:42:29 INFO - PROCESS | 31010 | RSS: Main: 258420736 15:42:29 INFO - PROCESS | 31010 | 15:42:29 INFO - PROCESS | 31010 | __start_tp_report 15:42:29 INFO - PROCESS | 31010 | _x_x_mozilla_page_load 15:42:29 INFO - PROCESS | 31010 | _x_x_mozilla_page_load_details 15:42:29 INFO - PROCESS | 31010 | |i|pagename|runs| 15:42:29 INFO - PROCESS | 31010 | |0;dojo.html;3342.1477523231574;3390.3049874775656;3401.744869134814;3402.863885444582;3442.466417705255;5697.03150464421;5760.625559338645;5781.39295373986;5789.942100578993;5792.420757924211;5773.047447171211;5810.680412577307;5814.651120932747;5818.941810581893;5831.446012628793;5266.131088370415;5286.10136276832;5314.787408503656;5328.813491527797;5365.302510673607;5094.337736094302;5116.744162791864;5364.678119312854;5379.085555455563;5379.65032272901;5173.042987047408;5205.115130427817;5222.973885130569;5243.606729495303;5250.763715632786;5319.867003324909;5336.839894803124;5341.4658534146465;5349.973250133763;5350.946490535084;5264.973675131638;5275.419703832576;5306.814261500829;5310.787568497255;5316.787328506855;5458.5087342139;5486.423925487807;5641.153826925953;5736.225609542742;5737.770489180428;6161.4146656067605;6172.4136207060255;6180.072989051633;6182.072689096626;6183.134361189437;6225.875482490324;6226.59527130735;6238.376162383771;6244.094606282109;6246.437820596168;5528.86177845549;5548;5738.167965644958;5772.076467765138;5803.158542011427;6046.395360464006;6090.269167699816;6094.6647934363145;6099.146119543268;6124.6860923983895;6035.36628653985;6052.697365131814;6066.363031881677;6083.908741368883;6086.6652334122045;6134.141220229171;6135.723892424762;6138.478229350466;6139.109829074849;6139.324674285825;5890.734916928748;6114.052321890114;6115.327313995546;6118.265808103056;6120.08198770188;6000.8799824004145;6098.481629061579;6121.310528255591;6121.645920812088;6130.724117414727;4754.334393184888;4755.286706993978;4756.381670382828;4782.354382158364;4785.808567657325;4198.223328684203;4220.683448741357;4224.408582798411;4225.894352641147;4265;5742.7415766290615;5786.2477877876445;5839.270091238595;5888.440598143169;5988.9401105989255;6190.164327815777;6194.38056194377;6195.256569211633;6198.442140207403;6215.06773983906;5925.585209035412;5925.881482370329;5933.940660593339;5941;5964.552658550626;5015.724135172528;5057.519535644108;5180.844574662766;5182.274481572583;5208.713520756395;6246.531510136758;6312.274088479791;6348.079528468346;6396.584222025646;6407.135036769976;6220.066989951543;6222.160008398808;6226.688665566794;6227.96886015567;6234.096056071753;6042.8791424170395;6312;6353.110564520878;6379.425851673372;6391.456726178327;5912.497437717842;5992;6019.51843852482;6111.816645500642;6118.541109416722;6166.124770880347;6210.658413787285;6210.658413787285;6214.37856214393;6226.40849119333;5849.3858144894175;5873.618214816023;5965.075413310944;6016.639001659914;6051.697415129314;6099.512039036777;6109.969450152721;6112.541559383153;6114.144019837137;6125.050617154348;5996.8500787478915;6052.273727152769;6060.727267272895;6060.969695151496;6064.06007068905;6068.4841788448475;6103;6120.387961203844;6126.938730612636;6130.63216207029;5747.540196784331;5779.711014449176;5844.620099693507;5888.499477544286;5961.523078153824 15:42:29 INFO - PROCESS | 31010 | |1;ext.html;746.4886552711394;829.5893532701313;843.1442086282425;901.8016036471973;908.5048648486575;30478.23804404891;43415.565844341545;43633;43670.344944825854;43757;43486.13027739443;43587.564124358745;43661.12677746451;43706.7814660927;43723.56276437235;7580.05249343832;9116.225120864734;9254.768630784218;9255.953720231422;9262.583183756748;7654.808629784245;10609.257351985365;10764.192685548576;10772.56909723614;10773.62292319769;10805.595272614588;10841.67474975748;10863.239573229877;10863.891361086407;10870.130389568854;10810.189235807307;10813.621523246728;10840.13278937683;10846.783064338748;10872.456377181188;10506;10559.208059395576;10594.205434592359;10618.522166502526;10621.468926553642;40517.594824051674;40711;40733.388999165036;40760.79619601883;40877;4111.938320925188;4158.459400277945;4204.726692764961;4210.642095421893;4311.396404503341;29111.126666199834;29223.415531689247;29393;29602.555961660593;29609.259768505744;4247.532771395144;4258.930175908009;4327.653787696977;4340.869773906757;4387.3638322443385;194775;195326;195425;196352;196565;53104.46895530995;53164.46835531595;53196.73401633045;53201;53228;54123.45876541263;54126;54188.72905635525;54717.452825471235;54768;15841.920790395974;15857.841421585867;15948.20258987046;15990.96058756177;16004.599885002968;12704.110712250238;12992.415341309665;13927.025108242326;14132.222727750073;14143.151410915378;12799;13104;13397.062205645707;13399.330033498287;13465.124766890121;5524.613277070647;5542.224088627595;5575.358833734092;5622.690752008597;5682.261306030272;1025.6564051042835;1025.8563801067855;1030.1449796668746;1030.4796077980573;1031.6904928521415;27684.723152768616;28079.366904460945;28087.719122808918;28138.2965425866;28521.57217641737;1103.3435106111851;1107.3687997841153;1107.9723006924892;1113.3932007056173;1128.3342827731678;14872.182029988455;15184.316705748268;15197.544073677807;15197.936144470003;15229.847701523064;273454;274075;274195;275130;275336;54177.729111354194;54218.728906355216;54260.45739542633;54331.72834135804;54375.72812135914;1510.2297828107744;1549.8140223173066;1565.7494800831812;1566.4987204094807;1575.054967019779;25890.093846715274;27142.321441964108;27339.726602733717;27637;27709.445811084068;45525.772371139254;45613;45650.54349456596;45689;45833.541664582925;253245;253496;253763;253970;254198;28103.768066671775;34758;34834.65165348314;34850.30299394049;34868.82565587156;43279.13441731211;43551.78224108859;43593.78203108964;44876.10247795091;45336;36303.818480908485;36453.724119655686;36601.45097823588;36647.45028824623;36652.63347366492;36387.272254554235;36445.45331820078;36524.086897827765;36607.26785464329;36678.08304792402;38033.4294985581;38163.61836381712;38175.42736859005;38182.42726359162;38324.23351532898;30786.230344241572;33127.33745325128;33132.1716957078;33411.33177336391;33437;26225.475490490466;26494.205173844817;26558;26593.202203933914;26873.193804185907 15:42:29 INFO - PROCESS | 31010 | |2;jquery.html;455.31929765001325;459.3752496604617;469.99890233801995;472.4425178289618;476.2451514349755;19612.509687257825;21149.259775907845;21289.787102128976;21400.678989815166;21540.353789386303;20336;20768.584628307464;20878.06048727807;21267.14931402742;21959.34121976339;5083.517065878736;6763.357481039294;6933.757318493854;6994.650267486631;6994.825129371756;6864.279250678682;6907.861842763142;6912.032315475837;6955.339242771928;6965.825854353631;6975.860482790341;7373.29953654402;7653.272939070779;7701.8074548136465;7702.922970770304;7610.581418022034;7729.806754831175;7821.726239581587;7835;7886.093099293568;6961.338672826073;7615.238476152396;7621.275978782062;7632.503887247367;7635.236476352376;25268.241952741446;25417.110401135873;25424.618630720553;25655.230343089737;26004.08985685511;3045.9695403045907;3071.938561228785;3180.109569320594;3189.521571764254;3195.265089029513;15831.920840395724;16201.270942807601;16215.432459863967;16428.260728267258;16609.501714948572;2198.7141671582754;2221.911123555072;2235.228846048111;2322.941926451835;2347.507023525062;82365;87469;90647.54676226643;94399.52800235956;116103.41948290289;16450.6709865802;17949.551261218574;18203.726944095848;18662.81337186611;19022.23911043543;32289.35421291561;32324;32354.676453235166;32435.51346729801;32720.181995450304;10730.839037414446;10757.515911783988;10847.132229421628;10847.620333288298;11062.170337224741;9093.136152065543;9095.95452022749;9096.272298216127;9342.159205671522;9349.532523373804;9204.769880753034;9457.527123643791;9673.564689588844;9828.21374290055;9853.310268281151;3426.7087297579983;3518.859245630197;3583.1937813991644;3657.634236576321;3821.464994900716;959.7168835193635;964.3538828984597;972.4748635736764;976.3165783951263;986.9013098690074;19673.803261967198;20725.68911466329;20782.064807083716;20829.68755468669;20903.163873445195;959.4435227567993;973.5813600152003;980.1766516126488;993.1657407777357;995.1342332171057;11436.542538298374;11460.59887903936;11473.426328683532;11506.424678766029;11625.709357266136;524942;570789;584437;589074;607504;103285.48357258165;118079;118598;121023.36929892117;123186.30441086782;1215.2404747033104;1238.504598160743;1264.8608653047972;1267.524678245658;1276.719121793204;17634.29462821524;17757.644847103245;18232.635347292715;18261.54346141357;18600.813991859908;47499.28751068806;49097.75451122721;52769.20846187234;53068;53869.73065134806;67709.32290677227;67810;68373.31626683868;68829.3117068843;69522;12292;12443.315617641116;12482.500699971899;12591.748165036832;12603.369831508204;12525.749485010067;14355.425782968565;14578.85421145775;14629.634259143606;14882.851171488579;11994.76010479803;12015.879841201826;12105.939470302945;12124.75750485003;12464.127511074137;11606.419679015846;11641.301521908712;11711.88288117142;11809.350485723367;11953.282803031845;11627.825582616098;11952.880471195176;12146.271223726604;12238.204516706386;12292.139550231755;12384.504619815107;12702.87297127017;12787.040971927328;12791.488340466278;13206.867931320563;10780.946095269474;11026.669199924016;11059.612913547988;12285.877141228473;12346.197497162655 15:42:29 INFO - PROCESS | 31010 | |3;mootools.html;1544.8455154484545;1548.736714758491;1571.5835303644528;1597.1455271429784;1597.5446997605684;10861;11474.770504589904;11605.419729013536;11618.419079046045;11621.418929053556;11180.105591552676;11426.42867856608;11643.767124657523;11977;11980.520779168844;2487.216526794054;2514.8491090534535;2518.962215566768;2519.6346529753173;2522.5333313337;2422.588160012802;2444.5477586646525;2462.064415522108;2463.4949835283724;2468.2348471973655;2383.8808059597036;2399.9640005399933;2400.7479214682467;2409.7349291578;2410.650455683925;2277.430642339415;2279.2706333973133;2297.414159389345;2302.343832007878;2309.722833260011;2247.2808701215454;2277.7380601230907;2318.362450326174;2329.557384097016;2330.3358542815386;11636.592719254786;11644.825327620092;11686.24039437434;11732.35472049037;11780.410979450993;5803.912941305884;5945.524358051389;5947.702614869239;5947.791827286068;5948.702564871783;3364.0580637421563;3401.5748031496064;3454.5509083819193;3531.523244362004;3607.4228123500116;1338.7456383287242;1347.9393427295697;1366.1734650536482;1406.1352268354888;1407.7466056109897;15016.624584385369;15393.23033848303;15940.20298985046;16982.745258821127;17189.828101718947;4174.499060112806;4734.905301894012;4884.633652476078;4894.975525122351;4907.460179380265;12858.228506289652;13016.54442094541;13017.349132543335;13077.084604077623;13093.476260949456;5973.163757074013;5975.40245975399;5979.491743201789;5982.670953097621;5984.880302393928;5396.244525766396;5397.2443857859935;5400.216968539618;5459.563234941195;5464.098423760114;4126.979365103155;4130.884007195347;4190.16196760643;4227.387028880857;4233.661307095425;1080.6001779341693;1089.6839916424149;1094.8303013032992;1107.9335239885634;1109.4452773613193;897.4211633496358;900.5587262241454;916.5142474488532;938;1104.640991677708;7162.355388014999;7254.528455650366;7298.416126709851;7368.963155184189;7407.66665500043;1098.0674013735882;1144.370596172102;1145.6104924325768;1153.0487347937985;1168.824676298545;4440.977795111004;4456.398386217884;4461.464624245112;4518.277075667877;4571.2000399929875;14656.487022954145;15129.773053404208;15224.923875380773;15283.083015019134;15355.462558810612;12702.491900323883;15132.243387830784;15135.091894486366;15221.162836044125;15252.77120843166;9027.819443611223;10211.540480678388;10451.798043224975;10544.103751181083;10865.40240286776;7323.560586364835;7596.544207347577;7669.271419215165;7674.347680447001;7734.303912647889;13148.34258287101;13219.603411897659;13368.264745439094;13409.597712068653;13470.93264533671;13467.932660336635;13491.730165396833;13533.188008719508;13660.795088073488;13696.93151534236;9952.452615105949;9997.500124993867;10061.949690251502;10062.899371006197;10099.242556808416;10829.67510974672;10838.13294936419;10856.34861908288;10953.233273670767;11014;9647.228221742103;9716.514174291116;9804.215662746821;9867.901320986699;9955.900440995498;9376.95311523438;9436.197923176607;9520.0479952007;9529.285303602397;9562.474063926551;7910.248526389983;7972.641231144728;8093.514389136671;8100.675972961016;8106.270435660583;6093.451589356979;6113.877722445437;6118.449339559461;6205.968970155121;6384.170057892445;6086.452219300284;6112.235970503687;6137.35557766446;6137.7851775187655;6149.723262453111 15:42:29 INFO - PROCESS | 31010 | |4;prototype.html;423.7076417272084;430.48986950463694;437.1519252649859;448.6209153265489;450.0346756207934;5289.88912328411;5308.575313974882;5321.547668448186;5353.812616558421;5381.865453363668;5160.741962901859;5264.631475796696;5285.365756109272;5292.311999440077;5314.707691076989;4297.634701050414;4304.483461984566;4305.440292761937;4309.577839313035;4327.935080973788;4292.61366477017;4316.6402583186355;4323.081919704203;4338.284183109783;4373.562643735617;4198.9370159447635;4302.462192225972;4318.976716298588;4345.5654434556445;4351.65186785058;4276.657867370603;4289.592488713567;4289.656827453796;4310.5042920064125;4330.873972767072;3918.3338832398563;3925.2934471795065;3928.998105483112;3935.9212815743813;3952.170044290702;5091.974540127276;5148.922766158511;5190.845798993413;5195.376554813409;5213.765380557884;4737.692050016738;4903.289023091632;4910.288008238821;4910.779014944336;4923.975380123076;5534.584906132016;5541.33503979525;5555.805546805843;5557.861053473655;5597.356304025048;4331.722141968127;4375.8249670013165;4386.605205531518;4402.3836662867225;4402.911941761179;5528.364238112628;5532.585056120767;5621.550275977953;5759.65442073477;5801.419858014207;4736.455307639666;4761.309610106515;4765.285207218875;4773.451053128934;4776.498467660915;4729.810807567727;4749.976250118727;4791.209450440639;4798.160321943646;4822.685111146669;4808.783604737795;4820.68665536739;4855.669278746222;5073.122944510555;5086.516780905808;5409.188621706776;5459.2629994950175;5542.307211598551;5595.496405323541;5600.943990560124;1622.294301978643;1654.3713388912136;1672.3227093027344;1677.2452396421415;1688.3162319260719;1240.696029472767;1263.008538297432;1288.9677758055936;1291.4640424223842;1293.4050336845157;5380.977614253279;5398.946010539844;5403.972980135074;5407.351117865803;5434.64674796137;5578.716895114147;5667.801626943037;5671.2060311556415;5718.056520674042;5718.942810571841;5194.728356531149;5421.674699518042;5452.309783966983;5470.781168753285;5509.421510741395;2948.926276843053;2995.670476247611;2997.3855359651657;3001.42972835165;3009.3830764693184;5829.854253643693;5835.395266301801;5842.152887831241;5853.590248682552;5907.793227237026;5533.197686335539;5753.158989123441;5779.422057794187;5804.854878627983;5807.883842323215;5796.333951169265;5843.211166492554;5849.766009359578;5853.414658534112;5862.384449632727;5534.695591742493;5683.9715801420725;5696.8006119785605;5706.457886500776;5714.399988001366;5452.945470545244;5605.971970140124;5638.097904335286;5668.37647858727;5674.347450043298;5525.944740552543;5618.185363122243;5704.229928959538;5784.305883294031;5803.65178089316;4697.929531056969;4717.994852187738;4726.36194113804;4753.83361582343;4776.379070720784;5472.452754724496;5601.467860553241;5654.123610840326;5683.914741278802;5703.828885133453;5539.806106786243;5545.944540554543;5551.944480555304;5555.527780138734;5561.054620714569;5524.58565607573;5536.0865457200725;5557.527255277436;5564.415736347787;5593.853260081592;5318.973405133104;5454.836354909359;5506.944930550803;5525.171224316385;5553.084185955839;5519.613627046068;5542.861428464321;5600.27196464457;5600.691961942132;5605.80379686709;5421.102614085039;5436.53789427903;5454.263674403905;5480.287562616834;5499.395066542597 15:42:29 INFO - PROCESS | 31010 | |5;yui.html;843.472829481574;851.4295422067214;894.2896191098697;906.2930913887168;923.00776665085;15074.849251507481;15132.546023619281;15722.92138539307;16148.111853848033;16359.182040897967;14268.4292628295;14405.567832965027;15132;16272.349106035745;16476.588085297873;850.740524140137;865.4071960706921;881.5812489067706;883.4566741453991;885.3846576629245;877.2368039805378;886.1094599927064;887.1527691055027;889.6130183370223;889.7775556110972;930.1767935377206;930.9767255818625;939.8684184214216;940.0364626258106;942.3780304998702;917.8118485710447;918.6325469812061;919.9494027828467;927.9489628070453;928.9814203715922;677.1366507702719;677.7797215904851;679.178194384795;683.1733602341174;687.7386593094642;16076.678466430723;16369.099699516522;16463.423780167635;17131.57171070721;17380.73928891055;14475.203863787487;14800.863018271844;14807.555773326818;15110.697786044328;15464.149471779048;13389.598312050653;13569.660758481117;13574.117682350616;13843.446262149502;13920.93039534806;3948.526176858795;3964.6431821136234;3991.481107456041;4055.3916912463073;4057.1479989202303;88451.55774221088;88844.99999999936;89255;90870.545647272;91570.54214728884;11987.22083064598;12107;12111.697207569881;12204.633860984184;12255.69360765988;21698.674519882214;21875.562488750136;21919;22164.335069947603;22444.32667019992;8273.710420135267;8323.084460709317;8377.329813615019;8545.145485451405;8633.39566230358;4930.359053323117;4972.676776009548;5033.597312215014;5071.061853557104;5090.287359769635;3570.732195085379;3652.5799533054037;3655.7623754455876;3657.670809627093;3680.723945704083;584.8596336879118;604.3744724210421;604.6281536854891;607.4350853706096;652.6638781027774;657.2277573850706;678.9219239787487;679.3512195852949;694.8019814352886;697.2887654592288;11305.039071678999;11309.660710178709;11316.37759923212;11729.824052639216;11875.64373068792;803.9316658084011;819.2340161948597;820.6353948809951;822.4489591973393;824.2993455562723;5459.836204913859;5612.635178713371;5701.857453563694;5720.227769251098;5745.1669507921115;75189;80392.59803701061;81080;82724;82752;41987.37018944718;44776.77611611921;70020.64989675018;73675.63162184154;74867.25132748712;50496.49503504918;50823;50933.98132037339;52933.20600191;58089;10920.126389888948;11205.831912521156;11320.886791131983;11510.02164816;11556.133290003452;40000.799995999834;41069;41917.37123943205;42087.579124208365;42823.7858810704;39122.21755564816;44959.77520112378;54483.45516544942;55346.06288779873;55491;13224.801627975396;13318.200907945167;13604.727905442034;13761.830244428935;13766.31168441594;16173.67652646964;16346.673066538364;16696.749548756536;17033.23350449208;17708.291668333124;14526.85473145255;14573.489927852474;14869.405223790927;15283;15875.52373428799;14474.710505790035;14670.808197834822;14713.632159196106;14805.111693298437;15051.322690478735;15103.54689359321;15153;15380.92309538445;15411.460598878986;15815.762763558325;12282.324472154118;12538.686532836751;12810.231386116862;12844.550440734529;13158.21050736959;12376.07179461562;12460.501579936701;12581.739100211838;12733.363331833187;12825.743485130059 15:42:29 INFO - PROCESS | 31010 | __end_tp_report 15:42:29 INFO - PROCESS | 31010 | __start_cc_report 15:42:29 INFO - PROCESS | 31010 | _x_x_mozilla_cycle_collect,1469 15:42:29 INFO - PROCESS | 31010 | __end_cc_report 15:42:29 INFO - PROCESS | 31010 | __startTimestamp1489189349234__endTimestamp 15:42:29 INFO - PROCESS | 31010 | 15:42:29 INFO - PROCESS | 31010 | ------- Summary: start ------- 15:42:29 INFO - PROCESS | 31010 | Number of tests: 6 15:42:29 INFO - PROCESS | 31010 | 15:42:29 INFO - PROCESS | 31010 | [#0] dojo.html Cycles:165 Average:5722.39 Median:5964.55 stddev:635.04 (10.6%) stddev-sans-first:608.92 15:42:29 INFO - PROCESS | 31010 | Values: 3342.1 3390.3 3401.7 3402.9 3442.5 5697.0 5760.6 5781.4 5789.9 5792.4 5773.0 5810.7 5814.7 5818.9 5831.4 5266.1 5286.1 5314.8 5328.8 5365.3 5094.3 5116.7 5364.7 5379.1 5379.7 5173.0 5205.1 5223.0 5243.6 5250.8 5319.9 5336.8 5341.5 5350.0 5350.9 5265.0 5275.4 5306.8 5310.8 5316.8 5458.5 5486.4 5641.2 5736.2 5737.8 6161.4 6172.4 6180.1 6182.1 6183.1 6225.9 6226.6 6238.4 6244.1 6246.4 5528.9 5548.0 5738.2 5772.1 5803.2 6046.4 6090.3 6094.7 6099.1 6124.7 6035.4 6052.7 6066.4 6083.9 6086.7 6134.1 6135.7 6138.5 6139.1 6139.3 5890.7 6114.1 6115.3 6118.3 6120.1 6000.9 6098.5 6121.3 6121.6 6130.7 4754.3 4755.3 4756.4 4782.4 4785.8 4198.2 4220.7 4224.4 4225.9 4265.0 5742.7 5786.2 5839.3 5888.4 5988.9 6190.2 6194.4 6195.3 6198.4 6215.1 5925.6 5925.9 5933.9 5941.0 5964.6 5015.7 5057.5 5180.8 5182.3 5208.7 6246.5 6312.3 6348.1 6396.6 6407.1 6220.1 6222.2 6226.7 6228.0 6234.1 6042.9 6312.0 6353.1 6379.4 6391.5 5912.5 5992.0 6019.5 6111.8 6118.5 6166.1 6210.7 6210.7 6214.4 6226.4 5849.4 5873.6 5965.1 6016.6 6051.7 6099.5 6110.0 6112.5 6114.1 6125.1 5996.9 6052.3 6060.7 6061.0 6064.1 6068.5 6103.0 6120.4 6126.9 6130.6 5747.5 5779.7 5844.6 5888.5 5961.5 15:42:29 INFO - PROCESS | 31010 | 15:42:29 INFO - PROCESS | 31010 | [#1] ext.html Cycles:180 Average:42147.37 Median:30632.23 stddev:63189.89 (206.3%) stddev-sans-first:63290.69 15:42:29 INFO - PROCESS | 31010 | Values: 746.5 829.6 843.1 901.8 908.5 30478.2 43415.6 43633.0 43670.3 43757.0 43486.1 43587.6 43661.1 43706.8 43723.6 7580.1 9116.2 9254.8 9256.0 9262.6 7654.8 10609.3 10764.2 10772.6 10773.6 10805.6 10841.7 10863.2 10863.9 10870.1 10810.2 10813.6 10840.1 10846.8 10872.5 10506.0 10559.2 10594.2 10618.5 10621.5 40517.6 40711.0 40733.4 40760.8 40877.0 4111.9 4158.5 4204.7 4210.6 4311.4 29111.1 29223.4 29393.0 29602.6 29609.3 4247.5 4258.9 4327.7 4340.9 4387.4 194775.0 195326.0 195425.0 196352.0 196565.0 53104.5 53164.5 53196.7 53201.0 53228.0 54123.5 54126.0 54188.7 54717.5 54768.0 15841.9 15857.8 15948.2 15991.0 16004.6 12704.1 12992.4 13927.0 14132.2 14143.2 12799.0 13104.0 13397.1 13399.3 13465.1 5524.6 5542.2 5575.4 5622.7 5682.3 1025.7 1025.9 1030.1 1030.5 1031.7 27684.7 28079.4 28087.7 28138.3 28521.6 1103.3 1107.4 1108.0 1113.4 1128.3 14872.2 15184.3 15197.5 15197.9 15229.8 273454.0 274075.0 274195.0 275130.0 275336.0 54177.7 54218.7 54260.5 54331.7 54375.7 1510.2 1549.8 1565.7 1566.5 1575.1 25890.1 27142.3 27339.7 27637.0 27709.4 45525.8 45613.0 45650.5 45689.0 45833.5 253245.0 253496.0 253763.0 253970.0 254198.0 28103.8 34758.0 34834.7 34850.3 34868.8 43279.1 43551.8 43593.8 44876.1 45336.0 36303.8 36453.7 36601.5 36647.5 36652.6 36387.3 36445.5 36524.1 36607.3 36678.1 38033.4 38163.6 38175.4 38182.4 38324.2 30786.2 33127.3 33132.2 33411.3 33437.0 26225.5 26494.2 26558.0 26593.2 26873.2 15:42:29 INFO - PROCESS | 31010 | 15:42:29 INFO - PROCESS | 31010 | [#2] jquery.html Cycles:180 Average:34890.07 Median:13807.87 stddev:95095.27 (688.7%) stddev-sans-first:95326.89 15:42:29 INFO - PROCESS | 31010 | Values: 455.3 459.4 470.0 472.4 476.2 19612.5 21149.3 21289.8 21400.7 21540.4 20336.0 20768.6 20878.1 21267.1 21959.3 5083.5 6763.4 6933.8 6994.7 6994.8 6864.3 6907.9 6912.0 6955.3 6965.8 6975.9 7373.3 7653.3 7701.8 7702.9 7610.6 7729.8 7821.7 7835.0 7886.1 6961.3 7615.2 7621.3 7632.5 7635.2 25268.2 25417.1 25424.6 25655.2 26004.1 3046.0 3071.9 3180.1 3189.5 3195.3 15831.9 16201.3 16215.4 16428.3 16609.5 2198.7 2221.9 2235.2 2322.9 2347.5 82365.0 87469.0 90647.5 94399.5 116103.4 16450.7 17949.6 18203.7 18662.8 19022.2 32289.4 32324.0 32354.7 32435.5 32720.2 10730.8 10757.5 10847.1 10847.6 11062.2 9093.1 9096.0 9096.3 9342.2 9349.5 9204.8 9457.5 9673.6 9828.2 9853.3 3426.7 3518.9 3583.2 3657.6 3821.5 959.7 964.4 972.5 976.3 986.9 19673.8 20725.7 20782.1 20829.7 20903.2 959.4 973.6 980.2 993.2 995.1 11436.5 11460.6 11473.4 11506.4 11625.7 524942.0 570789.0 584437.0 589074.0 607504.0 103285.5 118079.0 118598.0 121023.4 123186.3 1215.2 1238.5 1264.9 1267.5 1276.7 17634.3 17757.6 18232.6 18261.5 18600.8 47499.3 49097.8 52769.2 53068.0 53869.7 67709.3 67810.0 68373.3 68829.3 69522.0 12292.0 12443.3 12482.5 12591.7 12603.4 12525.7 14355.4 14578.9 14629.6 14882.9 11994.8 12015.9 12105.9 12124.8 12464.1 11606.4 11641.3 11711.9 11809.4 11953.3 11627.8 11952.9 12146.3 12238.2 12292.1 12384.5 12702.9 12787.0 12791.5 13206.9 10780.9 11026.7 11059.6 12285.9 12346.2 15:42:29 INFO - PROCESS | 31010 | 15:42:29 INFO - PROCESS | 31010 | [#3] mootools.html Cycles:180 Average:7182.25 Median:2405.24 stddev:4587.68 (190.7%) stddev-sans-first:4580.99 15:42:29 INFO - PROCESS | 31010 | Values: 1544.8 1548.7 1571.6 1597.1 1597.5 10861.0 11474.8 11605.4 11618.4 11621.4 11180.1 11426.4 11643.8 11977.0 11980.5 2487.2 2514.8 2519.0 2519.6 2522.5 2422.6 2444.5 2462.1 2463.5 2468.2 2383.9 2400.0 2400.7 2409.7 2410.7 2277.4 2279.3 2297.4 2302.3 2309.7 2247.3 2277.7 2318.4 2329.6 2330.3 11636.6 11644.8 11686.2 11732.4 11780.4 5803.9 5945.5 5947.7 5947.8 5948.7 3364.1 3401.6 3454.6 3531.5 3607.4 1338.7 1347.9 1366.2 1406.1 1407.7 15016.6 15393.2 15940.2 16982.7 17189.8 4174.5 4734.9 4884.6 4895.0 4907.5 12858.2 13016.5 13017.3 13077.1 13093.5 5973.2 5975.4 5979.5 5982.7 5984.9 5396.2 5397.2 5400.2 5459.6 5464.1 4127.0 4130.9 4190.2 4227.4 4233.7 1080.6 1089.7 1094.8 1107.9 1109.4 897.4 900.6 916.5 938.0 1104.6 7162.4 7254.5 7298.4 7369.0 7407.7 1098.1 1144.4 1145.6 1153.0 1168.8 4441.0 4456.4 4461.5 4518.3 4571.2 14656.5 15129.8 15224.9 15283.1 15355.5 12702.5 15132.2 15135.1 15221.2 15252.8 9027.8 10211.5 10451.8 10544.1 10865.4 7323.6 7596.5 7669.3 7674.3 7734.3 13148.3 13219.6 13368.3 13409.6 13470.9 13467.9 13491.7 13533.2 13660.8 13696.9 9952.5 9997.5 10061.9 10062.9 10099.2 10829.7 10838.1 10856.3 10953.2 11014.0 9647.2 9716.5 9804.2 9867.9 9955.9 9377.0 9436.2 9520.0 9529.3 9562.5 7910.2 7972.6 8093.5 8100.7 8106.3 6093.5 6113.9 6118.4 6206.0 6384.2 6086.5 6112.2 6137.4 6137.8 6149.7 15:42:29 INFO - PROCESS | 31010 | 15:42:29 INFO - PROCESS | 31010 | [#4] prototype.html Cycles:180 Average:4794.56 Median:5367.40 stddev:1284.87 (23.9%) stddev-sans-first:1245.89 15:42:29 INFO - PROCESS | 31010 | Values: 423.7 430.5 437.2 448.6 450.0 5289.9 5308.6 5321.5 5353.8 5381.9 5160.7 5264.6 5285.4 5292.3 5314.7 4297.6 4304.5 4305.4 4309.6 4327.9 4292.6 4316.6 4323.1 4338.3 4373.6 4198.9 4302.5 4319.0 4345.6 4351.7 4276.7 4289.6 4289.7 4310.5 4330.9 3918.3 3925.3 3929.0 3935.9 3952.2 5092.0 5148.9 5190.8 5195.4 5213.8 4737.7 4903.3 4910.3 4910.8 4924.0 5534.6 5541.3 5555.8 5557.9 5597.4 4331.7 4375.8 4386.6 4402.4 4402.9 5528.4 5532.6 5621.6 5759.7 5801.4 4736.5 4761.3 4765.3 4773.5 4776.5 4729.8 4750.0 4791.2 4798.2 4822.7 4808.8 4820.7 4855.7 5073.1 5086.5 5409.2 5459.3 5542.3 5595.5 5600.9 1622.3 1654.4 1672.3 1677.2 1688.3 1240.7 1263.0 1289.0 1291.5 1293.4 5381.0 5398.9 5404.0 5407.4 5434.6 5578.7 5667.8 5671.2 5718.1 5718.9 5194.7 5421.7 5452.3 5470.8 5509.4 2948.9 2995.7 2997.4 3001.4 3009.4 5829.9 5835.4 5842.2 5853.6 5907.8 5533.2 5753.2 5779.4 5804.9 5807.9 5796.3 5843.2 5849.8 5853.4 5862.4 5534.7 5684.0 5696.8 5706.5 5714.4 5452.9 5606.0 5638.1 5668.4 5674.3 5525.9 5618.2 5704.2 5784.3 5803.7 4697.9 4718.0 4726.4 4753.8 4776.4 5472.5 5601.5 5654.1 5683.9 5703.8 5539.8 5545.9 5551.9 5555.5 5561.1 5524.6 5536.1 5557.5 5564.4 5593.9 5319.0 5454.8 5506.9 5525.2 5553.1 5519.6 5542.9 5600.3 5600.7 5605.8 5421.1 5436.5 5454.3 5480.3 5499.4 15:42:29 INFO - PROCESS | 31010 | 15:42:29 INFO - PROCESS | 31010 | [#5] yui.html Cycles:180 Average:17874.28 Median:4056.27 stddev:22245.29 (548.4%) stddev-sans-first:22270.93 15:42:29 INFO - PROCESS | 31010 | Values: 843.5 851.4 894.3 906.3 923.0 15074.8 15132.5 15722.9 16148.1 16359.2 14268.4 14405.6 15132.0 16272.3 16476.6 850.7 865.4 881.6 883.5 885.4 877.2 886.1 887.2 889.6 889.8 930.2 931.0 939.9 940.0 942.4 917.8 918.6 919.9 927.9 929.0 677.1 677.8 679.2 683.2 687.7 16076.7 16369.1 16463.4 17131.6 17380.7 14475.2 14800.9 14807.6 15110.7 15464.1 13389.6 13569.7 13574.1 13843.4 13920.9 3948.5 3964.6 3991.5 4055.4 4057.1 88451.6 88845.0 89255.0 90870.5 91570.5 11987.2 12107.0 12111.7 12204.6 12255.7 21698.7 21875.6 21919.0 22164.3 22444.3 8273.7 8323.1 8377.3 8545.1 8633.4 4930.4 4972.7 5033.6 5071.1 5090.3 3570.7 3652.6 3655.8 3657.7 3680.7 584.9 604.4 604.6 607.4 652.7 657.2 678.9 679.4 694.8 697.3 11305.0 11309.7 11316.4 11729.8 11875.6 803.9 819.2 820.6 822.4 824.3 5459.8 5612.6 5701.9 5720.2 5745.2 75189.0 80392.6 81080.0 82724.0 82752.0 41987.4 44776.8 70020.6 73675.6 74867.3 50496.5 50823.0 50934.0 52933.2 58089.0 10920.1 11205.8 11320.9 11510.0 11556.1 40000.8 41069.0 41917.4 42087.6 42823.8 39122.2 44959.8 54483.5 55346.1 55491.0 13224.8 13318.2 13604.7 13761.8 13766.3 16173.7 16346.7 16696.7 17033.2 17708.3 14526.9 14573.5 14869.4 15283.0 15875.5 14474.7 14670.8 14713.6 14805.1 15051.3 15103.5 15153.0 15380.9 15411.5 15815.8 12282.3 12538.7 12810.2 12844.6 13158.2 12376.1 12460.5 12581.7 12733.4 12825.7 15:42:29 INFO - PROCESS | 31010 | -------- Summary: end -------- 15:42:29 INFO - PROCESS | 31010 | 15:42:30 INFO - TEST-INFO | 31010: exit 0 15:42:30 INFO - TEST-OK | dromaeo_css | took 1115282ms 15:42:30 INFO - TEST-START | kraken 15:42:30 INFO - operating with platform_type : linux_ 15:42:30 INFO - Initialising browser for kraken test... 15:42:30 INFO - TEST-INFO | started process 31339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQDKKJf/profile http://localhost:37293/getInfo.html) 15:42:34 INFO - PROCESS | 31339 | __metrics Screen width/height:1600/1200 15:42:34 INFO - PROCESS | 31339 | colorDepth:24 15:42:34 INFO - PROCESS | 31339 | Browser inner width/height: 1024/697 15:42:34 INFO - PROCESS | 31339 | __metrics 15:42:34 INFO - PROCESS | 31339 | 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" 15:42:34 INFO - PROCESS | 31339 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:42:35 INFO - TEST-INFO | 31339: exit 0 15:42:35 INFO - Browser initialized. 15:42:35 INFO - Running cycle 1/1 for kraken test... 15:42:35 INFO - TEST-INFO | started process 31432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQDKKJf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:47 INFO - PROCESS | 31432 | RSS: Main: 139599872 15:42:47 INFO - PROCESS | 31432 | 15:42:50 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37293/tests/kraken/driver.html?testName=audio-beat-detection) 15:42:51 INFO - PROCESS | 31432 | RSS: Main: 183320576 15:42:51 INFO - PROCESS | 31432 | 15:42:53 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37293/tests/kraken/driver.html?testName=audio-dft) 15:42:54 INFO - PROCESS | 31432 | RSS: Main: 174125056 15:42:54 INFO - PROCESS | 31432 | 15:42:57 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37293/tests/kraken/driver.html?testName=audio-fft) 15:42:57 INFO - PROCESS | 31432 | RSS: Main: 265674752 15:42:57 INFO - PROCESS | 31432 | 15:42:59 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37293/tests/kraken/driver.html?testName=audio-oscillator) 15:43:00 INFO - PROCESS | 31432 | RSS: Main: 171720704 15:43:00 INFO - PROCESS | 31432 | 15:43:02 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:43:03 INFO - PROCESS | 31432 | RSS: Main: 174235648 15:43:03 INFO - PROCESS | 31432 | 15:43:06 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37293/tests/kraken/driver.html?testName=imaging-darkroom) 15:43:06 INFO - PROCESS | 31432 | RSS: Main: 212193280 15:43:06 INFO - PROCESS | 31432 | 15:43:10 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37293/tests/kraken/driver.html?testName=imaging-desaturate) 15:43:10 INFO - PROCESS | 31432 | RSS: Main: 212164608 15:43:10 INFO - PROCESS | 31432 | 15:43:13 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37293/tests/kraken/driver.html?testName=json-parse-financial) 15:43:14 INFO - PROCESS | 31432 | RSS: Main: 210542592 15:43:14 INFO - PROCESS | 31432 | 15:43:15 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:43:16 INFO - PROCESS | 31432 | RSS: Main: 172855296 15:43:16 INFO - PROCESS | 31432 | 15:43:17 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:43:18 INFO - PROCESS | 31432 | RSS: Main: 179826688 15:43:18 INFO - PROCESS | 31432 | 15:43:20 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:43:21 INFO - PROCESS | 31432 | RSS: Main: 189157376 15:43:21 INFO - PROCESS | 31432 | 15:43:23 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:43:24 INFO - PROCESS | 31432 | RSS: Main: 198856704 15:43:24 INFO - PROCESS | 31432 | 15:43:27 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:43:27 INFO - PROCESS | 31432 | RSS: Main: 194768896 15:43:27 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37293/tests/kraken/driver.html?testName=ai-astar) 15:43:29 INFO - PROCESS | 31432 | RSS: Main: 242905088 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | __start_tp_report 15:43:29 INFO - PROCESS | 31432 | _x_x_mozilla_page_load 15:43:29 INFO - PROCESS | 31432 | _x_x_mozilla_page_load_details 15:43:29 INFO - PROCESS | 31432 | |i|pagename|runs| 15:43:29 INFO - PROCESS | 31432 | |0;ai-astar;103;112;113;113;111;113;113;111;113;112 15:43:29 INFO - PROCESS | 31432 | |1;audio-beat-detection;144;116;120;155;117;115;114;115;140;116 15:43:29 INFO - PROCESS | 31432 | |2;audio-dft;160;161;159;161;163;160;162;161;160;159 15:43:29 INFO - PROCESS | 31432 | |3;audio-fft;74;75;76;109;77;76;76;76;104;77 15:43:29 INFO - PROCESS | 31432 | |4;audio-oscillator;81;81;112;81;82;81;106;82;82;122 15:43:29 INFO - PROCESS | 31432 | |5;imaging-gaussian-blur;113;114;113;114;113;112;113;113;112;114 15:43:29 INFO - PROCESS | 31432 | |6;imaging-darkroom;146;145;146;146;147;146;146;145;146;147 15:43:29 INFO - PROCESS | 31432 | |7;imaging-desaturate;93;94;93;93;94;94;94;94;94;94 15:43:29 INFO - PROCESS | 31432 | |8;json-parse-financial;56;55;57;55;55;57;55;55;56;54 15:43:29 INFO - PROCESS | 31432 | |9;json-stringify-tinderbox;52;53;53;53;53;53;54;53;53;53 15:43:29 INFO - PROCESS | 31432 | |10;stanford-crypto-aes;84;80;81;82;80;75;75;74;74;80 15:43:29 INFO - PROCESS | 31432 | |11;stanford-crypto-ccm;128;124;120;123;121;121;124;119;159;123 15:43:29 INFO - PROCESS | 31432 | |12;stanford-crypto-pbkdf2;164;162;163;160;162;160;167;156;161;159 15:43:29 INFO - PROCESS | 31432 | |13;stanford-crypto-sha256-iterative;59;63;59;59;60;60;60;60;58;58 15:43:29 INFO - PROCESS | 31432 | __end_tp_report 15:43:29 INFO - PROCESS | 31432 | __start_cc_report 15:43:29 INFO - PROCESS | 31432 | _x_x_mozilla_cycle_collect,1702 15:43:29 INFO - PROCESS | 31432 | __end_cc_report 15:43:29 INFO - PROCESS | 31432 | __startTimestamp1489189409585__endTimestamp 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | ------- Summary: start ------- 15:43:29 INFO - PROCESS | 31432 | Number of tests: 14 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.06 (2.7%) stddev-sans-first:0.87 15:43:29 INFO - PROCESS | 31432 | Values: 103.0 112.0 113.0 113.0 111.0 113.0 113.0 111.0 113.0 112.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:118.50 stddev:15.12 (12.8%) stddev-sans-first:14.43 15:43:29 INFO - PROCESS | 31432 | Values: 144.0 116.0 120.0 155.0 117.0 115.0 114.0 115.0 140.0 116.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 15:43:29 INFO - PROCESS | 31432 | Values: 160.0 161.0 159.0 161.0 163.0 160.0 162.0 161.0 160.0 159.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:13.00 (17.1%) stddev-sans-first:13.46 15:43:29 INFO - PROCESS | 31432 | Values: 74.0 75.0 76.0 109.0 77.0 76.0 76.0 76.0 104.0 77.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:81.00 stddev:15.88 (19.6%) stddev-sans-first:16.43 15:43:29 INFO - PROCESS | 31432 | Values: 81.0 81.0 112.0 81.0 82.0 81.0 106.0 82.0 82.0 122.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 15:43:29 INFO - PROCESS | 31432 | Values: 113.0 114.0 113.0 114.0 113.0 112.0 113.0 113.0 112.0 114.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:43:29 INFO - PROCESS | 31432 | Values: 146.0 145.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 147.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:43:29 INFO - PROCESS | 31432 | Values: 93.0 94.0 93.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:0.97 (1.8%) stddev-sans-first:1.01 15:43:29 INFO - PROCESS | 31432 | Values: 56.0 55.0 57.0 55.0 55.0 57.0 55.0 55.0 56.0 54.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.47 (0.9%) stddev-sans-first:0.33 15:43:29 INFO - PROCESS | 31432 | Values: 52.0 53.0 53.0 53.0 53.0 53.0 54.0 53.0 53.0 53.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:80.00 stddev:3.66 (4.6%) stddev-sans-first:3.30 15:43:29 INFO - PROCESS | 31432 | Values: 84.0 80.0 81.0 82.0 80.0 75.0 75.0 74.0 74.0 80.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:123.50 stddev:11.80 (9.6%) stddev-sans-first:12.50 15:43:29 INFO - PROCESS | 31432 | Values: 128.0 124.0 120.0 123.0 121.0 121.0 124.0 119.0 159.0 123.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:2.99 (1.8%) stddev-sans-first:3.02 15:43:29 INFO - PROCESS | 31432 | Values: 164.0 162.0 163.0 160.0 162.0 160.0 167.0 156.0 161.0 159.0 15:43:29 INFO - PROCESS | 31432 | 15:43:29 INFO - PROCESS | 31432 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:60.00 stddev:1.43 (2.4%) stddev-sans-first:1.50 15:43:29 INFO - PROCESS | 31432 | Values: 59.0 63.0 59.0 59.0 60.0 60.0 60.0 60.0 58.0 58.0 15:43:29 INFO - PROCESS | 31432 | -------- Summary: end -------- 15:43:29 INFO - PROCESS | 31432 | 15:43:30 INFO - TEST-INFO | 31432: exit 0 15:43:30 INFO - TEST-OK | kraken | took 60587ms 15:43:30 INFO - SUITE-END | took 1175s 15:43:30 INFO - Completed test suite (00:19:35) 15:43:30 INFO - javascript benchmark 15:43:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7805.130721611485, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3342.1477523231574, 3390.3049874775656, 3401.744869134814, 3402.863885444582, 3442.466417705255, 5697.03150464421, 5760.625559338645, 5781.39295373986, 5789.942100578993, 5792.420757924211, 5773.047447171211, 5810.680412577307, 5814.651120932747, 5818.941810581893, 5831.446012628793, 5266.131088370415, 5286.10136276832, 5314.787408503656, 5328.813491527797, 5365.302510673607, 5094.337736094302, 5116.744162791864, 5364.678119312854, 5379.085555455563, 5379.65032272901, 5173.042987047408, 5205.115130427817, 5222.973885130569, 5243.606729495303, 5250.763715632786, 5319.867003324909, 5336.839894803124, 5341.4658534146465, 5349.973250133763, 5350.946490535084, 5264.973675131638, 5275.419703832576, 5306.814261500829, 5310.787568497255, 5316.787328506855, 5458.5087342139, 5486.423925487807, 5641.153826925953, 5736.225609542742, 5737.770489180428, 6161.4146656067605, 6172.4136207060255, 6180.072989051633, 6182.072689096626, 6183.134361189437, 6225.875482490324, 6226.59527130735, 6238.376162383771, 6244.094606282109, 6246.437820596168, 5528.86177845549, 5548.0, 5738.167965644958, 5772.076467765138, 5803.158542011427, 6046.395360464006, 6090.269167699816, 6094.6647934363145, 6099.146119543268, 6124.6860923983895, 6035.36628653985, 6052.697365131814, 6066.363031881677, 6083.908741368883, 6086.6652334122045, 6134.141220229171, 6135.723892424762, 6138.478229350466, 6139.109829074849, 6139.324674285825, 5890.734916928748, 6114.052321890114, 6115.327313995546, 6118.265808103056, 6120.08198770188, 6000.8799824004145, 6098.481629061579, 6121.310528255591, 6121.645920812088, 6130.724117414727, 4754.334393184888, 4755.286706993978, 4756.381670382828, 4782.354382158364, 4785.808567657325, 4198.223328684203, 4220.683448741357, 4224.408582798411, 4225.894352641147, 4265.0, 5742.7415766290615, 5786.2477877876445, 5839.270091238595, 5888.440598143169, 5988.9401105989255, 6190.164327815777, 6194.38056194377, 6195.256569211633, 6198.442140207403, 6215.06773983906, 5925.585209035412, 5925.881482370329, 5933.940660593339, 5941.0, 5964.552658550626, 5015.724135172528, 5057.519535644108, 5180.844574662766, 5182.274481572583, 5208.713520756395, 6246.531510136758, 6312.274088479791, 6348.079528468346, 6396.584222025646, 6407.135036769976, 6220.066989951543, 6222.160008398808, 6226.688665566794, 6227.96886015567, 6234.096056071753, 6042.8791424170395, 6312.0, 6353.110564520878, 6379.425851673372, 6391.456726178327, 5912.497437717842, 5992.0, 6019.51843852482, 6111.816645500642, 6118.541109416722, 6166.124770880347, 6210.658413787285, 6210.658413787285, 6214.37856214393, 6226.40849119333, 5849.3858144894175, 5873.618214816023, 5965.075413310944, 6016.639001659914, 6051.697415129314, 6099.512039036777, 6109.969450152721, 6112.541559383153, 6114.144019837137, 6125.050617154348, 5996.8500787478915, 6052.273727152769, 6060.727267272895, 6060.969695151496, 6064.06007068905, 6068.4841788448475, 6103.0, 6120.387961203844, 6126.938730612636, 6130.63216207029, 5747.540196784331, 5779.711014449176, 5844.620099693507, 5888.499477544286, 5961.523078153824], "value": 5680.799658268792, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.4886552711394, 829.5893532701313, 843.1442086282425, 901.8016036471973, 908.5048648486575, 30478.23804404891, 43415.565844341545, 43633.0, 43670.344944825854, 43757.0, 43486.13027739443, 43587.564124358745, 43661.12677746451, 43706.7814660927, 43723.56276437235, 7580.05249343832, 9116.225120864734, 9254.768630784218, 9255.953720231422, 9262.583183756748, 7654.808629784245, 10609.257351985365, 10764.192685548576, 10772.56909723614, 10773.62292319769, 10805.595272614588, 10841.67474975748, 10863.239573229877, 10863.891361086407, 10870.130389568854, 10810.189235807307, 10813.621523246728, 10840.13278937683, 10846.783064338748, 10872.456377181188, 10506.0, 10559.208059395576, 10594.205434592359, 10618.522166502526, 10621.468926553642, 40517.594824051674, 40711.0, 40733.388999165036, 40760.79619601883, 40877.0, 4111.938320925188, 4158.459400277945, 4204.726692764961, 4210.642095421893, 4311.396404503341, 29111.126666199834, 29223.415531689247, 29393.0, 29602.555961660593, 29609.259768505744, 4247.532771395144, 4258.930175908009, 4327.653787696977, 4340.869773906757, 4387.3638322443385, 194775.0, 195326.0, 195425.0, 196352.0, 196565.0, 53104.46895530995, 53164.46835531595, 53196.73401633045, 53201.0, 53228.0, 54123.45876541263, 54126.0, 54188.72905635525, 54717.452825471235, 54768.0, 15841.920790395974, 15857.841421585867, 15948.20258987046, 15990.96058756177, 16004.599885002968, 12704.110712250238, 12992.415341309665, 13927.025108242326, 14132.222727750073, 14143.151410915378, 12799.0, 13104.0, 13397.062205645707, 13399.330033498287, 13465.124766890121, 5524.613277070647, 5542.224088627595, 5575.358833734092, 5622.690752008597, 5682.261306030272, 1025.6564051042835, 1025.8563801067855, 1030.1449796668746, 1030.4796077980573, 1031.6904928521415, 27684.723152768616, 28079.366904460945, 28087.719122808918, 28138.2965425866, 28521.57217641737, 1103.3435106111851, 1107.3687997841153, 1107.9723006924892, 1113.3932007056173, 1128.3342827731678, 14872.182029988455, 15184.316705748268, 15197.544073677807, 15197.936144470003, 15229.847701523064, 273454.0, 274075.0, 274195.0, 275130.0, 275336.0, 54177.729111354194, 54218.728906355216, 54260.45739542633, 54331.72834135804, 54375.72812135914, 1510.2297828107744, 1549.8140223173066, 1565.7494800831812, 1566.4987204094807, 1575.054967019779, 25890.093846715274, 27142.321441964108, 27339.726602733717, 27637.0, 27709.445811084068, 45525.772371139254, 45613.0, 45650.54349456596, 45689.0, 45833.541664582925, 253245.0, 253496.0, 253763.0, 253970.0, 254198.0, 28103.768066671775, 34758.0, 34834.65165348314, 34850.30299394049, 34868.82565587156, 43279.13441731211, 43551.78224108859, 43593.78203108964, 44876.10247795091, 45336.0, 36303.818480908485, 36453.724119655686, 36601.45097823588, 36647.45028824623, 36652.63347366492, 36387.272254554235, 36445.45331820078, 36524.086897827765, 36607.26785464329, 36678.08304792402, 38033.4294985581, 38163.61836381712, 38175.42736859005, 38182.42726359162, 38324.23351532898, 30786.230344241572, 33127.33745325128, 33132.1716957078, 33411.33177336391, 33437.0, 26225.475490490466, 26494.205173844817, 26558.0, 26593.202203933914, 26873.193804185907], "value": 18822.545649695214, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.31929765001325, 459.3752496604617, 469.99890233801995, 472.4425178289618, 476.2451514349755, 19612.509687257825, 21149.259775907845, 21289.787102128976, 21400.678989815166, 21540.353789386303, 20336.0, 20768.584628307464, 20878.06048727807, 21267.14931402742, 21959.34121976339, 5083.517065878736, 6763.357481039294, 6933.757318493854, 6994.650267486631, 6994.825129371756, 6864.279250678682, 6907.861842763142, 6912.032315475837, 6955.339242771928, 6965.825854353631, 6975.860482790341, 7373.29953654402, 7653.272939070779, 7701.8074548136465, 7702.922970770304, 7610.581418022034, 7729.806754831175, 7821.726239581587, 7835.0, 7886.093099293568, 6961.338672826073, 7615.238476152396, 7621.275978782062, 7632.503887247367, 7635.236476352376, 25268.241952741446, 25417.110401135873, 25424.618630720553, 25655.230343089737, 26004.08985685511, 3045.9695403045907, 3071.938561228785, 3180.109569320594, 3189.521571764254, 3195.265089029513, 15831.920840395724, 16201.270942807601, 16215.432459863967, 16428.260728267258, 16609.501714948572, 2198.7141671582754, 2221.911123555072, 2235.228846048111, 2322.941926451835, 2347.507023525062, 82365.0, 87469.0, 90647.54676226643, 94399.52800235956, 116103.41948290289, 16450.6709865802, 17949.551261218574, 18203.726944095848, 18662.81337186611, 19022.23911043543, 32289.35421291561, 32324.0, 32354.676453235166, 32435.51346729801, 32720.181995450304, 10730.839037414446, 10757.515911783988, 10847.132229421628, 10847.620333288298, 11062.170337224741, 9093.136152065543, 9095.95452022749, 9096.272298216127, 9342.159205671522, 9349.532523373804, 9204.769880753034, 9457.527123643791, 9673.564689588844, 9828.21374290055, 9853.310268281151, 3426.7087297579983, 3518.859245630197, 3583.1937813991644, 3657.634236576321, 3821.464994900716, 959.7168835193635, 964.3538828984597, 972.4748635736764, 976.3165783951263, 986.9013098690074, 19673.803261967198, 20725.68911466329, 20782.064807083716, 20829.68755468669, 20903.163873445195, 959.4435227567993, 973.5813600152003, 980.1766516126488, 993.1657407777357, 995.1342332171057, 11436.542538298374, 11460.59887903936, 11473.426328683532, 11506.424678766029, 11625.709357266136, 524942.0, 570789.0, 584437.0, 589074.0, 607504.0, 103285.48357258165, 118079.0, 118598.0, 121023.36929892117, 123186.30441086782, 1215.2404747033104, 1238.504598160743, 1264.8608653047972, 1267.524678245658, 1276.719121793204, 17634.29462821524, 17757.644847103245, 18232.635347292715, 18261.54346141357, 18600.813991859908, 47499.28751068806, 49097.75451122721, 52769.20846187234, 53068.0, 53869.73065134806, 67709.32290677227, 67810.0, 68373.31626683868, 68829.3117068843, 69522.0, 12292.0, 12443.315617641116, 12482.500699971899, 12591.748165036832, 12603.369831508204, 12525.749485010067, 14355.425782968565, 14578.85421145775, 14629.634259143606, 14882.851171488579, 11994.76010479803, 12015.879841201826, 12105.939470302945, 12124.75750485003, 12464.127511074137, 11606.419679015846, 11641.301521908712, 11711.88288117142, 11809.350485723367, 11953.282803031845, 11627.825582616098, 11952.880471195176, 12146.271223726604, 12238.204516706386, 12292.139550231755, 12384.504619815107, 12702.87297127017, 12787.040971927328, 12791.488340466278, 13206.867931320563, 10780.946095269474, 11026.669199924016, 11059.612913547988, 12285.877141228473, 12346.197497162655], "value": 11433.167811355703, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.8455154484545, 1548.736714758491, 1571.5835303644528, 1597.1455271429784, 1597.5446997605684, 10861.0, 11474.770504589904, 11605.419729013536, 11618.419079046045, 11621.418929053556, 11180.105591552676, 11426.42867856608, 11643.767124657523, 11977.0, 11980.520779168844, 2487.216526794054, 2514.8491090534535, 2518.962215566768, 2519.6346529753173, 2522.5333313337, 2422.588160012802, 2444.5477586646525, 2462.064415522108, 2463.4949835283724, 2468.2348471973655, 2383.8808059597036, 2399.9640005399933, 2400.7479214682467, 2409.7349291578, 2410.650455683925, 2277.430642339415, 2279.2706333973133, 2297.414159389345, 2302.343832007878, 2309.722833260011, 2247.2808701215454, 2277.7380601230907, 2318.362450326174, 2329.557384097016, 2330.3358542815386, 11636.592719254786, 11644.825327620092, 11686.24039437434, 11732.35472049037, 11780.410979450993, 5803.912941305884, 5945.524358051389, 5947.702614869239, 5947.791827286068, 5948.702564871783, 3364.0580637421563, 3401.5748031496064, 3454.5509083819193, 3531.523244362004, 3607.4228123500116, 1338.7456383287242, 1347.9393427295697, 1366.1734650536482, 1406.1352268354888, 1407.7466056109897, 15016.624584385369, 15393.23033848303, 15940.20298985046, 16982.745258821127, 17189.828101718947, 4174.499060112806, 4734.905301894012, 4884.633652476078, 4894.975525122351, 4907.460179380265, 12858.228506289652, 13016.54442094541, 13017.349132543335, 13077.084604077623, 13093.476260949456, 5973.163757074013, 5975.40245975399, 5979.491743201789, 5982.670953097621, 5984.880302393928, 5396.244525766396, 5397.2443857859935, 5400.216968539618, 5459.563234941195, 5464.098423760114, 4126.979365103155, 4130.884007195347, 4190.16196760643, 4227.387028880857, 4233.661307095425, 1080.6001779341693, 1089.6839916424149, 1094.8303013032992, 1107.9335239885634, 1109.4452773613193, 897.4211633496358, 900.5587262241454, 916.5142474488532, 938.0, 1104.640991677708, 7162.355388014999, 7254.528455650366, 7298.416126709851, 7368.963155184189, 7407.66665500043, 1098.0674013735882, 1144.370596172102, 1145.6104924325768, 1153.0487347937985, 1168.824676298545, 4440.977795111004, 4456.398386217884, 4461.464624245112, 4518.277075667877, 4571.2000399929875, 14656.487022954145, 15129.773053404208, 15224.923875380773, 15283.083015019134, 15355.462558810612, 12702.491900323883, 15132.243387830784, 15135.091894486366, 15221.162836044125, 15252.77120843166, 9027.819443611223, 10211.540480678388, 10451.798043224975, 10544.103751181083, 10865.40240286776, 7323.560586364835, 7596.544207347577, 7669.271419215165, 7674.347680447001, 7734.303912647889, 13148.34258287101, 13219.603411897659, 13368.264745439094, 13409.597712068653, 13470.93264533671, 13467.932660336635, 13491.730165396833, 13533.188008719508, 13660.795088073488, 13696.93151534236, 9952.452615105949, 9997.500124993867, 10061.949690251502, 10062.899371006197, 10099.242556808416, 10829.67510974672, 10838.13294936419, 10856.34861908288, 10953.233273670767, 11014.0, 9647.228221742103, 9716.514174291116, 9804.215662746821, 9867.901320986699, 9955.900440995498, 9376.95311523438, 9436.197923176607, 9520.0479952007, 9529.285303602397, 9562.474063926551, 7910.248526389983, 7972.641231144728, 8093.514389136671, 8100.675972961016, 8106.270435660583, 6093.451589356979, 6113.877722445437, 6118.449339559461, 6205.968970155121, 6384.170057892445, 6086.452219300284, 6112.235970503687, 6137.35557766446, 6137.7851775187655, 6149.723262453111], "value": 5424.40900513257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.7076417272084, 430.48986950463694, 437.1519252649859, 448.6209153265489, 450.0346756207934, 5289.88912328411, 5308.575313974882, 5321.547668448186, 5353.812616558421, 5381.865453363668, 5160.741962901859, 5264.631475796696, 5285.365756109272, 5292.311999440077, 5314.707691076989, 4297.634701050414, 4304.483461984566, 4305.440292761937, 4309.577839313035, 4327.935080973788, 4292.61366477017, 4316.6402583186355, 4323.081919704203, 4338.284183109783, 4373.562643735617, 4198.9370159447635, 4302.462192225972, 4318.976716298588, 4345.5654434556445, 4351.65186785058, 4276.657867370603, 4289.592488713567, 4289.656827453796, 4310.5042920064125, 4330.873972767072, 3918.3338832398563, 3925.2934471795065, 3928.998105483112, 3935.9212815743813, 3952.170044290702, 5091.974540127276, 5148.922766158511, 5190.845798993413, 5195.376554813409, 5213.765380557884, 4737.692050016738, 4903.289023091632, 4910.288008238821, 4910.779014944336, 4923.975380123076, 5534.584906132016, 5541.33503979525, 5555.805546805843, 5557.861053473655, 5597.356304025048, 4331.722141968127, 4375.8249670013165, 4386.605205531518, 4402.3836662867225, 4402.911941761179, 5528.364238112628, 5532.585056120767, 5621.550275977953, 5759.65442073477, 5801.419858014207, 4736.455307639666, 4761.309610106515, 4765.285207218875, 4773.451053128934, 4776.498467660915, 4729.810807567727, 4749.976250118727, 4791.209450440639, 4798.160321943646, 4822.685111146669, 4808.783604737795, 4820.68665536739, 4855.669278746222, 5073.122944510555, 5086.516780905808, 5409.188621706776, 5459.2629994950175, 5542.307211598551, 5595.496405323541, 5600.943990560124, 1622.294301978643, 1654.3713388912136, 1672.3227093027344, 1677.2452396421415, 1688.3162319260719, 1240.696029472767, 1263.008538297432, 1288.9677758055936, 1291.4640424223842, 1293.4050336845157, 5380.977614253279, 5398.946010539844, 5403.972980135074, 5407.351117865803, 5434.64674796137, 5578.716895114147, 5667.801626943037, 5671.2060311556415, 5718.056520674042, 5718.942810571841, 5194.728356531149, 5421.674699518042, 5452.309783966983, 5470.781168753285, 5509.421510741395, 2948.926276843053, 2995.670476247611, 2997.3855359651657, 3001.42972835165, 3009.3830764693184, 5829.854253643693, 5835.395266301801, 5842.152887831241, 5853.590248682552, 5907.793227237026, 5533.197686335539, 5753.158989123441, 5779.422057794187, 5804.854878627983, 5807.883842323215, 5796.333951169265, 5843.211166492554, 5849.766009359578, 5853.414658534112, 5862.384449632727, 5534.695591742493, 5683.9715801420725, 5696.8006119785605, 5706.457886500776, 5714.399988001366, 5452.945470545244, 5605.971970140124, 5638.097904335286, 5668.37647858727, 5674.347450043298, 5525.944740552543, 5618.185363122243, 5704.229928959538, 5784.305883294031, 5803.65178089316, 4697.929531056969, 4717.994852187738, 4726.36194113804, 4753.83361582343, 4776.379070720784, 5472.452754724496, 5601.467860553241, 5654.123610840326, 5683.914741278802, 5703.828885133453, 5539.806106786243, 5545.944540554543, 5551.944480555304, 5555.527780138734, 5561.054620714569, 5524.58565607573, 5536.0865457200725, 5557.527255277436, 5564.415736347787, 5593.853260081592, 5318.973405133104, 5454.836354909359, 5506.944930550803, 5525.171224316385, 5553.084185955839, 5519.613627046068, 5542.861428464321, 5600.27196464457, 5600.691961942132, 5605.80379686709, 5421.102614085039, 5436.53789427903, 5454.263674403905, 5480.287562616834, 5499.395066542597], "value": 4427.591836783776, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.472829481574, 851.4295422067214, 894.2896191098697, 906.2930913887168, 923.00776665085, 15074.849251507481, 15132.546023619281, 15722.92138539307, 16148.111853848033, 16359.182040897967, 14268.4292628295, 14405.567832965027, 15132.0, 16272.349106035745, 16476.588085297873, 850.740524140137, 865.4071960706921, 881.5812489067706, 883.4566741453991, 885.3846576629245, 877.2368039805378, 886.1094599927064, 887.1527691055027, 889.6130183370223, 889.7775556110972, 930.1767935377206, 930.9767255818625, 939.8684184214216, 940.0364626258106, 942.3780304998702, 917.8118485710447, 918.6325469812061, 919.9494027828467, 927.9489628070453, 928.9814203715922, 677.1366507702719, 677.7797215904851, 679.178194384795, 683.1733602341174, 687.7386593094642, 16076.678466430723, 16369.099699516522, 16463.423780167635, 17131.57171070721, 17380.73928891055, 14475.203863787487, 14800.863018271844, 14807.555773326818, 15110.697786044328, 15464.149471779048, 13389.598312050653, 13569.660758481117, 13574.117682350616, 13843.446262149502, 13920.93039534806, 3948.526176858795, 3964.6431821136234, 3991.481107456041, 4055.3916912463073, 4057.1479989202303, 88451.55774221088, 88844.99999999936, 89255.0, 90870.545647272, 91570.54214728884, 11987.22083064598, 12107.0, 12111.697207569881, 12204.633860984184, 12255.69360765988, 21698.674519882214, 21875.562488750136, 21919.0, 22164.335069947603, 22444.32667019992, 8273.710420135267, 8323.084460709317, 8377.329813615019, 8545.145485451405, 8633.39566230358, 4930.359053323117, 4972.676776009548, 5033.597312215014, 5071.061853557104, 5090.287359769635, 3570.732195085379, 3652.5799533054037, 3655.7623754455876, 3657.670809627093, 3680.723945704083, 584.8596336879118, 604.3744724210421, 604.6281536854891, 607.4350853706096, 652.6638781027774, 657.2277573850706, 678.9219239787487, 679.3512195852949, 694.8019814352886, 697.2887654592288, 11305.039071678999, 11309.660710178709, 11316.37759923212, 11729.824052639216, 11875.64373068792, 803.9316658084011, 819.2340161948597, 820.6353948809951, 822.4489591973393, 824.2993455562723, 5459.836204913859, 5612.635178713371, 5701.857453563694, 5720.227769251098, 5745.1669507921115, 75189.0, 80392.59803701061, 81080.0, 82724.0, 82752.0, 41987.37018944718, 44776.77611611921, 70020.64989675018, 73675.63162184154, 74867.25132748712, 50496.49503504918, 50823.0, 50933.98132037339, 52933.20600191, 58089.0, 10920.126389888948, 11205.831912521156, 11320.886791131983, 11510.02164816, 11556.133290003452, 40000.799995999834, 41069.0, 41917.37123943205, 42087.579124208365, 42823.7858810704, 39122.21755564816, 44959.77520112378, 54483.45516544942, 55346.06288779873, 55491.0, 13224.801627975396, 13318.200907945167, 13604.727905442034, 13761.830244428935, 13766.31168441594, 16173.67652646964, 16346.673066538364, 16696.749548756536, 17033.23350449208, 17708.291668333124, 14526.85473145255, 14573.489927852474, 14869.405223790927, 15283.0, 15875.52373428799, 14474.710505790035, 14670.808197834822, 14713.632159196106, 14805.111693298437, 15051.322690478735, 15103.54689359321, 15153.0, 15380.92309538445, 15411.460598878986, 15815.762763558325, 12282.324472154118, 12538.686532836751, 12810.231386116862, 12844.550440734529, 13158.21050736959, 12376.07179461562, 12460.501579936701, 12581.739100211838, 12733.363331833187, 12825.743485130059], "value": 7699.605399770218, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 113.0, 111.0, 113.0, 113.0, 111.0, 113.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 120.0, 155.0, 117.0, 115.0, 114.0, 115.0, 140.0, 116.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 161.0, 163.0, 160.0, 162.0, 161.0, 160.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 109.0, 77.0, 76.0, 76.0, 76.0, 104.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 112.0, 81.0, 82.0, 81.0, 106.0, 82.0, 82.0, 122.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 113.0, 112.0, 113.0, 113.0, 112.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 55.0, 55.0, 57.0, 55.0, 55.0, 56.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 81.0, 82.0, 80.0, 75.0, 75.0, 74.0, 74.0, 80.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 120.0, 123.0, 121.0, 121.0, 124.0, 119.0, 159.0, 123.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 160.0, 162.0, 160.0, 167.0, 156.0, 161.0, 159.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 58.0, 58.0], "value": 59.6, "unit": "score"}]}]} 15:43:30 INFO - Return code: 0 15:43:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:43:30 ERROR - # TBPL SUCCESS # 15:43:30 INFO - Running post-action listener: _resource_record_post_action 15:43:30 INFO - [mozharness: 2017-03-10 23:43:30.900630Z] Finished run-tests step (success) 15:43:30 INFO - Running post-run listener: _resource_record_post_run 15:43:30 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 266240; Write bytes: 365629440; Read time: 28; Write time: 277272 15:43:30 INFO - TinderboxPrint: CPU usage
13.1% 15:43:30 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 15:43:30 INFO - TinderboxPrint: I/O write bytes / time
365,629,440 / 277,272 15:43:30 INFO - TinderboxPrint: CPU idle
8,272.2 (86.9%) 15:43:30 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 15:43:30 INFO - TinderboxPrint: Swap in / out
0 / 0 15:43:30 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109953024; Read time: 0; Write time: 85964 15:43:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252870656; Read time: 28; Write time: 191116 15:43:31 INFO - Running post-run listener: _upload_blobber_files 15:43:31 INFO - Blob upload gear active. 15:43:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:43:31 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 15:43:31 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'] 15:43:31 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 15:43:31 INFO - (blobuploader) - INFO - Open directory for files ... 15:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:43:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:32 INFO - (blobuploader) - INFO - Done attempting. 15:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:34 INFO - (blobuploader) - INFO - Done attempting. 15:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:35 INFO - (blobuploader) - INFO - Done attempting. 15:43:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:43:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:43:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:43:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:38 INFO - (blobuploader) - INFO - Done attempting. 15:43:38 INFO - (blobuploader) - INFO - Iteration through files over. 15:43:38 INFO - Return code: 0 15:43:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:43:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:43:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bb583d806777ed5bc87fff8f95185fa310a0070ab4a1ee0018f1911411923320d15fbbec576485227330cc291aa1fb438f770b3905adb2b444aaafada2c8dd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae844751ba78c015c69b19cb540ff27a51e1dcc55c5ef78a9ab2c35a6a5070884f311bd00c0926218c61ea8d385633c2ec6ebc6c693b1e44049fd4f5242643ce", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65b457d144edde9a48ddd6f41ea1513a5eb4f024f30062349abcb95908e7486a37754e0aa0479f0c07e7ce521244f17ea301c409a5f4139053fb6015510eafb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2381529f9e566c28b383261237414fdaffb56dd3e69f5dd8d098508f9f1afab1fd9f0dbd72c51575c1cbd312f76b70fcb2f004bfa53c069fbdd12f9c80ff20fa"} 15:43:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:43:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:43:38 INFO - Contents: 15:43:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bb583d806777ed5bc87fff8f95185fa310a0070ab4a1ee0018f1911411923320d15fbbec576485227330cc291aa1fb438f770b3905adb2b444aaafada2c8dd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae844751ba78c015c69b19cb540ff27a51e1dcc55c5ef78a9ab2c35a6a5070884f311bd00c0926218c61ea8d385633c2ec6ebc6c693b1e44049fd4f5242643ce", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65b457d144edde9a48ddd6f41ea1513a5eb4f024f30062349abcb95908e7486a37754e0aa0479f0c07e7ce521244f17ea301c409a5f4139053fb6015510eafb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2381529f9e566c28b383261237414fdaffb56dd3e69f5dd8d098508f9f1afab1fd9f0dbd72c51575c1cbd312f76b70fcb2f004bfa53c069fbdd12f9c80ff20fa"} 15:43:38 INFO - Running post-run listener: copy_logs_to_upload_dir 15:43:38 INFO - Copying logs to upload dir... 15:43:38 INFO - mkdir: /builds/slave/test/build/upload/logs 15:43:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.032665 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-10 15:43:38.266995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 15:43:38.272627) ========= 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=c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725 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/2bb583d806777ed5bc87fff8f95185fa310a0070ab4a1ee0018f1911411923320d15fbbec576485227330cc291aa1fb438f770b3905adb2b444aaafada2c8dd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae844751ba78c015c69b19cb540ff27a51e1dcc55c5ef78a9ab2c35a6a5070884f311bd00c0926218c61ea8d385633c2ec6ebc6c693b1e44049fd4f5242643ce", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65b457d144edde9a48ddd6f41ea1513a5eb4f024f30062349abcb95908e7486a37754e0aa0479f0c07e7ce521244f17ea301c409a5f4139053fb6015510eafb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2381529f9e566c28b383261237414fdaffb56dd3e69f5dd8d098508f9f1afab1fd9f0dbd72c51575c1cbd312f76b70fcb2f004bfa53c069fbdd12f9c80ff20fa"} build_url:https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/P4LUcqdiSdmLFWaxlvVytw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bb583d806777ed5bc87fff8f95185fa310a0070ab4a1ee0018f1911411923320d15fbbec576485227330cc291aa1fb438f770b3905adb2b444aaafada2c8dd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae844751ba78c015c69b19cb540ff27a51e1dcc55c5ef78a9ab2c35a6a5070884f311bd00c0926218c61ea8d385633c2ec6ebc6c693b1e44049fd4f5242643ce", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65b457d144edde9a48ddd6f41ea1513a5eb4f024f30062349abcb95908e7486a37754e0aa0479f0c07e7ce521244f17ea301c409a5f4139053fb6015510eafb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2381529f9e566c28b383261237414fdaffb56dd3e69f5dd8d098508f9f1afab1fd9f0dbd72c51575c1cbd312f76b70fcb2f004bfa53c069fbdd12f9c80ff20fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 15:43:38.297750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:43:38.298079) ========= 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=c6927cf182745ad25b1d38b9000001fe-1489188165.21121-1848057725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 15:43:38.380172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 15:43:38.380582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 15:43:38.380878) ========= ========= Total master_lag: 0.16 =========