builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1494372405.67 results: success (0) revision: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:45.670145) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:45.670737) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:45.671015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:45.685799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:45.686090) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-09 16:26: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% 222M=0s 2017-05-09 16:26:45 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141269 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:45.841796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:45.842105) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019616 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:45.891604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:45.892039) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 --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=74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-09 16:26:46,037 truncating revision to first 12 chars 2017-05-09 16:26:46,037 Setting DEBUG logging. 2017-05-09 16:26:46,037 attempt 1/10 2017-05-09 16:26:46,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/120d8562d4a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 16:26:46,297 unpacking tar archive at: mozilla-central-120d8562d4a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:46.468794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:46.469135) ========= script_repo_revision: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:46.469509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:46.469773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 16:26:46.480335) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-09 16:26:46.480621) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:26:46 INFO - MultiFileLogger online at 20170509 16:26:46 in /builds/slave/test 16:26:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:26:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:26:46 INFO - {'append_to_log': False, 16:26:46 INFO - 'base_work_dir': '/builds/slave/test', 16:26:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:26:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:26:46 INFO - 'branch': 'Firefox-Non-PGO', 16:26:46 INFO - 'buildbot_json_path': 'buildprops.json', 16:26:46 INFO - 'config_files': ('talos/linux_config.py',), 16:26:46 INFO - 'default_actions': ('clobber', 16:26:46 INFO - 'read-buildbot-config', 16:26:46 INFO - 'download-and-extract', 16:26:46 INFO - 'populate-webroot', 16:26:46 INFO - 'create-virtualenv', 16:26:46 INFO - 'install', 16:26:46 INFO - 'run-tests'), 16:26:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:26:46 INFO - 'download_minidump_stackwalk': True, 16:26:46 INFO - 'download_symbols': 'ondemand', 16:26:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:26:46 INFO - 'tooltool.py': '/tools/tooltool.py', 16:26:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:26:46 INFO - '/tools/misc-python/virtualenv.py')}, 16:26:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:26:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:26:46 INFO - 'gecko_profile': False, 16:26:46 INFO - 'gecko_profile_interval': 0, 16:26:46 INFO - 'installer_path': 'installer.exe', 16:26:46 INFO - 'log_level': 'info', 16:26:46 INFO - 'log_name': 'talos', 16:26:46 INFO - 'log_to_console': True, 16:26:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:26:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:26:46 INFO - 'opt_config_files': (), 16:26:46 INFO - 'pip_index': False, 16:26:46 INFO - 'suite': 'dromaeojs', 16:26:46 INFO - 'system_bits': '32', 16:26:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:26:46 INFO - 'title': 'talos-linux64-ix-042', 16:26:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:26:46 INFO - 'use_talos_json': True, 16:26:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:26:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:26:46 INFO - 'work_dir': 'build'} 16:26:46 INFO - [mozharness: 2017-05-09 23:26:46.724815Z] Running clobber step. 16:26:46 INFO - Running pre-action listener: _resource_record_pre_action 16:26:46 INFO - Running main action method: clobber 16:26:46 INFO - rmtree: /builds/slave/test/build 16:26:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:26:47 INFO - Running post-action listener: _resource_record_post_action 16:26:47 INFO - [mozharness: 2017-05-09 23:26:47.656352Z] Finished clobber step (success) 16:26:47 INFO - [mozharness: 2017-05-09 23:26:47.656454Z] Running read-buildbot-config step. 16:26:47 INFO - Running pre-action listener: _resource_record_pre_action 16:26:47 INFO - Running main action method: read_buildbot_config 16:26:47 INFO - Using buildbot properties: 16:26:47 INFO - { 16:26:47 INFO - "project": "", 16:26:47 INFO - "product": "firefox", 16:26:47 INFO - "who": "kwierso@gmail.com", 16:26:47 INFO - "installer_path": "public/build/target.tar.bz2", 16:26:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:26:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:26:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:26:47 INFO - "stage_platform": "linux64", 16:26:47 INFO - "basedir": "/builds/slave/test", 16:26:47 INFO - "buildnumber": 1140, 16:26:47 INFO - "platform": "ubuntu64_hw", 16:26:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:26:47 INFO - "slavebuilddir": "test", 16:26:47 INFO - "taskId": "D-u1Y52oSzKHveWg_BPuEw", 16:26:47 INFO - "branch": "mozilla-central", 16:26:47 INFO - "script_repo_revision": "production", 16:26:47 INFO - "revision": "120d8562d4a53e4f78bd86c6f5076f6db265e5a3", 16:26:47 INFO - "slavename": "talos-linux64-ix-042", 16:26:47 INFO - "repo_path": "mozilla-central" 16:26:47 INFO - } 16:26:47 INFO - Finding installer, test and symbols from parent task. 16:26:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D-u1Y52oSzKHveWg_BPuEw'}, attempt #1 16:26:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D-u1Y52oSzKHveWg_BPuEw'}, attempt #1 16:26:48 INFO - Task dependencies: QpYdVLAaRvGC2Gvi6zA-yg 16:26:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg'}, attempt #1 16:26:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.tar.bz2 16:26:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/test_packages.json 16:26:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.crashreporter-symbols.zip 16:26:49 INFO - Running post-action listener: _resource_record_post_action 16:26:49 INFO - [mozharness: 2017-05-09 23:26:49.040959Z] Finished read-buildbot-config step (success) 16:26:49 INFO - [mozharness: 2017-05-09 23:26:49.041178Z] Running download-and-extract step. 16:26:49 INFO - Running pre-action listener: _resource_record_pre_action 16:26:49 INFO - Running main action method: download_and_extract 16:26:49 INFO - mkdir: /builds/slave/test/build/tests 16:26: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')]} 16:26:49 INFO - trying https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.test_packages.json 16:26:49 INFO - Downloading https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:26:49 INFO - Downloaded 986 bytes. 16:26:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:26:49 INFO - Using the following test package requirements: 16:26:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:26:49 INFO - u'common': [u'target.common.tests.zip'], 16:26:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:26:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:26:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:26:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:26:49 INFO - u'mozbase': [u'target.common.tests.zip'], 16:26:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:26:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:26:49 INFO - u'web-platform': [u'target.common.tests.zip', 16:26:49 INFO - u'target.web-platform.tests.zip'], 16:26:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:26:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:26:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.common.tests.zip 16:26:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:26:49 INFO - Fetch https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.common.tests.zip into memory 16:26:50 INFO - Content-Length response header: 58446255 16:26:50 INFO - Bytes received: 58446255 16:27:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:27:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.common.tests.zip 16:27:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:27:00 INFO - Fetch https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.common.tests.zip into memory 16:27:01 INFO - Content-Length response header: 58446255 16:27:01 INFO - Bytes received: 58446255 16:27:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.talos.tests.zip 16:27:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:27:12 INFO - Fetch https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.talos.tests.zip into memory 16:27:13 INFO - Content-Length response header: 14409362 16:27:13 INFO - Bytes received: 14409362 16:27: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')]} 16:27:13 INFO - trying https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.tar.bz2 16:27:13 INFO - Downloading https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:27:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:27:14 INFO - Downloaded 62977172 bytes. 16:27:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.tar.bz2 16:27:14 INFO - mkdir: /builds/slave/test/properties 16:27:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:27:14 INFO - Writing to file /builds/slave/test/properties/build_url 16:27:14 INFO - Contents: 16:27:14 INFO - build_url:https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.tar.bz2 16:27:14 INFO - Running post-action listener: _resource_record_post_action 16:27:14 INFO - Running post-action listener: set_extra_try_arguments 16:27:14 INFO - [mozharness: 2017-05-09 23:27:14.539844Z] Finished download-and-extract step (success) 16:27:14 INFO - [mozharness: 2017-05-09 23:27:14.539941Z] Running populate-webroot step. 16:27:14 INFO - Running pre-action listener: _resource_record_pre_action 16:27:14 INFO - Running main action method: populate_webroot 16:27:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:27:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:27:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:27:14 INFO - '--tppagecycles', 16:27:14 INFO - '7'], 16:27:14 INFO - 'tests': ['tsvgm']}}, 16:27:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:27:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:27:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:27:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:27:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:27:14 INFO - 'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:27:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:27:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:27:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:27:14 INFO - 'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['damp', 'tps']}, 16:27:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:27:14 INFO - 'tests': ['damp', 'tps']}, 16:27:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['dromaeo_dom']}, 16:27:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:27:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:27:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:27:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['a11yr', 16:27:14 INFO - 'ts_paint', 16:27:14 INFO - 'tpaint', 16:27:14 INFO - 'sessionrestore', 16:27:14 INFO - 'sessionrestore_no_auto_restore', 16:27:14 INFO - 'tabpaint']}, 16:27:14 INFO - 'other-e10s': {'tests': ['a11yr', 16:27:14 INFO - 'ts_paint', 16:27:14 INFO - 'tpaint', 16:27:14 INFO - 'sessionrestore', 16:27:14 INFO - 'sessionrestore_no_auto_restore', 16:27:14 INFO - 'tabpaint']}, 16:27:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:27:14 INFO - 'ts_paint', 16:27:14 INFO - 'tpaint', 16:27:14 INFO - 'sessionrestore', 16:27:14 INFO - 'sessionrestore_no_auto_restore', 16:27:14 INFO - 'tabpaint']}, 16:27:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:27:14 INFO - 'ts_paint', 16:27:14 INFO - 'tpaint', 16:27:14 INFO - 'sessionrestore', 16:27:14 INFO - 'sessionrestore_no_auto_restore', 16:27:14 INFO - 'tabpaint']}, 16:27:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['a11yr', 16:27:14 INFO - 'ts_paint', 16:27:14 INFO - 'tpaint', 16:27:14 INFO - 'sessionrestore', 16:27:14 INFO - 'sessionrestore_no_auto_restore', 16:27:14 INFO - 'tabpaint']}, 16:27:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['a11yr', 16:27:14 INFO - 'ts_paint', 16:27:14 INFO - 'tpaint', 16:27:14 INFO - 'sessionrestore', 16:27:14 INFO - 'sessionrestore_no_auto_restore', 16:27:14 INFO - 'tabpaint']}, 16:27:14 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:27:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:27:14 INFO - 'bloom_basic_ref']}, 16:27:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['tsvgx', 16:27:14 INFO - 'tsvgr_opacity', 16:27:14 INFO - 'tart', 16:27:14 INFO - 'tscrollx', 16:27:14 INFO - 'cart', 16:27:14 INFO - 'tsvg_static']}, 16:27:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:27:14 INFO - 'tsvgr_opacity', 16:27:14 INFO - 'tart', 16:27:14 INFO - 'tscrollx', 16:27:14 INFO - 'cart', 16:27:14 INFO - 'tsvg_static']}, 16:27:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:27:14 INFO - 'talos_options': ['--disable-e10s'], 16:27:14 INFO - 'tests': ['tp5o']}, 16:27:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:27:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:27:14 INFO - 'talos_options': ['--disable-e10s', 16:27:14 INFO - '--xperf_path', 16:27:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:27:14 INFO - 'tests': ['tp5n']}, 16:27:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:27:14 INFO - 'talos_options': ['--xperf_path', 16:27:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:27:14 INFO - 'tests': ['tp5n']}}, 16:27:14 INFO - 'talos.zip': {'path': '', 16:27:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:27:14 INFO - Running post-action listener: _resource_record_post_action 16:27:14 INFO - [mozharness: 2017-05-09 23:27:14.553593Z] Finished populate-webroot step (success) 16:27:14 INFO - [mozharness: 2017-05-09 23:27:14.553683Z] Running create-virtualenv step. 16:27:14 INFO - Running pre-action listener: _resource_record_pre_action 16:27:14 INFO - Running main action method: create_virtualenv 16:27:14 INFO - Creating virtualenv /builds/slave/test/build/venv 16:27: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 16:27:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:27:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:27:14 INFO - Using real prefix '/usr' 16:27:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:27:15 INFO - Installing distribute.............................................................................................................................................................................................done. 16:27:17 INFO - Installing pip.................done. 16:27:17 INFO - Return code: 0 16:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:27:17 INFO - Reading from file tmpfile_stdout 16:27:17 INFO - Output received: 16:27: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) 16:27:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:27: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')]} 16:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27: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')]} 16:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27: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 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27: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 16:27: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 16:27:17 INFO - Using env: {'DISPLAY': ':0', 16:27:17 INFO - 'HOME': '/home/cltbld', 16:27:17 INFO - 'LANG': 'en_US.UTF-8', 16:27:17 INFO - 'LANGUAGE': 'en_US:en', 16:27:17 INFO - 'LOGNAME': 'cltbld', 16:27:17 INFO - 'MAIL': '/var/mail/cltbld', 16:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:17 INFO - 'MOZ_NO_REMOTE': '1', 16:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:17 INFO - 'NO_EM_RESTART': '1', 16:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:17 INFO - 'PWD': '/builds/slave/test', 16:27:17 INFO - 'SHELL': '/bin/bash', 16:27:17 INFO - 'SHLVL': '1', 16:27:17 INFO - 'TERM': 'linux', 16:27:17 INFO - 'TMOUT': '86400', 16:27:17 INFO - 'USER': 'cltbld', 16:27:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:17 INFO - '_': '/tools/buildbot/bin/python'} 16:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27: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 16:27:17 INFO - Cleaning up... 16:27:17 INFO - Return code: 0 16:27:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:27: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')]} 16:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27: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')]} 16:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27: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', '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 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:27: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 psutil>=3.1.1 16:27:17 INFO - Using env: {'DISPLAY': ':0', 16:27:17 INFO - 'HOME': '/home/cltbld', 16:27:17 INFO - 'LANG': 'en_US.UTF-8', 16:27:17 INFO - 'LANGUAGE': 'en_US:en', 16:27:17 INFO - 'LOGNAME': 'cltbld', 16:27:17 INFO - 'MAIL': '/var/mail/cltbld', 16:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:17 INFO - 'MOZ_NO_REMOTE': '1', 16:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:17 INFO - 'NO_EM_RESTART': '1', 16:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:17 INFO - 'PWD': '/builds/slave/test', 16:27:17 INFO - 'SHELL': '/bin/bash', 16:27:17 INFO - 'SHLVL': '1', 16:27:17 INFO - 'TERM': 'linux', 16:27:17 INFO - 'TMOUT': '86400', 16:27:17 INFO - 'USER': 'cltbld', 16:27:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:17 INFO - '_': '/tools/buildbot/bin/python'} 16:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:17 INFO - Downloading/unpacking psutil>=3.1.1 16:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:27:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:27:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:27:18 INFO - Installing collected packages: psutil 16:27:18 INFO - Running setup.py install for psutil 16:27:19 INFO - building 'psutil._psutil_linux' extension 16:27:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:27:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:27:19 INFO - building 'psutil._psutil_posix' extension 16:27:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:27:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:27:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:27:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:27:19 INFO - Successfully installed psutil 16:27:19 INFO - Cleaning up... 16:27:19 INFO - Return code: 0 16:27:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:27:19 INFO - Using env: {'DISPLAY': ':0', 16:27:19 INFO - 'HOME': '/home/cltbld', 16:27:19 INFO - 'LANG': 'en_US.UTF-8', 16:27:19 INFO - 'LANGUAGE': 'en_US:en', 16:27:19 INFO - 'LOGNAME': 'cltbld', 16:27:19 INFO - 'MAIL': '/var/mail/cltbld', 16:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:19 INFO - 'MOZ_NO_REMOTE': '1', 16:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:19 INFO - 'NO_EM_RESTART': '1', 16:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:19 INFO - 'PWD': '/builds/slave/test', 16:27:19 INFO - 'SHELL': '/bin/bash', 16:27:19 INFO - 'SHLVL': '1', 16:27:19 INFO - 'TERM': 'linux', 16:27:19 INFO - 'TMOUT': '86400', 16:27:19 INFO - 'USER': 'cltbld', 16:27:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:19 INFO - '_': '/tools/buildbot/bin/python'} 16:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:27:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:27:20 INFO - Installing collected packages: mozsystemmonitor 16:27:20 INFO - Running setup.py install for mozsystemmonitor 16:27:20 INFO - Successfully installed mozsystemmonitor 16:27:20 INFO - Cleaning up... 16:27:21 INFO - Return code: 0 16:27:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:21 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 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:27:21 INFO - Using env: {'DISPLAY': ':0', 16:27:21 INFO - 'HOME': '/home/cltbld', 16:27:21 INFO - 'LANG': 'en_US.UTF-8', 16:27:21 INFO - 'LANGUAGE': 'en_US:en', 16:27:21 INFO - 'LOGNAME': 'cltbld', 16:27:21 INFO - 'MAIL': '/var/mail/cltbld', 16:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:21 INFO - 'MOZ_NO_REMOTE': '1', 16:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:21 INFO - 'NO_EM_RESTART': '1', 16:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:21 INFO - 'PWD': '/builds/slave/test', 16:27:21 INFO - 'SHELL': '/bin/bash', 16:27:21 INFO - 'SHLVL': '1', 16:27:21 INFO - 'TERM': 'linux', 16:27:21 INFO - 'TMOUT': '86400', 16:27:21 INFO - 'USER': 'cltbld', 16:27:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:21 INFO - '_': '/tools/buildbot/bin/python'} 16:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:21 INFO - Downloading/unpacking jsonschema==2.5.1 16:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:27:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:27:22 INFO - warning: no files found matching '*.txt' 16:27:22 INFO - no previously-included directories found matching 'build' 16:27:22 INFO - no previously-included directories found matching 'dist' 16:27:22 INFO - no previously-included directories found matching '.git*' 16:27:22 INFO - Installing collected packages: jsonschema, functools32 16:27:22 INFO - Running setup.py install for functools32 16:27:22 INFO - warning: no files found matching '*.txt' 16:27:22 INFO - no previously-included directories found matching 'build' 16:27:22 INFO - no previously-included directories found matching 'dist' 16:27:22 INFO - no previously-included directories found matching '.git*' 16:27:22 INFO - Successfully installed jsonschema functools32 16:27:22 INFO - Cleaning up... 16:27:22 INFO - Return code: 0 16:27:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:22 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 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:27:22 INFO - Using env: {'DISPLAY': ':0', 16:27:22 INFO - 'HOME': '/home/cltbld', 16:27:22 INFO - 'LANG': 'en_US.UTF-8', 16:27:22 INFO - 'LANGUAGE': 'en_US:en', 16:27:22 INFO - 'LOGNAME': 'cltbld', 16:27:22 INFO - 'MAIL': '/var/mail/cltbld', 16:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:22 INFO - 'MOZ_NO_REMOTE': '1', 16:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:22 INFO - 'NO_EM_RESTART': '1', 16:27:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:22 INFO - 'PWD': '/builds/slave/test', 16:27:22 INFO - 'SHELL': '/bin/bash', 16:27:22 INFO - 'SHLVL': '1', 16:27:22 INFO - 'TERM': 'linux', 16:27:22 INFO - 'TMOUT': '86400', 16:27:22 INFO - 'USER': 'cltbld', 16:27:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:22 INFO - '_': '/tools/buildbot/bin/python'} 16:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:27:22 INFO - Cleaning up... 16:27:22 INFO - Return code: 0 16:27:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:22 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 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:27:22 INFO - Using env: {'DISPLAY': ':0', 16:27:22 INFO - 'HOME': '/home/cltbld', 16:27:22 INFO - 'LANG': 'en_US.UTF-8', 16:27:22 INFO - 'LANGUAGE': 'en_US:en', 16:27:22 INFO - 'LOGNAME': 'cltbld', 16:27:22 INFO - 'MAIL': '/var/mail/cltbld', 16:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:22 INFO - 'MOZ_NO_REMOTE': '1', 16:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:22 INFO - 'NO_EM_RESTART': '1', 16:27:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:22 INFO - 'PWD': '/builds/slave/test', 16:27:22 INFO - 'SHELL': '/bin/bash', 16:27:22 INFO - 'SHLVL': '1', 16:27:22 INFO - 'TERM': 'linux', 16:27:22 INFO - 'TMOUT': '86400', 16:27:22 INFO - 'USER': 'cltbld', 16:27:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:22 INFO - '_': '/tools/buildbot/bin/python'} 16:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27: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 16:27:24 INFO - Downloading blobuploader-1.2.4.tar.gz 16:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:27:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:27:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:24 INFO - Downloading docopt-0.6.1.tar.gz 16:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:27:24 INFO - Installing collected packages: blobuploader, requests, docopt 16:27:24 INFO - Running setup.py install for blobuploader 16:27:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:27:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:27:25 INFO - Running setup.py install for requests 16:27:25 INFO - Running setup.py install for docopt 16:27:25 INFO - Successfully installed blobuploader requests docopt 16:27:25 INFO - Cleaning up... 16:27:25 INFO - Return code: 0 16:27:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:25 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 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:27:25 INFO - Using env: {'DISPLAY': ':0', 16:27:25 INFO - 'HOME': '/home/cltbld', 16:27:25 INFO - 'LANG': 'en_US.UTF-8', 16:27:25 INFO - 'LANGUAGE': 'en_US:en', 16:27:25 INFO - 'LOGNAME': 'cltbld', 16:27:25 INFO - 'MAIL': '/var/mail/cltbld', 16:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:25 INFO - 'MOZ_NO_REMOTE': '1', 16:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:25 INFO - 'NO_EM_RESTART': '1', 16:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:25 INFO - 'PWD': '/builds/slave/test', 16:27:25 INFO - 'SHELL': '/bin/bash', 16:27:25 INFO - 'SHLVL': '1', 16:27:25 INFO - 'TERM': 'linux', 16:27:25 INFO - 'TMOUT': '86400', 16:27:25 INFO - 'USER': 'cltbld', 16:27:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:25 INFO - '_': '/tools/buildbot/bin/python'} 16:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:27:25 INFO - Running setup.py (path:/tmp/pip-_gwKOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:27:25 INFO - Running setup.py (path:/tmp/pip-rciQnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:27:25 INFO - Running setup.py (path:/tmp/pip-A1JQeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:27:25 INFO - Running setup.py (path:/tmp/pip-iYWb_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:27:26 INFO - Running setup.py (path:/tmp/pip-RgxN9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:27:26 INFO - Running setup.py (path:/tmp/pip-pW2bUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:27:26 INFO - Running setup.py (path:/tmp/pip-TpeOOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:27:26 INFO - Running setup.py (path:/tmp/pip-a9gnUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:27:26 INFO - Running setup.py (path:/tmp/pip-1aWTmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:27:26 INFO - Running setup.py (path:/tmp/pip-679CGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:27:26 INFO - Running setup.py (path:/tmp/pip-hS3qSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:27:26 INFO - Running setup.py (path:/tmp/pip-Z5un9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:27:26 INFO - Running setup.py (path:/tmp/pip-WwbieB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:27:26 INFO - Running setup.py (path:/tmp/pip-A4F_om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:26 INFO - Running setup.py (path:/tmp/pip-ppzMLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:27:26 INFO - Running setup.py (path:/tmp/pip-QclE1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:27:26 INFO - Running setup.py (path:/tmp/pip-jhYW9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:27:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:27:26 INFO - Running setup.py install for manifestparser 16:27:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:27:27 INFO - Running setup.py install for mozcrash 16:27:27 INFO - Running setup.py install for mozdebug 16:27:27 INFO - Running setup.py install for mozdevice 16:27:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:27:27 INFO - Running setup.py install for mozfile 16:27:27 INFO - Running setup.py install for mozhttpd 16:27:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:27:27 INFO - Running setup.py install for mozinfo 16:27:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:27:27 INFO - Running setup.py install for mozInstall 16:27:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:27:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:27:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:27:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:27:27 INFO - Running setup.py install for mozleak 16:27:27 INFO - Running setup.py install for mozlog 16:27:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:27:27 INFO - Running setup.py install for moznetwork 16:27:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:27:28 INFO - Running setup.py install for mozprocess 16:27:28 INFO - Running setup.py install for mozprofile 16:27:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:27:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:27:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:27:28 INFO - Running setup.py install for mozrunner 16:27:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:27:28 INFO - Running setup.py install for mozscreenshot 16:27:28 INFO - Running setup.py install for moztest 16:27:28 INFO - Running setup.py install for mozversion 16:27:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:27:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:27:28 INFO - Cleaning up... 16:27:28 INFO - Return code: 0 16:27:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:28 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 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:27:28 INFO - Using env: {'DISPLAY': ':0', 16:27:28 INFO - 'HOME': '/home/cltbld', 16:27:28 INFO - 'LANG': 'en_US.UTF-8', 16:27:28 INFO - 'LANGUAGE': 'en_US:en', 16:27:28 INFO - 'LOGNAME': 'cltbld', 16:27:28 INFO - 'MAIL': '/var/mail/cltbld', 16:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:28 INFO - 'MOZ_NO_REMOTE': '1', 16:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:28 INFO - 'NO_EM_RESTART': '1', 16:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:28 INFO - 'PWD': '/builds/slave/test', 16:27:28 INFO - 'SHELL': '/bin/bash', 16:27:28 INFO - 'SHLVL': '1', 16:27:28 INFO - 'TERM': 'linux', 16:27:28 INFO - 'TMOUT': '86400', 16:27:28 INFO - 'USER': 'cltbld', 16:27:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:28 INFO - '_': '/tools/buildbot/bin/python'} 16:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:27:28 INFO - Running setup.py (path:/tmp/pip-HOoB5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:27:29 INFO - Running setup.py (path:/tmp/pip-KZTY1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:27:29 INFO - Running setup.py (path:/tmp/pip-BlUxWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:27:29 INFO - Running setup.py (path:/tmp/pip-uXRZtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:27:29 INFO - Running setup.py (path:/tmp/pip-VyF9TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:27:29 INFO - Running setup.py (path:/tmp/pip-xRMiU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:27:29 INFO - Running setup.py (path:/tmp/pip-0WoYlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:27:29 INFO - Running setup.py (path:/tmp/pip-kL2DKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:27:29 INFO - Running setup.py (path:/tmp/pip-w9Wjf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:27:29 INFO - Running setup.py (path:/tmp/pip-hl0Glu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:27:29 INFO - Running setup.py (path:/tmp/pip-1v6KOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:27:29 INFO - Running setup.py (path:/tmp/pip-xYzz_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:27:29 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)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:27:29 INFO - Running setup.py (path:/tmp/pip-JeDkta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:27:29 INFO - Running setup.py (path:/tmp/pip-EcET3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:30 INFO - Running setup.py (path:/tmp/pip-F0UWmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:27:30 INFO - Running setup.py (path:/tmp/pip-nx25xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:27:30 INFO - Running setup.py (path:/tmp/pip-ShJMFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:27:30 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:27:30 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:27:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:27:32 INFO - Downloading blessings-1.6.tar.gz 16:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:27:32 INFO - Installing collected packages: blessings 16:27:32 INFO - Running setup.py install for blessings 16:27:32 INFO - Successfully installed blessings 16:27:32 INFO - Cleaning up... 16:27:32 INFO - Return code: 0 16:27:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:27:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:27:32 INFO - Reading from file tmpfile_stdout 16:27:32 INFO - Current package versions: 16:27:32 INFO - argparse == 1.2.1 16:27:32 INFO - blessings == 1.6 16:27:32 INFO - blobuploader == 1.2.4 16:27:32 INFO - docopt == 0.6.1 16:27:32 INFO - functools32 == 3.2.3-2 16:27:32 INFO - jsonschema == 2.5.1 16:27:32 INFO - manifestparser == 1.1 16:27:32 INFO - mozInstall == 1.12 16:27:32 INFO - mozcrash == 1.0 16:27:32 INFO - mozdebug == 0.1 16:27:32 INFO - mozdevice == 0.50 16:27:32 INFO - mozfile == 1.2 16:27:32 INFO - mozhttpd == 0.7 16:27:32 INFO - mozinfo == 0.9 16:27:32 INFO - mozleak == 0.1 16:27:32 INFO - mozlog == 3.4 16:27:32 INFO - moznetwork == 0.27 16:27:32 INFO - mozprocess == 0.25 16:27:32 INFO - mozprofile == 0.28 16:27:32 INFO - mozrunner == 6.13 16:27:32 INFO - mozscreenshot == 0.1 16:27:32 INFO - mozsystemmonitor == 0.3 16:27:32 INFO - moztest == 0.8 16:27:32 INFO - mozversion == 1.4 16:27:32 INFO - psutil == 3.1.1 16:27:32 INFO - requests == 1.2.3 16:27:32 INFO - wsgiref == 0.1.2 16:27:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:32 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 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:27:32 INFO - Using env: {'DISPLAY': ':0', 16:27:32 INFO - 'HOME': '/home/cltbld', 16:27:32 INFO - 'LANG': 'en_US.UTF-8', 16:27:32 INFO - 'LANGUAGE': 'en_US:en', 16:27:32 INFO - 'LOGNAME': 'cltbld', 16:27:32 INFO - 'MAIL': '/var/mail/cltbld', 16:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:32 INFO - 'MOZ_NO_REMOTE': '1', 16:27:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:32 INFO - 'NO_EM_RESTART': '1', 16:27:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:32 INFO - 'PWD': '/builds/slave/test', 16:27:32 INFO - 'SHELL': '/bin/bash', 16:27:32 INFO - 'SHLVL': '1', 16:27:32 INFO - 'TERM': 'linux', 16:27:32 INFO - 'TMOUT': '86400', 16:27:32 INFO - 'USER': 'cltbld', 16:27:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:32 INFO - '_': '/tools/buildbot/bin/python'} 16:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:27:32 INFO - Cleaning up... 16:27:33 INFO - Return code: 0 16:27:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:27: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')]} 16:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27: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')]} 16:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:27:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1750a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:27:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:27:33 INFO - Using env: {'DISPLAY': ':0', 16:27:33 INFO - 'HOME': '/home/cltbld', 16:27:33 INFO - 'LANG': 'en_US.UTF-8', 16:27:33 INFO - 'LANGUAGE': 'en_US:en', 16:27:33 INFO - 'LOGNAME': 'cltbld', 16:27:33 INFO - 'MAIL': '/var/mail/cltbld', 16:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:33 INFO - 'MOZ_NO_REMOTE': '1', 16:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:33 INFO - 'NO_EM_RESTART': '1', 16:27:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:33 INFO - 'PWD': '/builds/slave/test', 16:27:33 INFO - 'SHELL': '/bin/bash', 16:27:33 INFO - 'SHLVL': '1', 16:27:33 INFO - 'TERM': 'linux', 16:27:33 INFO - 'TMOUT': '86400', 16:27:33 INFO - 'USER': 'cltbld', 16:27:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:33 INFO - '_': '/tools/buildbot/bin/python'} 16:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:27:33 INFO - Cleaning up... 16:27:33 INFO - Return code: 0 16:27:33 INFO - Running post-action listener: _resource_record_post_action 16:27:33 INFO - Running post-action listener: _start_resource_monitoring 16:27:33 INFO - Starting resource monitoring. 16:27:33 INFO - [mozharness: 2017-05-09 23:27:33.262075Z] Finished create-virtualenv step (success) 16:27:33 INFO - [mozharness: 2017-05-09 23:27:33.262537Z] Running install step. 16:27:33 INFO - Running pre-action listener: _resource_record_pre_action 16:27:33 INFO - Running main action method: install 16:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:27:33 INFO - Reading from file tmpfile_stdout 16:27:33 INFO - Detecting whether we're running mozinstall >=1.0... 16:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:27:33 INFO - Reading from file tmpfile_stdout 16:27:33 INFO - Output received: 16:27:33 INFO - Usage: mozinstall [options] installer 16:27:33 INFO - Options: 16:27:33 INFO - -h, --help show this help message and exit 16:27:33 INFO - -d DEST, --destination=DEST 16:27:33 INFO - Directory to install application into. [default: 16:27:33 INFO - "/builds/slave/test"] 16:27:33 INFO - --app=APP Application being installed. [default: firefox] 16:27:33 INFO - mkdir: /builds/slave/test/build/application 16:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:27:49 INFO - Reading from file tmpfile_stdout 16:27:49 INFO - Output received: 16:27:49 INFO - /builds/slave/test/build/application/firefox/firefox 16:27:49 INFO - Running post-action listener: _resource_record_post_action 16:27:49 INFO - [mozharness: 2017-05-09 23:27:49.385943Z] Finished install step (success) 16:27:49 INFO - [mozharness: 2017-05-09 23:27:49.386215Z] Running run-tests step. 16:27:49 INFO - Running pre-action listener: _resource_record_pre_action 16:27:49 INFO - Running main action method: run_tests 16:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:27:49 INFO - Python 2.7.3 16:27:49 INFO - Return code: 0 16:27:49 INFO - grabbing minidump binary from tooltool 16:27: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')]} 16:27:49 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 0x18f3a30>, '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 0x18f47f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f4ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:27:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:27:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:27:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:27:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:27:49 INFO - Return code: 0 16:27:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:27:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:27:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:27:49 INFO - ENV: RUST_BACKTRACE is now 1 16:27:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:27:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:27:49 INFO - Using env: {'DISPLAY': ':0', 16:27:49 INFO - 'HOME': '/home/cltbld', 16:27:49 INFO - 'LANG': 'en_US.UTF-8', 16:27:49 INFO - 'LANGUAGE': 'en_US:en', 16:27:49 INFO - 'LOGNAME': 'cltbld', 16:27:49 INFO - 'MAIL': '/var/mail/cltbld', 16:27:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:27:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:49 INFO - 'MOZ_NO_REMOTE': '1', 16:27:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:49 INFO - 'NO_EM_RESTART': '1', 16:27:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:49 INFO - 'PWD': '/builds/slave/test', 16:27:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:27:49 INFO - 'RUST_BACKTRACE': '1', 16:27:49 INFO - 'SHELL': '/bin/bash', 16:27:49 INFO - 'SHLVL': '1', 16:27:49 INFO - 'TERM': 'linux', 16:27:49 INFO - 'TMOUT': '86400', 16:27:49 INFO - 'USER': 'cltbld', 16:27:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755', 16:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:49 INFO - '_': '/tools/buildbot/bin/python'} 16:27:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:27:49 INFO - mozversion application_buildid: 20170509213607 16:27:49 INFO - mozversion application_changeset: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 16:27:49 INFO - mozversion application_display_name: Nightly 16:27:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:27:49 INFO - mozversion application_name: Firefox 16:27:49 INFO - mozversion application_remotingname: firefox 16:27:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:27:49 INFO - mozversion application_vendor: Mozilla 16:27:49 INFO - mozversion application_version: 55.0a1 16:27:49 INFO - mozversion platform_buildid: 20170509213607 16:27:49 INFO - mozversion platform_changeset: 120d8562d4a53e4f78bd86c6f5076f6db265e5a3 16:27:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:27:49 INFO - mozversion platform_version: 55.0a1 16:27:49 INFO - using testdate: 1494372469 16:27:49 INFO - actual date: 1494372469 16:27:49 INFO - starting webserver on 'localhost:36551' 16:27:49 INFO - SUITE-START | Running 2 tests 16:27:49 INFO - TEST-START | dromaeo_css 16:27:49 INFO - operating with platform_type : linux_ 16:27:49 INFO - Initialising browser for dromaeo_css test... 16:27:49 INFO - TEST-INFO | started process 20684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNq2QjR/profile http://localhost:36551/getInfo.html) 16:27:53 INFO - PID 20684 | __metrics Screen width/height:1600/1200 16:27:53 INFO - PID 20684 | colorDepth:24 16:27:53 INFO - PID 20684 | Browser inner width/height: 1024/695 16:27:53 INFO - PID 20684 | __metrics 16:27:54 INFO - PID 20684 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:27:54 INFO - PID 20684 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:27:55 INFO - TEST-INFO | 20684: exit 0 16:27:55 INFO - Browser initialized. 16:27:55 INFO - Running cycle 1/1 for dromaeo_css test... 16:27:55 INFO - TEST-INFO | started process 20782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNq2QjR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:28:07 INFO - PID 20782 | RSS: Main: 149704704 16:28:07 INFO - PID 20782 | 16:31:14 INFO - PID 20782 | Cycle 1(1): loaded http://localhost:36551/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36551/tests/dromaeo/cssquery-ext.html) 16:31:15 INFO - PID 20782 | RSS: Main: 277655552 16:31:15 INFO - PID 20782 | 16:34:17 INFO - PID 20782 | Cycle 1(1): loaded http://localhost:36551/tests/dromaeo/cssquery-ext.html (next: http://localhost:36551/tests/dromaeo/cssquery-jquery.html) 16:34:18 INFO - PID 20782 | RSS: Main: 225005568 16:34:18 INFO - PID 20782 | 16:37:20 INFO - PID 20782 | Cycle 1(1): loaded http://localhost:36551/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36551/tests/dromaeo/cssquery-mootools.html) 16:37:20 INFO - PID 20782 | RSS: Main: 176779264 16:37:20 INFO - PID 20782 | 16:40:23 INFO - PID 20782 | Cycle 1(1): loaded http://localhost:36551/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36551/tests/dromaeo/cssquery-prototype.html) 16:40:23 INFO - PID 20782 | RSS: Main: 208707584 16:40:23 INFO - PID 20782 | 16:43:26 INFO - PID 20782 | Cycle 1(1): loaded http://localhost:36551/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36551/tests/dromaeo/cssquery-yui.html) 16:43:27 INFO - PID 20782 | RSS: Main: 175906816 16:43:27 INFO - PID 20782 | 16:46:29 INFO - PID 20782 | Cycle 1(1): loaded http://localhost:36551/tests/dromaeo/cssquery-yui.html (next: http://localhost:36551/tests/dromaeo/cssquery-dojo.html) 16:46:29 INFO - PID 20782 | RSS: Main: 235458560 16:46:29 INFO - PID 20782 | 16:46:29 INFO - PID 20782 | __start_tp_report 16:46:29 INFO - PID 20782 | _x_x_mozilla_page_load 16:46:29 INFO - PID 20782 | _x_x_mozilla_page_load_details 16:46:29 INFO - PID 20782 | |i|pagename|runs| 16:46:29 INFO - PID 20782 | |0;dojo.html;2694.6766388033434;2720.8503532305717;2751.1471443852406;2754.063618369754;2756.434930839177;5064.696118232909;5209.661372010816;5299.761510732017;5313.57491400688;5357.517823395893;5126.615503837218;5176.7929282828645;5226.8693282667955;5267.710275934822;5317.175837745156;4415.580519850609;4614.400127983357;4682.157211701892;4744.383230180089;4784.473707892129;4732.171869922784;4738.47876733559;4758.547937945889;4768.094062128202;4804.303376010476;4572.314152877062;4643.698159619647;4661.790219440133;4667.766611669403;4700.694454860457;4674.579287864074;4675.719456832567;4698.201305777991;4750.429948406213;4766.594839438651;4635.7218566886095;4673.766311684436;4696.365990591295;4702.106599746037;4744.07490539345;5105.642605017651;5189.40321862983;5203.895922081575;5247.317848679647;5257;5483.972580137074;5492.533134683556;5616.410276920906;5617.410171931929;5622.156676498517;5688.658680479184;5708.286464191976;5710.942890571124;5723.227364305807;5724.16999535065;5174.663646862942;5284.497972692588;5291.973540132351;5294.735263236861;5337.066013447631;5669.574781891375;5703.058995265817;5752.511036561856;5825.592208545361;5828.12578113278;5516.310461192351;5539.778408863681;5545.223668686387;5600.075987462104;5632.9436705632415;5650.63270887391;5651.265335506358;5661.830145095653;5693.03218452864;5708.65748055118;5601.719914004283;5606.579506537026;5611.9438805612235;5615.2700148981185;5623.128415095667;5474.452554744574;5531.474509921551;5600.6919619420505;5617.43825617435;5618.775248989995;4667.346571479996;4680.3447517347595;4712.95287047132;4720.905581888343;4725.692829966041;4080.81636326366;4084.6732261419015;4094.754314741125;4097.303458412077;4134.813933373005;4732.455767586703;4835.44392394872;4838.806447742051;4839.927401088987;4847.854564363075;5636.2391077204875;5665.688387138747;5724.713764311768;5757.6833274169485;5777.971110144423;4795.232762757942;4799;4801.783919723621;4801.807927682854;4852.102361063215;4994.825181118644;4995.17579599362;5001.349824522788;5008.524190201925;5039.647224694236;5202;5223.92164117531;5257.0800109981365;5350;5359.330083739533;5562.249096371938;5569.19246709233;5573.581981351496;5577.358603760619;5685.34618518859;5155.845324640117;5165.586753059822;5171.45699701541;5202.03762303975;5211.47885211491;5466.3986961435;5475.72621368922;5527.143292789624;5546.417626149358;5552.111662134039;5618.410066943075;5657.886842263049;5678.68767217807;5690.118031705092;5701.914471282851;5395.487428694268;5441.809536666197;5509.834704958857;5512.118061110203;5518.172274158908;5447.782088716407;5480.068388374066;5528.170774383874;5549.1676248561425;5559.138333558305;5437.646552974044;5439.537639300704;5445.101558242845;5459.5632349412745;5471.425500322568;5586.994341018656;5598.3282006159525;5600.159976003632;5600.747966341606;5613.663180209201;5301.310829592283;5313.814016509404;5403;5414.242006119225;5417.593680474059 16:46:29 INFO - PID 20782 | |1;ext.html;617.3764497857165;661.5600625583987;677.9457643388528;1026.5791025679473;1027.7173777211267;25737.871310643444;30882;33205.50191747123;33314.33371332578;33328.50007249887;34373.14067148316;34649.92100473967;34672.65327346726;34724.131896702595;34724.65275347246;5400.243965844785;7020.964895175517;7171.533850299714;7176.712931482734;7176.748813791518;5408.675479471224;5500.862478438031;5502.119660854264;6969.059177011115;7117.644117794115;7179.425645948338;7195.676194571257;7202.783916482514;7227.241139680311;7275.236100209481;7140.964295178543;7197.676104575306;7200.49596528238;7207.423406127524;7214.350708436214;5339.252504649352;5467.289252397202;6758.357955994173;6880.518363714542;7131.643417829139;32780.508292375634;33089.834550827094;33117;33148.66851331504;33178.834105829555;3032.7118923702214;3079.7690173237097;3084;3084.4910589752662;3085.7377122944577;24803;24878.50242995148;24894.253172404857;24909.128180513777;24937;3130.4208721386617;3154.463741164008;3162.3991441626017;3162.9525557116663;3169.239382548195;145776.2711186448;146232.2688386562;146261;146303;146784;41794.37308440376;41864.790676046425;41883.58116418797;41899.7905010473;41996;44072.338914916305;44141;44187.77906110513;44232;44274.786260687484;12811.871881281255;12826.486940522462;12888.677783055498;12898.419571119135;12934.353282335846;10360.637377691895;10375.94812025935;10383.428911409794;10391.792164156675;10392.428416437016;10161.441120738431;10280.897191027994;13528.255945923069;13598.864011359958;13644.522441714493;5312.838860877771;5549.750261238254;5594.24477695514;5613;5647.774089036392;858.7638399440079;918.4626993209048;919.9402038867452;922.8707980882682;934.5981228071994;21888;22879;22916;23118.19086332004;23194.65208021881;941.6562954521551;941.8351788436996;958.9041095890494;972.6838777397375;979.128575567731;10918.344899305908;11331.150163737753;11471.082313414907;11496.42517874103;11601.651950441501;181225;181728;182203;182334;182838;40351;40635.390469142985;40646.59353406428;40666;40726.79636601798;1186.5009920006219;1225.5281716539196;1226.8957138643316;1228.4840367045863;1230.833837431953;19781.80218197857;19896.403107906786;20489.69265461049;21475.570488589827;21482.14071437125;29600.851995740744;29604.703952960193;29610.55584166196;29689.406211876074;29703.40593188081;163388;163810;163845;163873;164515;25401.87299063493;29445.705542944295;29979.850100749358;30080;30242.84878575681;30369.544456833606;30508.847455762578;30523.542146868258;30527.236819079702;30543.54184687187;23040.508655589234;26019;26334.341641459116;26828;27719.72280277252;26116.580996768083;26797.464050719267;26882.73117268802;27048.864755676095;27323.59014614822;29316.7068329314;29552.261193470335;29565.704342956295;29595.26011849635;29620.555691665075;24807.50384992326;25359.112431064823;25829;26188.607170892832;26688.866555667097;20349.287774927805;21091.6012277279;21119.04964276642;21170.25904093349;21201.575968480236 16:46:29 INFO - PID 20782 | |2;jquery.html;414.74907680853084;416.5189206466532;429.5253744612202;434.3332983869761;437.4357079367616;16675.749863752055;17192.742108868344;17480.825191748096;17495.47513574593;17773;17521.7371739424;17869.302416270468;18003.279868805264;18024.188911498983;18300.450986470394;5336.546393556552;5344.866378340553;5358.624896257264;5432.837014889559;5537.224788529609;5369.48989845964;5438.755256013469;5450.727463626803;5454.699991500466;5456;5301.098813201765;5386.218998245252;5429.077056900317;5432.402435732066;5441.564674826024;5341.412444631087;5416.133418652997;5426.565874730012;5428;5432.185172224158;4825.879353016167;4857.975710121426;4921.286413470027;4921.926171107436;4933.555979961785;20729.378118656463;20736.792632073637;20861.68707469389;20894.5821083579;20919.477013074644;1603.1984007996002;1630.315267587616;1640.1143382573396;1645.3747575921072;1648.620817212036;13709.588712338646;14023.737863592223;14083.295835208199;14217.289135543182;14341.49804756839;1997.6404247235491;2006.9397918062482;2061.752589689232;2073.5645514441985;2078.6778049402365;71920.6403967982;79276;99592;101830;102567.99999999926;10035.849462258071;10219.18246540275;10375.429351385746;10486.685399438029;10505.474726263808;13910.791338129937;13920.37358318878;13936.651583710489;13965.301734913417;14044.36800343987;6979.546329488669;7127.358537731629;7161.958841730186;7339.155997060299;7352.264773522605;6569.37590928861;6628.4697224221945;6774.051632771416;6805.285445028299;6814.591124532544;6594.340565943367;6670.566413183127;6686.899696504556;6703.061571380011;6735.124433823572;1932.9323473678635;1985.9702104468445;1995.610855883118;2029.5433527456205;2044.723962265105;861.9784505387415;882.9293656507464;885.4554449013939;887.0995939121797;916.6104405627715;16937.576560585836;17239;17477.475675729747;17708.203130859143;17844.375446859296;883.0595415882065;884.8893888263967;892.8928528576612;915.6017132547363;917.5274733512247;9140.451572905515;9649.951750241204;9659.46872921996;9699.224062075016;9728.404168888805;352393;354170;361643;363123;365609;77297;77355.61322193353;79975.60012199901;80970.5951470239;81820.18179818244;1075.1291453922347;1093.7703082352637;1097.2922465010024;1104.7956128116325;1107.363266121967;14409.13545187292;14792.186429746036;14852.405903763729;14990.47533336328;15499.767503487683;37738.622613773514;38740.41889371605;39844.601553985245;39968.2006359877;41388.37917431301;51103.233451497515;51194;51390.22914656358;51813.22280165725;54087.72956135194;8377.581120943807;8419.11599282091;8498.957505212682;8704.26013788835;8814.206721395105;11890.524379024742;11980.221285616408;12118.515259389525;12468.937655311665;12649.367531623566;9758.804823903623;9984.650537231162;10223.591056357662;10342.482875856327;10401.739956501147;10266.794664106825;10320.845187322046;10459.738506537093;10625.415602141957;10655.946720266349;11362.54549817998;11419.486123124314;11427.885721142682;11586.246893951866;11827.645170644895;8314.334853211849;8329.12544182852;8460.238578527962;8498.787530311793;8837.690680826398;10619.256652034592;10666.36001839892;10697.037266646039;10984.835227471754;11065.114790816877 16:46:29 INFO - PID 20782 | |3;mootools.html;1243.75124975005;1246.9625911222668;1275.8405199350086;1295.9416826242818;1307.3332600373806;9949.403035817855;10362.53368598413;10365.067143957041;10377.377357358555;10379.584816607327;10011.649592264272;10097.192224622031;10558.524866381013;10572.365658060522;10594.311369760979;2300.378897697625;2338.4738433852417;2342.531493701258;2343.589871772433;2344.9765502345012;2174.8803815790125;2299.471121642015;2304.158981971577;2309.157157637467;2317.1194945920524;1934.4486821255946;2012.8490363222743;2185.169635538501;2254.6392577187653;2254.77452254774;2285.3029825903095;2311.5839148953182;2313.5141620259765;2314.6296592545114;2315.2591170825344;2242.2936774915847;2269.920552780661;2302.4934514406805;2303.8502497337618;2305.688732021189;10238;10395.636152734618;10406.479676016168;10434.321769084985;10441.112505437048;5751;5953.374895635982;5954.374790646963;5956.761729530814;5975.342712301644;3339.215284408162;3410.360724254202;3450.240946991658;3464.2378676691087;3471.444568868994;1121.2879821313443;1169.1248770894788;1198.4187668980537;1215.6960759810047;1232.7472868062025;15359.232038398148;15507.147106909115;15508.224588770516;15522.223888805514;15531.223438828127;4776.617870570346;4822.42130944289;5065.569426598707;5072.721000344943;5092.9745351273;10893.128549716004;10900.672979810619;10913.454327283604;10928.726781830359;10947.945260273807;5787.421257874179;5792.333881603585;5793.449622285876;5800.767969281182;5806.535477161901;5164.690118592821;5179.352580927384;5329.7068661224;5358.5981051421295;5406.91889621656;3910.980445097813;3911.7261791674878;3984.641382275609;4026.778527181033;4090.6727461802984;1110;1119.7144728094447;1127.881572434899;1133.0652211925194;1138.8064029115071;619.3668584226454;628.5694299404922;721.9639018049181;732.7325526182905;738.0442327186306;6692.263850976388;6714.899276510856;6752.3922846944015;6797.762078327235;6939.548929319679;802.7993001749562;846.7459762071354;864.8486514859875;868.6525389843987;873.4322690251388;3644.0525463379713;3680.607605056681;4001.2597669431248;4179.059711564873;4272.188284225987;13202.273874936971;13926.373313200931;13936.442542298397;13945.093568917988;13953.302334883216;13175.60473185806;13608.93195534016;13811.723765524634;13815.102018368774;13821.170729756246;7530.736424225126;7792.41556883236;7817.57003364809;8011.7195898144455;8014.599270036475;6313.842153946188;6412.9679351602945;6479.5788273762055;6528.477721782341;6558.8360290993105;12294.20087694297;12366.62900112998;12401.13192076582;12506.687332816753;12582.937085314516;12285.69285767863;12415.44130514111;12604.747905042032;12647.936760316139;12813.103082784115;8476.576171191538;8744.519051452231;8758.598624220094;8775.91224087751;8788.16512431318;9670.226381889292;9682.854757178507;9906.752331191778;9914.851277230702;9919.702408927744;7912.406569507425;7917.406194535548;8064.596770161351;8122.309603683753;8355.749327520183;7962.402819788424;7977.401694873024;8019.1579884111325;8122.675092996214;8231.218034286732;6604.537682362381;6684.465242780663;6688.130543029375;6694.230163531061;6717.429018533479;5278.683279003272;5296.549793267615;5336.2529245904825;5450.31871016123;5545.029619816597;5327.360716714019;5343.091674415281;5385.46145385474;5459.208414779914;5523.25436066142 16:46:29 INFO - PID 20782 | |4;prototype.html;374.08722716571566;398.20557986816294;399.15578551363865;399.43878850215424;402.2317373816012;5091.261767043786;5191.922121168185;5273.129933560963;5329.493698098684;5343.492368225017;5062.443131255559;5213.452587478308;5215.4523775003645;5216;5230.163173892178;4116.58834116589;4141.523724771652;4153.107081977374;4160.83356665733;4162.396452514384;4082.4080508326274;4116.608922152391;4149.377593361005;4161.791910404483;4175.144095460439;4101.323281658522;4103.507579090498;4107.589241075883;4109.301418758818;4109.342505199169;4113.71204015719;4120.546739858613;4121.979390103045;4123.443335149746;4140.710150289481;3709.295233905549;3711.795851228181;3725.217704282104;3737.0657335666083;3739.4577786221116;4918.131110178145;5098.898022039539;5117.104506711348;5125.743712814345;5162.896742065175;4935.087008903364;4959;4966.404031516205;4973.32860063894;4979.626528010377;5494.5054945055135;5529.3364796224305;5600.5799565032785;5611.382747897728;5612.66324020556;4292.1630282095;4310.78446077698;4314.503832059322;4315.82736690532;4316.935245971313;5865.442782935657;5931.940680593182;5939.554533410012;5953.196318496991;5959.135925290852;4312.69811113219;4381.978090109593;4410.647148228134;4453.1316393303;4456.6211871991245;4451.688381813242;4466.129104824528;4486.910261794746;4492.663050271178;4508.887277818081;4908.558229759339;4929.605631549539;4930.841252305705;4934.235193545006;4936.654434189572;5411.783528658888;5530.198121272473;5536.501714845684;5566.053770858964;5572.693501857437;1471.720373129102;1506.621441381124;1517.2565442933103;1519.8556137166952;1524.6950609877847;1097.4238524774557;1139.8259792413828;1143.085531574737;1154.0940361815933;1163.650904728578;4865.245886887467;4871.147549178951;4884.975575122173;4898.853034408902;4903.583195428429;5529.889402211933;5719.942800571941;5727.312722473246;5769.9711501442225;5775.16260142277;4888.560029597354;4909.95090049095;4911.9754401227765;4916.0905232532095;4918.139325618003;2972.866221020059;3011.323407815986;3012.8041677290908;3033.3326668132977;3051.1761824307755;5287.867803304871;5298.655587386807;5313.734313284321;5331.20031995196;5361.812336568201;5838.328592211865;5855.3851845556455;5858.765649373977;5861.281668257094;5888;5236.659617124875;5312.973435132877;5337.226102215157;5338.626296159232;5369.677819330853;5695.544356451391;5705.258316418839;5710.771569137354;5731.707317073204;5735.827925162252;5471.562275018068;5635.492805647511;5663;5664.26364572603;5674.659520428788;5287.418383977836;5344.4922732340365;5349.893002140013;5352.304200453916;5364.436734142859;3963.980180099081;3966.7024973126554;3979.1842672252697;3980.601939805996;3983.8406463741126;5642.943570564242;5707.942920570741;5713.542916566747;5751.33859606134;5768.538516918553;5462.5374625374625;5515.972420138034;5539.944600554104;5550.8057217997175;5554.639443136844;5305.196233280703;5463.7814487420055;5542.806001789918;5542.806001790079;5558.527525160407;5232.424433312256;5400.135978243462;5400.729963501731;5416.9729151353995;5441.80280338325;5553.000919668997;5565.526930210977;5566.554675625859;5566.666000040011;5574.888502229852;5194.246834208943;5388.164834450667;5431.891362172813;5433.619646624857;5446.183072539151 16:46:29 INFO - PID 20782 | |5;yui.html;743.0600290632354;765.0589774577267;766.0309708219104;766.4673052228701;781.7615627233694;12916;13773.58679239622;13790.103643263194;13795.379207935643;13811.65470863229;13755.862441375582;15981.84018159818;16150.596235094128;16316;16366.918165409157;891.8038031633031;901.8872640919885;904.0688091266006;904.2494729374604;904.8778414913968;855.7774978505571;856.8543347630917;857.6783706110209;861.6467248428146;899.7975455522488;966.6520052780993;967.1392460709974;967.7725734452398;971.0192705367594;972.5331840716425;930.7952250504878;952.8951815300311;959.8128364968834;962.4417837654144;971.0677749360588;655.9147310849606;656.0487293424505;656.3403779201872;673.1383828699272;694.2016680817051;13311.467541298336;14199.574012779633;14404.711905761826;14420.206888621122;14434.711305773932;15412.46056388021;15796.684066318609;15800.20998950048;15820.841791582052;15825.366985320574;11898.702532436671;12407.25556466615;12409.441575129142;12416.130870839044;12420.565280215149;2938.089192350378;2939.470895238856;2955;2992.2668946108124;2997.190758495216;68942.65528672324;68947.65526172388;70838;72043.63978180075;74421.25578744197;12633.115681902362;12641.115121941375;12834.55079072228;12861.549845755353;13049.804252936214;20673.276435324693;20876.164953401694;20892.58214835725;20933.325333973247;20969.790302097088;6342.619442833445;6376.553641245161;6392.20097487814;6394.072859435449;6403.903941440882;3121.719045285935;3149.322895577416;3159.510275907238;3193.632732235776;3199.392115498048;3776.754510956779;3824.770513769183;3843;3843.0968722350226;3855.845766169378;692.2385376086265;699.192432740186;699.9335063168991;706.5831159615851;707.4234498883394;603.5865432178972;604.803438882365;618.0821480102045;619.829546874604;621.5586933277333;9280.679830042489;9779.853302200472;9899.505024748878;10311.793764124675;10394.740131496621;600.2676734384132;603.0562170203617;612.5712001598898;620.0791824141147;625.5746092656946;4345.587169218919;4541.6593755468475;4620.953790462052;4733.502982186889;4736.976315118472;57635.42364576385;57911.420885790605;58605;58956.705216473645;59247.40752592419;53118.61170672677;53859.461405385446;54144;54175;56254.43745562574;35563.64436355655;49491.75254123707;49882;50601.74699126481;52223.47776522186;10551.472426378803;11122.666320010088;11303;11392.48733806964;11431.828522572001;26187.214383568524;26550.86724566442;26558.86720566385;26986.730132698423;27862.3034424141;31906.20234494156;31911.521327179646;32168.678313217504;32665;32678.83660581777;12731.809022864849;12914.418851151533;13041.478340866259;13065.216087034809;13163.934180329421;15604.765928511308;15758.684826303639;15857.524274271791;15955.680886381975;16143.515694529184;13708.794368084287;13881.72236555243;13898.027138100237;14075.788863166856;14490.565283041526;13796.379162937892;13884.791728124288;14928.701425971636;15127.848721513084;15191.848081519043;12926.741465170457;13027.869721302666;14044.719105618035;14144.504942326968;14375.496857609933;9507.144357007903;9602;10377.844332335171;10585.206109541969;10773.24587278883;11583.189176757545;12050.337231452004;12063.577774777841;12085.516579336729;12109.849564291379 16:46:29 INFO - PID 20782 | __end_tp_report 16:46:29 INFO - PID 20782 | __start_cc_report 16:46:29 INFO - PID 20782 | _x_x_mozilla_cycle_collect,1464 16:46:29 INFO - PID 20782 | __end_cc_report 16:46:29 INFO - PID 20782 | __startTimestamp1494373589700__endTimestamp 16:46:29 INFO - PID 20782 | 16:46:29 INFO - PID 20782 | ------- Summary: start ------- 16:46:29 INFO - PID 20782 | Number of tests: 6 16:46:29 INFO - PID 20782 | 16:46:29 INFO - PID 20782 | [#0] dojo.html Cycles:165 Average:5163.45 Median:5317.18 stddev:598.51 (11.3%) stddev-sans-first:568.14 16:46:29 INFO - PID 20782 | Values: 2694.7 2720.9 2751.1 2754.1 2756.4 5064.7 5209.7 5299.8 5313.6 5357.5 5126.6 5176.8 5226.9 5267.7 5317.2 4415.6 4614.4 4682.2 4744.4 4784.5 4732.2 4738.5 4758.5 4768.1 4804.3 4572.3 4643.7 4661.8 4667.8 4700.7 4674.6 4675.7 4698.2 4750.4 4766.6 4635.7 4673.8 4696.4 4702.1 4744.1 5105.6 5189.4 5203.9 5247.3 5257.0 5484.0 5492.5 5616.4 5617.4 5622.2 5688.7 5708.3 5710.9 5723.2 5724.2 5174.7 5284.5 5292.0 5294.7 5337.1 5669.6 5703.1 5752.5 5825.6 5828.1 5516.3 5539.8 5545.2 5600.1 5632.9 5650.6 5651.3 5661.8 5693.0 5708.7 5601.7 5606.6 5611.9 5615.3 5623.1 5474.5 5531.5 5600.7 5617.4 5618.8 4667.3 4680.3 4713.0 4720.9 4725.7 4080.8 4084.7 4094.8 4097.3 4134.8 4732.5 4835.4 4838.8 4839.9 4847.9 5636.2 5665.7 5724.7 5757.7 5778.0 4795.2 4799.0 4801.8 4801.8 4852.1 4994.8 4995.2 5001.3 5008.5 5039.6 5202.0 5223.9 5257.1 5350.0 5359.3 5562.2 5569.2 5573.6 5577.4 5685.3 5155.8 5165.6 5171.5 5202.0 5211.5 5466.4 5475.7 5527.1 5546.4 5552.1 5618.4 5657.9 5678.7 5690.1 5701.9 5395.5 5441.8 5509.8 5512.1 5518.2 5447.8 5480.1 5528.2 5549.2 5559.1 5437.6 5439.5 5445.1 5459.6 5471.4 5587.0 5598.3 5600.2 5600.7 5613.7 5301.3 5313.8 5403.0 5414.2 5417.6 16:46:29 INFO - PID 20782 | 16:46:29 INFO - PID 20782 | [#1] ext.html Cycles:180 Average:30572.44 Median:30029.93 stddev:42552.31 (141.7%) stddev-sans-first:42612.23 16:46:29 INFO - PID 20782 | Values: 617.4 661.6 677.9 1026.6 1027.7 25737.9 30882.0 33205.5 33314.3 33328.5 34373.1 34649.9 34672.7 34724.1 34724.7 5400.2 7021.0 7171.5 7176.7 7176.7 5408.7 5500.9 5502.1 6969.1 7117.6 7179.4 7195.7 7202.8 7227.2 7275.2 7141.0 7197.7 7200.5 7207.4 7214.4 5339.3 5467.3 6758.4 6880.5 7131.6 32780.5 33089.8 33117.0 33148.7 33178.8 3032.7 3079.8 3084.0 3084.5 3085.7 24803.0 24878.5 24894.3 24909.1 24937.0 3130.4 3154.5 3162.4 3163.0 3169.2 145776.3 146232.3 146261.0 146303.0 146784.0 41794.4 41864.8 41883.6 41899.8 41996.0 44072.3 44141.0 44187.8 44232.0 44274.8 12811.9 12826.5 12888.7 12898.4 12934.4 10360.6 10375.9 10383.4 10391.8 10392.4 10161.4 10280.9 13528.3 13598.9 13644.5 5312.8 5549.8 5594.2 5613.0 5647.8 858.8 918.5 919.9 922.9 934.6 21888.0 22879.0 22916.0 23118.2 23194.7 941.7 941.8 958.9 972.7 979.1 10918.3 11331.2 11471.1 11496.4 11601.7 181225.0 181728.0 182203.0 182334.0 182838.0 40351.0 40635.4 40646.6 40666.0 40726.8 1186.5 1225.5 1226.9 1228.5 1230.8 19781.8 19896.4 20489.7 21475.6 21482.1 29600.9 29604.7 29610.6 29689.4 29703.4 163388.0 163810.0 163845.0 163873.0 164515.0 25401.9 29445.7 29979.9 30080.0 30242.8 30369.5 30508.8 30523.5 30527.2 30543.5 23040.5 26019.0 26334.3 26828.0 27719.7 26116.6 26797.5 26882.7 27048.9 27323.6 29316.7 29552.3 29565.7 29595.3 29620.6 24807.5 25359.1 25829.0 26188.6 26688.9 20349.3 21091.6 21119.0 21170.3 21201.6 16:46:29 INFO - PID 20782 | 16:46:29 INFO - PID 20782 | [#2] jquery.html Cycles:180 Average:24612.69 Median:38239.52 stddev:60176.87 (157.4%) stddev-sans-first:60318.25 16:46:29 INFO - PID 20782 | Values: 414.7 416.5 429.5 434.3 437.4 16675.7 17192.7 17480.8 17495.5 17773.0 17521.7 17869.3 18003.3 18024.2 18300.5 5336.5 5344.9 5358.6 5432.8 5537.2 5369.5 5438.8 5450.7 5454.7 5456.0 5301.1 5386.2 5429.1 5432.4 5441.6 5341.4 5416.1 5426.6 5428.0 5432.2 4825.9 4858.0 4921.3 4921.9 4933.6 20729.4 20736.8 20861.7 20894.6 20919.5 1603.2 1630.3 1640.1 1645.4 1648.6 13709.6 14023.7 14083.3 14217.3 14341.5 1997.6 2006.9 2061.8 2073.6 2078.7 71920.6 79276.0 99592.0 101830.0 102568.0 10035.8 10219.2 10375.4 10486.7 10505.5 13910.8 13920.4 13936.7 13965.3 14044.4 6979.5 7127.4 7162.0 7339.2 7352.3 6569.4 6628.5 6774.1 6805.3 6814.6 6594.3 6670.6 6686.9 6703.1 6735.1 1932.9 1986.0 1995.6 2029.5 2044.7 862.0 882.9 885.5 887.1 916.6 16937.6 17239.0 17477.5 17708.2 17844.4 883.1 884.9 892.9 915.6 917.5 9140.5 9650.0 9659.5 9699.2 9728.4 352393.0 354170.0 361643.0 363123.0 365609.0 77297.0 77355.6 79975.6 80970.6 81820.2 1075.1 1093.8 1097.3 1104.8 1107.4 14409.1 14792.2 14852.4 14990.5 15499.8 37738.6 38740.4 39844.6 39968.2 41388.4 51103.2 51194.0 51390.2 51813.2 54087.7 8377.6 8419.1 8499.0 8704.3 8814.2 11890.5 11980.2 12118.5 12468.9 12649.4 9758.8 9984.7 10223.6 10342.5 10401.7 10266.8 10320.8 10459.7 10625.4 10655.9 11362.5 11419.5 11427.9 11586.2 11827.6 8314.3 8329.1 8460.2 8498.8 8837.7 10619.3 10666.4 10697.0 10984.8 11065.1 16:46:29 INFO - PID 20782 | 16:46:29 INFO - PID 20782 | [#3] mootools.html Cycles:180 Average:6468.44 Median:3795.79 stddev:4137.88 (109.0%) stddev-sans-first:4130.86 16:46:29 INFO - PID 20782 | Values: 1243.8 1247.0 1275.8 1295.9 1307.3 9949.4 10362.5 10365.1 10377.4 10379.6 10011.6 10097.2 10558.5 10572.4 10594.3 2300.4 2338.5 2342.5 2343.6 2345.0 2174.9 2299.5 2304.2 2309.2 2317.1 1934.4 2012.8 2185.2 2254.6 2254.8 2285.3 2311.6 2313.5 2314.6 2315.3 2242.3 2269.9 2302.5 2303.9 2305.7 10238.0 10395.6 10406.5 10434.3 10441.1 5751.0 5953.4 5954.4 5956.8 5975.3 3339.2 3410.4 3450.2 3464.2 3471.4 1121.3 1169.1 1198.4 1215.7 1232.7 15359.2 15507.1 15508.2 15522.2 15531.2 4776.6 4822.4 5065.6 5072.7 5093.0 10893.1 10900.7 10913.5 10928.7 10947.9 5787.4 5792.3 5793.4 5800.8 5806.5 5164.7 5179.4 5329.7 5358.6 5406.9 3911.0 3911.7 3984.6 4026.8 4090.7 1110.0 1119.7 1127.9 1133.1 1138.8 619.4 628.6 722.0 732.7 738.0 6692.3 6714.9 6752.4 6797.8 6939.5 802.8 846.7 864.8 868.7 873.4 3644.1 3680.6 4001.3 4179.1 4272.2 13202.3 13926.4 13936.4 13945.1 13953.3 13175.6 13608.9 13811.7 13815.1 13821.2 7530.7 7792.4 7817.6 8011.7 8014.6 6313.8 6413.0 6479.6 6528.5 6558.8 12294.2 12366.6 12401.1 12506.7 12582.9 12285.7 12415.4 12604.7 12647.9 12813.1 8476.6 8744.5 8758.6 8775.9 8788.2 9670.2 9682.9 9906.8 9914.9 9919.7 7912.4 7917.4 8064.6 8122.3 8355.7 7962.4 7977.4 8019.2 8122.7 8231.2 6604.5 6684.5 6688.1 6694.2 6717.4 5278.7 5296.5 5336.3 5450.3 5545.0 5327.4 5343.1 5385.5 5459.2 5523.3 16:46:29 INFO - PID 20782 | 16:46:29 INFO - PID 20782 | [#4] prototype.html Cycles:180 Average:4656.07 Median:5144.32 stddev:1300.58 (25.3%) stddev-sans-first:1263.89 16:46:29 INFO - PID 20782 | Values: 374.1 398.2 399.2 399.4 402.2 5091.3 5191.9 5273.1 5329.5 5343.5 5062.4 5213.5 5215.5 5216.0 5230.2 4116.6 4141.5 4153.1 4160.8 4162.4 4082.4 4116.6 4149.4 4161.8 4175.1 4101.3 4103.5 4107.6 4109.3 4109.3 4113.7 4120.5 4122.0 4123.4 4140.7 3709.3 3711.8 3725.2 3737.1 3739.5 4918.1 5098.9 5117.1 5125.7 5162.9 4935.1 4959.0 4966.4 4973.3 4979.6 5494.5 5529.3 5600.6 5611.4 5612.7 4292.2 4310.8 4314.5 4315.8 4316.9 5865.4 5931.9 5939.6 5953.2 5959.1 4312.7 4382.0 4410.6 4453.1 4456.6 4451.7 4466.1 4486.9 4492.7 4508.9 4908.6 4929.6 4930.8 4934.2 4936.7 5411.8 5530.2 5536.5 5566.1 5572.7 1471.7 1506.6 1517.3 1519.9 1524.7 1097.4 1139.8 1143.1 1154.1 1163.7 4865.2 4871.1 4885.0 4898.9 4903.6 5529.9 5719.9 5727.3 5770.0 5775.2 4888.6 4910.0 4912.0 4916.1 4918.1 2972.9 3011.3 3012.8 3033.3 3051.2 5287.9 5298.7 5313.7 5331.2 5361.8 5838.3 5855.4 5858.8 5861.3 5888.0 5236.7 5313.0 5337.2 5338.6 5369.7 5695.5 5705.3 5710.8 5731.7 5735.8 5471.6 5635.5 5663.0 5664.3 5674.7 5287.4 5344.5 5349.9 5352.3 5364.4 3964.0 3966.7 3979.2 3980.6 3983.8 5642.9 5707.9 5713.5 5751.3 5768.5 5462.5 5516.0 5539.9 5550.8 5554.6 5305.2 5463.8 5542.8 5542.8 5558.5 5232.4 5400.1 5400.7 5417.0 5441.8 5553.0 5565.5 5566.6 5566.7 5574.9 5194.2 5388.2 5431.9 5433.6 5446.2 16:46:29 INFO - PID 20782 | 16:46:29 INFO - PID 20782 | [#5] yui.html Cycles:180 Average:14945.66 Median:3196.51 stddev:17256.62 (539.9%) stddev-sans-first:17272.07 16:46:29 INFO - PID 20782 | Values: 743.1 765.1 766.0 766.5 781.8 12916.0 13773.6 13790.1 13795.4 13811.7 13755.9 15981.8 16150.6 16316.0 16366.9 891.8 901.9 904.1 904.2 904.9 855.8 856.9 857.7 861.6 899.8 966.7 967.1 967.8 971.0 972.5 930.8 952.9 959.8 962.4 971.1 655.9 656.0 656.3 673.1 694.2 13311.5 14199.6 14404.7 14420.2 14434.7 15412.5 15796.7 15800.2 15820.8 15825.4 11898.7 12407.3 12409.4 12416.1 12420.6 2938.1 2939.5 2955.0 2992.3 2997.2 68942.7 68947.7 70838.0 72043.6 74421.3 12633.1 12641.1 12834.6 12861.5 13049.8 20673.3 20876.2 20892.6 20933.3 20969.8 6342.6 6376.6 6392.2 6394.1 6403.9 3121.7 3149.3 3159.5 3193.6 3199.4 3776.8 3824.8 3843.0 3843.1 3855.8 692.2 699.2 699.9 706.6 707.4 603.6 604.8 618.1 619.8 621.6 9280.7 9779.9 9899.5 10311.8 10394.7 600.3 603.1 612.6 620.1 625.6 4345.6 4541.7 4621.0 4733.5 4737.0 57635.4 57911.4 58605.0 58956.7 59247.4 53118.6 53859.5 54144.0 54175.0 56254.4 35563.6 49491.8 49882.0 50601.7 52223.5 10551.5 11122.7 11303.0 11392.5 11431.8 26187.2 26550.9 26558.9 26986.7 27862.3 31906.2 31911.5 32168.7 32665.0 32678.8 12731.8 12914.4 13041.5 13065.2 13163.9 15604.8 15758.7 15857.5 15955.7 16143.5 13708.8 13881.7 13898.0 14075.8 14490.6 13796.4 13884.8 14928.7 15127.8 15191.8 12926.7 13027.9 14044.7 14144.5 14375.5 9507.1 9602.0 10377.8 10585.2 10773.2 11583.2 12050.3 12063.6 12085.5 12109.8 16:46:29 INFO - PID 20782 | -------- Summary: end -------- 16:46:29 INFO - PID 20782 | 16:46:30 INFO - TEST-INFO | 20782: exit 0 16:46:30 INFO - TEST-OK | dromaeo_css | took 1120918ms 16:46:30 INFO - TEST-START | kraken 16:46:30 INFO - operating with platform_type : linux_ 16:46:30 INFO - Initialising browser for kraken test... 16:46:30 INFO - TEST-INFO | started process 21106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphtvsLe/profile http://localhost:36551/getInfo.html) 16:46:34 INFO - PID 21106 | __metrics Screen width/height:1600/1200 16:46:34 INFO - PID 21106 | colorDepth:24 16:46:34 INFO - PID 21106 | Browser inner width/height: 1024/695 16:46:34 INFO - PID 21106 | __metrics 16:46:35 INFO - PID 21106 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:46:35 INFO - PID 21106 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:46:36 INFO - TEST-INFO | 21106: exit 0 16:46:36 INFO - Browser initialized. 16:46:36 INFO - Running cycle 1/1 for kraken test... 16:46:36 INFO - TEST-INFO | started process 21200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphtvsLe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:48 INFO - PID 21200 | RSS: Main: 149327872 16:46:48 INFO - PID 21200 | 16:46:50 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36551/tests/kraken/driver.html?testName=audio-beat-detection) 16:46:51 INFO - PID 21200 | RSS: Main: 221691904 16:46:51 INFO - PID 21200 | 16:46:54 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36551/tests/kraken/driver.html?testName=audio-dft) 16:46:55 INFO - PID 21200 | RSS: Main: 181829632 16:46:55 INFO - PID 21200 | 16:46:58 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36551/tests/kraken/driver.html?testName=audio-fft) 16:46:58 INFO - PID 21200 | RSS: Main: 264065024 16:46:58 INFO - PID 21200 | 16:47:00 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36551/tests/kraken/driver.html?testName=audio-oscillator) 16:47:01 INFO - PID 21200 | RSS: Main: 175067136 16:47:01 INFO - PID 21200 | 16:47:03 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36551/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:47:04 INFO - PID 21200 | RSS: Main: 177324032 16:47:04 INFO - PID 21200 | 16:47:07 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36551/tests/kraken/driver.html?testName=imaging-darkroom) 16:47:08 INFO - PID 21200 | RSS: Main: 238223360 16:47:08 INFO - PID 21200 | 16:47:11 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36551/tests/kraken/driver.html?testName=imaging-desaturate) 16:47:12 INFO - PID 21200 | RSS: Main: 237232128 16:47:12 INFO - PID 21200 | 16:47:15 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36551/tests/kraken/driver.html?testName=json-parse-financial) 16:47:15 INFO - PID 21200 | RSS: Main: 235089920 16:47:15 INFO - PID 21200 | 16:47:17 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36551/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:47:17 INFO - PID 21200 | RSS: Main: 199667712 16:47:17 INFO - PID 21200 | 16:47:19 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36551/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:47:20 INFO - PID 21200 | RSS: Main: 187338752 16:47:20 INFO - PID 21200 | 16:47:22 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36551/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:47:22 INFO - PID 21200 | RSS: Main: 215539712 16:47:22 INFO - PID 21200 | 16:47:25 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:47:26 INFO - PID 21200 | RSS: Main: 224493568 16:47:26 INFO - PID 21200 | 16:47:29 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:47:30 INFO - PID 21200 | RSS: Main: 219512832 16:47:30 INFO - PID 21200 | 16:47:31 INFO - PID 21200 | Cycle 1(1): loaded http://localhost:36551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36551/tests/kraken/driver.html?testName=ai-astar) 16:47:32 INFO - PID 21200 | RSS: Main: 269955072 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | __start_tp_report 16:47:32 INFO - PID 21200 | _x_x_mozilla_page_load 16:47:32 INFO - PID 21200 | _x_x_mozilla_page_load_details 16:47:32 INFO - PID 21200 | |i|pagename|runs| 16:47:32 INFO - PID 21200 | |0;ai-astar;108;111;111;111;110;115;113;112;111;113 16:47:32 INFO - PID 21200 | |1;audio-beat-detection;154;123;123;169;124;124;123;120;144;127 16:47:32 INFO - PID 21200 | |2;audio-dft;162;161;161;160;162;164;162;161;161;161 16:47:32 INFO - PID 21200 | |3;audio-fft;75;75;77;113;77;75;74;75;100;74 16:47:32 INFO - PID 21200 | |4;audio-oscillator;83;83;102;83;83;84;102;84;83;114 16:47:32 INFO - PID 21200 | |5;imaging-gaussian-blur;114;113;113;113;113;114;113;113;113;114 16:47:32 INFO - PID 21200 | |6;imaging-darkroom;149;149;148;148;148;148;148;149;149;148 16:47:32 INFO - PID 21200 | |7;imaging-desaturate;94;94;93;94;93;94;94;94;93;93 16:47:32 INFO - PID 21200 | |8;json-parse-financial;52;51;51;53;53;53;53;53;52;53 16:47:32 INFO - PID 21200 | |9;json-stringify-tinderbox;56;56;57;57;57;56;57;56;57;56 16:47:32 INFO - PID 21200 | |10;stanford-crypto-aes;81;79;80;81;81;81;82;84;81;82 16:47:32 INFO - PID 21200 | |11;stanford-crypto-ccm;132;149;130;136;129;128;132;129;175;132 16:47:32 INFO - PID 21200 | |12;stanford-crypto-pbkdf2;182;192;191;188;190;189;186;187;190;190 16:47:32 INFO - PID 21200 | |13;stanford-crypto-sha256-iterative;73;75;74;72;70;75;74;72;74;71 16:47:32 INFO - PID 21200 | __end_tp_report 16:47:32 INFO - PID 21200 | __start_cc_report 16:47:32 INFO - PID 21200 | _x_x_mozilla_cycle_collect,1993 16:47:32 INFO - PID 21200 | __end_cc_report 16:47:32 INFO - PID 21200 | __startTimestamp1494373652222__endTimestamp 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | ------- Summary: start ------- 16:47:32 INFO - PID 21200 | Number of tests: 14 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:1.90 (1.7%) stddev-sans-first:1.54 16:47:32 INFO - PID 21200 | Values: 108.0 111.0 111.0 111.0 110.0 115.0 113.0 112.0 111.0 113.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:125.50 stddev:16.75 (13.3%) stddev-sans-first:15.97 16:47:32 INFO - PID 21200 | Values: 154.0 123.0 123.0 169.0 124.0 124.0 123.0 120.0 144.0 127.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 16:47:32 INFO - PID 21200 | Values: 162.0 161.0 161.0 160.0 162.0 164.0 162.0 161.0 161.0 161.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:13.57 (18.1%) stddev-sans-first:14.18 16:47:32 INFO - PID 21200 | Values: 75.0 75.0 77.0 113.0 77.0 75.0 74.0 75.0 100.0 74.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.00 stddev:11.45 (13.8%) stddev-sans-first:11.86 16:47:32 INFO - PID 21200 | Values: 83.0 83.0 102.0 83.0 83.0 84.0 102.0 84.0 83.0 114.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 16:47:32 INFO - PID 21200 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 114.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 16:47:32 INFO - PID 21200 | Values: 149.0 149.0 148.0 148.0 148.0 148.0 148.0 149.0 149.0 148.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:47:32 INFO - PID 21200 | Values: 94.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 93.0 93.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:0.84 (1.6%) stddev-sans-first:0.88 16:47:32 INFO - PID 21200 | Values: 52.0 51.0 51.0 53.0 53.0 53.0 53.0 53.0 52.0 53.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:57.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 16:47:32 INFO - PID 21200 | Values: 56.0 56.0 57.0 57.0 57.0 56.0 57.0 56.0 57.0 56.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:1.32 (1.6%) stddev-sans-first:1.39 16:47:32 INFO - PID 21200 | Values: 81.0 79.0 80.0 81.0 81.0 81.0 82.0 84.0 81.0 82.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:132.00 stddev:14.61 (11.1%) stddev-sans-first:15.38 16:47:32 INFO - PID 21200 | Values: 132.0 149.0 130.0 136.0 129.0 128.0 132.0 129.0 175.0 132.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.50 Median:190.00 stddev:2.92 (1.5%) stddev-sans-first:1.92 16:47:32 INFO - PID 21200 | Values: 182.0 192.0 191.0 188.0 190.0 189.0 186.0 187.0 190.0 190.0 16:47:32 INFO - PID 21200 | 16:47:32 INFO - PID 21200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:74.00 stddev:1.70 (2.3%) stddev-sans-first:1.80 16:47:32 INFO - PID 21200 | Values: 73.0 75.0 74.0 72.0 70.0 75.0 74.0 72.0 74.0 71.0 16:47:32 INFO - PID 21200 | -------- Summary: end -------- 16:47:32 INFO - PID 21200 | 16:47:33 INFO - TEST-INFO | 21200: exit 0 16:47:33 INFO - TEST-OK | kraken | took 62878ms 16:47:33 INFO - SUITE-END | took 1183s 16:47:33 INFO - Completed test suite (00:19:44) 16:47:33 INFO - javascript benchmark 16:47:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6711.310336849969, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2694.6766388033434, 2720.8503532305717, 2751.1471443852406, 2754.063618369754, 2756.434930839177, 5064.696118232909, 5209.661372010816, 5299.761510732017, 5313.57491400688, 5357.517823395893, 5126.615503837218, 5176.7929282828645, 5226.8693282667955, 5267.710275934822, 5317.175837745156, 4415.580519850609, 4614.400127983357, 4682.157211701892, 4744.383230180089, 4784.473707892129, 4732.171869922784, 4738.47876733559, 4758.547937945889, 4768.094062128202, 4804.303376010476, 4572.314152877062, 4643.698159619647, 4661.790219440133, 4667.766611669403, 4700.694454860457, 4674.579287864074, 4675.719456832567, 4698.201305777991, 4750.429948406213, 4766.594839438651, 4635.7218566886095, 4673.766311684436, 4696.365990591295, 4702.106599746037, 4744.07490539345, 5105.642605017651, 5189.40321862983, 5203.895922081575, 5247.317848679647, 5257.0, 5483.972580137074, 5492.533134683556, 5616.410276920906, 5617.410171931929, 5622.156676498517, 5688.658680479184, 5708.286464191976, 5710.942890571124, 5723.227364305807, 5724.16999535065, 5174.663646862942, 5284.497972692588, 5291.973540132351, 5294.735263236861, 5337.066013447631, 5669.574781891375, 5703.058995265817, 5752.511036561856, 5825.592208545361, 5828.12578113278, 5516.310461192351, 5539.778408863681, 5545.223668686387, 5600.075987462104, 5632.9436705632415, 5650.63270887391, 5651.265335506358, 5661.830145095653, 5693.03218452864, 5708.65748055118, 5601.719914004283, 5606.579506537026, 5611.9438805612235, 5615.2700148981185, 5623.128415095667, 5474.452554744574, 5531.474509921551, 5600.6919619420505, 5617.43825617435, 5618.775248989995, 4667.346571479996, 4680.3447517347595, 4712.95287047132, 4720.905581888343, 4725.692829966041, 4080.81636326366, 4084.6732261419015, 4094.754314741125, 4097.303458412077, 4134.813933373005, 4732.455767586703, 4835.44392394872, 4838.806447742051, 4839.927401088987, 4847.854564363075, 5636.2391077204875, 5665.688387138747, 5724.713764311768, 5757.6833274169485, 5777.971110144423, 4795.232762757942, 4799.0, 4801.783919723621, 4801.807927682854, 4852.102361063215, 4994.825181118644, 4995.17579599362, 5001.349824522788, 5008.524190201925, 5039.647224694236, 5202.0, 5223.92164117531, 5257.0800109981365, 5350.0, 5359.330083739533, 5562.249096371938, 5569.19246709233, 5573.581981351496, 5577.358603760619, 5685.34618518859, 5155.845324640117, 5165.586753059822, 5171.45699701541, 5202.03762303975, 5211.47885211491, 5466.3986961435, 5475.72621368922, 5527.143292789624, 5546.417626149358, 5552.111662134039, 5618.410066943075, 5657.886842263049, 5678.68767217807, 5690.118031705092, 5701.914471282851, 5395.487428694268, 5441.809536666197, 5509.834704958857, 5512.118061110203, 5518.172274158908, 5447.782088716407, 5480.068388374066, 5528.170774383874, 5549.1676248561425, 5559.138333558305, 5437.646552974044, 5439.537639300704, 5445.101558242845, 5459.5632349412745, 5471.425500322568, 5586.994341018656, 5598.3282006159525, 5600.159976003632, 5600.747966341606, 5613.663180209201, 5301.310829592283, 5313.814016509404, 5403.0, 5414.242006119225, 5417.593680474059], "value": 5120.532394767572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.3764497857165, 661.5600625583987, 677.9457643388528, 1026.5791025679473, 1027.7173777211267, 25737.871310643444, 30882.0, 33205.50191747123, 33314.33371332578, 33328.50007249887, 34373.14067148316, 34649.92100473967, 34672.65327346726, 34724.131896702595, 34724.65275347246, 5400.243965844785, 7020.964895175517, 7171.533850299714, 7176.712931482734, 7176.748813791518, 5408.675479471224, 5500.862478438031, 5502.119660854264, 6969.059177011115, 7117.644117794115, 7179.425645948338, 7195.676194571257, 7202.783916482514, 7227.241139680311, 7275.236100209481, 7140.964295178543, 7197.676104575306, 7200.49596528238, 7207.423406127524, 7214.350708436214, 5339.252504649352, 5467.289252397202, 6758.357955994173, 6880.518363714542, 7131.643417829139, 32780.508292375634, 33089.834550827094, 33117.0, 33148.66851331504, 33178.834105829555, 3032.7118923702214, 3079.7690173237097, 3084.0, 3084.4910589752662, 3085.7377122944577, 24803.0, 24878.50242995148, 24894.253172404857, 24909.128180513777, 24937.0, 3130.4208721386617, 3154.463741164008, 3162.3991441626017, 3162.9525557116663, 3169.239382548195, 145776.2711186448, 146232.2688386562, 146261.0, 146303.0, 146784.0, 41794.37308440376, 41864.790676046425, 41883.58116418797, 41899.7905010473, 41996.0, 44072.338914916305, 44141.0, 44187.77906110513, 44232.0, 44274.786260687484, 12811.871881281255, 12826.486940522462, 12888.677783055498, 12898.419571119135, 12934.353282335846, 10360.637377691895, 10375.94812025935, 10383.428911409794, 10391.792164156675, 10392.428416437016, 10161.441120738431, 10280.897191027994, 13528.255945923069, 13598.864011359958, 13644.522441714493, 5312.838860877771, 5549.750261238254, 5594.24477695514, 5613.0, 5647.774089036392, 858.7638399440079, 918.4626993209048, 919.9402038867452, 922.8707980882682, 934.5981228071994, 21888.0, 22879.0, 22916.0, 23118.19086332004, 23194.65208021881, 941.6562954521551, 941.8351788436996, 958.9041095890494, 972.6838777397375, 979.128575567731, 10918.344899305908, 11331.150163737753, 11471.082313414907, 11496.42517874103, 11601.651950441501, 181225.0, 181728.0, 182203.0, 182334.0, 182838.0, 40351.0, 40635.390469142985, 40646.59353406428, 40666.0, 40726.79636601798, 1186.5009920006219, 1225.5281716539196, 1226.8957138643316, 1228.4840367045863, 1230.833837431953, 19781.80218197857, 19896.403107906786, 20489.69265461049, 21475.570488589827, 21482.14071437125, 29600.851995740744, 29604.703952960193, 29610.55584166196, 29689.406211876074, 29703.40593188081, 163388.0, 163810.0, 163845.0, 163873.0, 164515.0, 25401.87299063493, 29445.705542944295, 29979.850100749358, 30080.0, 30242.84878575681, 30369.544456833606, 30508.847455762578, 30523.542146868258, 30527.236819079702, 30543.54184687187, 23040.508655589234, 26019.0, 26334.341641459116, 26828.0, 27719.72280277252, 26116.580996768083, 26797.464050719267, 26882.73117268802, 27048.864755676095, 27323.59014614822, 29316.7068329314, 29552.261193470335, 29565.704342956295, 29595.26011849635, 29620.555691665075, 24807.50384992326, 25359.112431064823, 25829.0, 26188.607170892832, 26688.866555667097, 20349.287774927805, 21091.6012277279, 21119.04964276642, 21170.25904093349, 21201.575968480236], "value": 14371.649015778441, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.74907680853084, 416.5189206466532, 429.5253744612202, 434.3332983869761, 437.4357079367616, 16675.749863752055, 17192.742108868344, 17480.825191748096, 17495.47513574593, 17773.0, 17521.7371739424, 17869.302416270468, 18003.279868805264, 18024.188911498983, 18300.450986470394, 5336.546393556552, 5344.866378340553, 5358.624896257264, 5432.837014889559, 5537.224788529609, 5369.48989845964, 5438.755256013469, 5450.727463626803, 5454.699991500466, 5456.0, 5301.098813201765, 5386.218998245252, 5429.077056900317, 5432.402435732066, 5441.564674826024, 5341.412444631087, 5416.133418652997, 5426.565874730012, 5428.0, 5432.185172224158, 4825.879353016167, 4857.975710121426, 4921.286413470027, 4921.926171107436, 4933.555979961785, 20729.378118656463, 20736.792632073637, 20861.68707469389, 20894.5821083579, 20919.477013074644, 1603.1984007996002, 1630.315267587616, 1640.1143382573396, 1645.3747575921072, 1648.620817212036, 13709.588712338646, 14023.737863592223, 14083.295835208199, 14217.289135543182, 14341.49804756839, 1997.6404247235491, 2006.9397918062482, 2061.752589689232, 2073.5645514441985, 2078.6778049402365, 71920.6403967982, 79276.0, 99592.0, 101830.0, 102567.99999999926, 10035.849462258071, 10219.18246540275, 10375.429351385746, 10486.685399438029, 10505.474726263808, 13910.791338129937, 13920.37358318878, 13936.651583710489, 13965.301734913417, 14044.36800343987, 6979.546329488669, 7127.358537731629, 7161.958841730186, 7339.155997060299, 7352.264773522605, 6569.37590928861, 6628.4697224221945, 6774.051632771416, 6805.285445028299, 6814.591124532544, 6594.340565943367, 6670.566413183127, 6686.899696504556, 6703.061571380011, 6735.124433823572, 1932.9323473678635, 1985.9702104468445, 1995.610855883118, 2029.5433527456205, 2044.723962265105, 861.9784505387415, 882.9293656507464, 885.4554449013939, 887.0995939121797, 916.6104405627715, 16937.576560585836, 17239.0, 17477.475675729747, 17708.203130859143, 17844.375446859296, 883.0595415882065, 884.8893888263967, 892.8928528576612, 915.6017132547363, 917.5274733512247, 9140.451572905515, 9649.951750241204, 9659.46872921996, 9699.224062075016, 9728.404168888805, 352393.0, 354170.0, 361643.0, 363123.0, 365609.0, 77297.0, 77355.61322193353, 79975.60012199901, 80970.5951470239, 81820.18179818244, 1075.1291453922347, 1093.7703082352637, 1097.2922465010024, 1104.7956128116325, 1107.363266121967, 14409.13545187292, 14792.186429746036, 14852.405903763729, 14990.47533336328, 15499.767503487683, 37738.622613773514, 38740.41889371605, 39844.601553985245, 39968.2006359877, 41388.37917431301, 51103.233451497515, 51194.0, 51390.22914656358, 51813.22280165725, 54087.72956135194, 8377.581120943807, 8419.11599282091, 8498.957505212682, 8704.26013788835, 8814.206721395105, 11890.524379024742, 11980.221285616408, 12118.515259389525, 12468.937655311665, 12649.367531623566, 9758.804823903623, 9984.650537231162, 10223.591056357662, 10342.482875856327, 10401.739956501147, 10266.794664106825, 10320.845187322046, 10459.738506537093, 10625.415602141957, 10655.946720266349, 11362.54549817998, 11419.486123124314, 11427.885721142682, 11586.246893951866, 11827.645170644895, 8314.334853211849, 8329.12544182852, 8460.238578527962, 8498.787530311793, 8837.690680826398, 10619.256652034592, 10666.36001839892, 10697.037266646039, 10984.835227471754, 11065.114790816877], "value": 8709.945809987936, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.75124975005, 1246.9625911222668, 1275.8405199350086, 1295.9416826242818, 1307.3332600373806, 9949.403035817855, 10362.53368598413, 10365.067143957041, 10377.377357358555, 10379.584816607327, 10011.649592264272, 10097.192224622031, 10558.524866381013, 10572.365658060522, 10594.311369760979, 2300.378897697625, 2338.4738433852417, 2342.531493701258, 2343.589871772433, 2344.9765502345012, 2174.8803815790125, 2299.471121642015, 2304.158981971577, 2309.157157637467, 2317.1194945920524, 1934.4486821255946, 2012.8490363222743, 2185.169635538501, 2254.6392577187653, 2254.77452254774, 2285.3029825903095, 2311.5839148953182, 2313.5141620259765, 2314.6296592545114, 2315.2591170825344, 2242.2936774915847, 2269.920552780661, 2302.4934514406805, 2303.8502497337618, 2305.688732021189, 10238.0, 10395.636152734618, 10406.479676016168, 10434.321769084985, 10441.112505437048, 5751.0, 5953.374895635982, 5954.374790646963, 5956.761729530814, 5975.342712301644, 3339.215284408162, 3410.360724254202, 3450.240946991658, 3464.2378676691087, 3471.444568868994, 1121.2879821313443, 1169.1248770894788, 1198.4187668980537, 1215.6960759810047, 1232.7472868062025, 15359.232038398148, 15507.147106909115, 15508.224588770516, 15522.223888805514, 15531.223438828127, 4776.617870570346, 4822.42130944289, 5065.569426598707, 5072.721000344943, 5092.9745351273, 10893.128549716004, 10900.672979810619, 10913.454327283604, 10928.726781830359, 10947.945260273807, 5787.421257874179, 5792.333881603585, 5793.449622285876, 5800.767969281182, 5806.535477161901, 5164.690118592821, 5179.352580927384, 5329.7068661224, 5358.5981051421295, 5406.91889621656, 3910.980445097813, 3911.7261791674878, 3984.641382275609, 4026.778527181033, 4090.6727461802984, 1110.0, 1119.7144728094447, 1127.881572434899, 1133.0652211925194, 1138.8064029115071, 619.3668584226454, 628.5694299404922, 721.9639018049181, 732.7325526182905, 738.0442327186306, 6692.263850976388, 6714.899276510856, 6752.3922846944015, 6797.762078327235, 6939.548929319679, 802.7993001749562, 846.7459762071354, 864.8486514859875, 868.6525389843987, 873.4322690251388, 3644.0525463379713, 3680.607605056681, 4001.2597669431248, 4179.059711564873, 4272.188284225987, 13202.273874936971, 13926.373313200931, 13936.442542298397, 13945.093568917988, 13953.302334883216, 13175.60473185806, 13608.93195534016, 13811.723765524634, 13815.102018368774, 13821.170729756246, 7530.736424225126, 7792.41556883236, 7817.57003364809, 8011.7195898144455, 8014.599270036475, 6313.842153946188, 6412.9679351602945, 6479.5788273762055, 6528.477721782341, 6558.8360290993105, 12294.20087694297, 12366.62900112998, 12401.13192076582, 12506.687332816753, 12582.937085314516, 12285.69285767863, 12415.44130514111, 12604.747905042032, 12647.936760316139, 12813.103082784115, 8476.576171191538, 8744.519051452231, 8758.598624220094, 8775.91224087751, 8788.16512431318, 9670.226381889292, 9682.854757178507, 9906.752331191778, 9914.851277230702, 9919.702408927744, 7912.406569507425, 7917.406194535548, 8064.596770161351, 8122.309603683753, 8355.749327520183, 7962.402819788424, 7977.401694873024, 8019.1579884111325, 8122.675092996214, 8231.218034286732, 6604.537682362381, 6684.465242780663, 6688.130543029375, 6694.230163531061, 6717.429018533479, 5278.683279003272, 5296.549793267615, 5336.2529245904825, 5450.31871016123, 5545.029619816597, 5327.360716714019, 5343.091674415281, 5385.46145385474, 5459.208414779914, 5523.25436066142], "value": 4877.082420702355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.08722716571566, 398.20557986816294, 399.15578551363865, 399.43878850215424, 402.2317373816012, 5091.261767043786, 5191.922121168185, 5273.129933560963, 5329.493698098684, 5343.492368225017, 5062.443131255559, 5213.452587478308, 5215.4523775003645, 5216.0, 5230.163173892178, 4116.58834116589, 4141.523724771652, 4153.107081977374, 4160.83356665733, 4162.396452514384, 4082.4080508326274, 4116.608922152391, 4149.377593361005, 4161.791910404483, 4175.144095460439, 4101.323281658522, 4103.507579090498, 4107.589241075883, 4109.301418758818, 4109.342505199169, 4113.71204015719, 4120.546739858613, 4121.979390103045, 4123.443335149746, 4140.710150289481, 3709.295233905549, 3711.795851228181, 3725.217704282104, 3737.0657335666083, 3739.4577786221116, 4918.131110178145, 5098.898022039539, 5117.104506711348, 5125.743712814345, 5162.896742065175, 4935.087008903364, 4959.0, 4966.404031516205, 4973.32860063894, 4979.626528010377, 5494.5054945055135, 5529.3364796224305, 5600.5799565032785, 5611.382747897728, 5612.66324020556, 4292.1630282095, 4310.78446077698, 4314.503832059322, 4315.82736690532, 4316.935245971313, 5865.442782935657, 5931.940680593182, 5939.554533410012, 5953.196318496991, 5959.135925290852, 4312.69811113219, 4381.978090109593, 4410.647148228134, 4453.1316393303, 4456.6211871991245, 4451.688381813242, 4466.129104824528, 4486.910261794746, 4492.663050271178, 4508.887277818081, 4908.558229759339, 4929.605631549539, 4930.841252305705, 4934.235193545006, 4936.654434189572, 5411.783528658888, 5530.198121272473, 5536.501714845684, 5566.053770858964, 5572.693501857437, 1471.720373129102, 1506.621441381124, 1517.2565442933103, 1519.8556137166952, 1524.6950609877847, 1097.4238524774557, 1139.8259792413828, 1143.085531574737, 1154.0940361815933, 1163.650904728578, 4865.245886887467, 4871.147549178951, 4884.975575122173, 4898.853034408902, 4903.583195428429, 5529.889402211933, 5719.942800571941, 5727.312722473246, 5769.9711501442225, 5775.16260142277, 4888.560029597354, 4909.95090049095, 4911.9754401227765, 4916.0905232532095, 4918.139325618003, 2972.866221020059, 3011.323407815986, 3012.8041677290908, 3033.3326668132977, 3051.1761824307755, 5287.867803304871, 5298.655587386807, 5313.734313284321, 5331.20031995196, 5361.812336568201, 5838.328592211865, 5855.3851845556455, 5858.765649373977, 5861.281668257094, 5888.0, 5236.659617124875, 5312.973435132877, 5337.226102215157, 5338.626296159232, 5369.677819330853, 5695.544356451391, 5705.258316418839, 5710.771569137354, 5731.707317073204, 5735.827925162252, 5471.562275018068, 5635.492805647511, 5663.0, 5664.26364572603, 5674.659520428788, 5287.418383977836, 5344.4922732340365, 5349.893002140013, 5352.304200453916, 5364.436734142859, 3963.980180099081, 3966.7024973126554, 3979.1842672252697, 3980.601939805996, 3983.8406463741126, 5642.943570564242, 5707.942920570741, 5713.542916566747, 5751.33859606134, 5768.538516918553, 5462.5374625374625, 5515.972420138034, 5539.944600554104, 5550.8057217997175, 5554.639443136844, 5305.196233280703, 5463.7814487420055, 5542.806001789918, 5542.806001790079, 5558.527525160407, 5232.424433312256, 5400.135978243462, 5400.729963501731, 5416.9729151353995, 5441.80280338325, 5553.000919668997, 5565.526930210977, 5566.554675625859, 5566.666000040011, 5574.888502229852, 5194.246834208943, 5388.164834450667, 5431.891362172813, 5433.619646624857, 5446.183072539151], "value": 4271.517080946959, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.0600290632354, 765.0589774577267, 766.0309708219104, 766.4673052228701, 781.7615627233694, 12916.0, 13773.58679239622, 13790.103643263194, 13795.379207935643, 13811.65470863229, 13755.862441375582, 15981.84018159818, 16150.596235094128, 16316.0, 16366.918165409157, 891.8038031633031, 901.8872640919885, 904.0688091266006, 904.2494729374604, 904.8778414913968, 855.7774978505571, 856.8543347630917, 857.6783706110209, 861.6467248428146, 899.7975455522488, 966.6520052780993, 967.1392460709974, 967.7725734452398, 971.0192705367594, 972.5331840716425, 930.7952250504878, 952.8951815300311, 959.8128364968834, 962.4417837654144, 971.0677749360588, 655.9147310849606, 656.0487293424505, 656.3403779201872, 673.1383828699272, 694.2016680817051, 13311.467541298336, 14199.574012779633, 14404.711905761826, 14420.206888621122, 14434.711305773932, 15412.46056388021, 15796.684066318609, 15800.20998950048, 15820.841791582052, 15825.366985320574, 11898.702532436671, 12407.25556466615, 12409.441575129142, 12416.130870839044, 12420.565280215149, 2938.089192350378, 2939.470895238856, 2955.0, 2992.2668946108124, 2997.190758495216, 68942.65528672324, 68947.65526172388, 70838.0, 72043.63978180075, 74421.25578744197, 12633.115681902362, 12641.115121941375, 12834.55079072228, 12861.549845755353, 13049.804252936214, 20673.276435324693, 20876.164953401694, 20892.58214835725, 20933.325333973247, 20969.790302097088, 6342.619442833445, 6376.553641245161, 6392.20097487814, 6394.072859435449, 6403.903941440882, 3121.719045285935, 3149.322895577416, 3159.510275907238, 3193.632732235776, 3199.392115498048, 3776.754510956779, 3824.770513769183, 3843.0, 3843.0968722350226, 3855.845766169378, 692.2385376086265, 699.192432740186, 699.9335063168991, 706.5831159615851, 707.4234498883394, 603.5865432178972, 604.803438882365, 618.0821480102045, 619.829546874604, 621.5586933277333, 9280.679830042489, 9779.853302200472, 9899.505024748878, 10311.793764124675, 10394.740131496621, 600.2676734384132, 603.0562170203617, 612.5712001598898, 620.0791824141147, 625.5746092656946, 4345.587169218919, 4541.6593755468475, 4620.953790462052, 4733.502982186889, 4736.976315118472, 57635.42364576385, 57911.420885790605, 58605.0, 58956.705216473645, 59247.40752592419, 53118.61170672677, 53859.461405385446, 54144.0, 54175.0, 56254.43745562574, 35563.64436355655, 49491.75254123707, 49882.0, 50601.74699126481, 52223.47776522186, 10551.472426378803, 11122.666320010088, 11303.0, 11392.48733806964, 11431.828522572001, 26187.214383568524, 26550.86724566442, 26558.86720566385, 26986.730132698423, 27862.3034424141, 31906.20234494156, 31911.521327179646, 32168.678313217504, 32665.0, 32678.83660581777, 12731.809022864849, 12914.418851151533, 13041.478340866259, 13065.216087034809, 13163.934180329421, 15604.765928511308, 15758.684826303639, 15857.524274271791, 15955.680886381975, 16143.515694529184, 13708.794368084287, 13881.72236555243, 13898.027138100237, 14075.788863166856, 14490.565283041526, 13796.379162937892, 13884.791728124288, 14928.701425971636, 15127.848721513084, 15191.848081519043, 12926.741465170457, 13027.869721302666, 14044.719105618035, 14144.504942326968, 14375.496857609933, 9507.144357007903, 9602.0, 10377.844332335171, 10585.206109541969, 10773.24587278883, 11583.189176757545, 12050.337231452004, 12063.577774777841, 12085.516579336729, 12109.849564291379], "value": 6842.797753774298, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 111.0, 111.0, 110.0, 115.0, 113.0, 112.0, 111.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 123.0, 169.0, 124.0, 124.0, 123.0, 120.0, 144.0, 127.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 162.0, 164.0, 162.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 113.0, 77.0, 75.0, 74.0, 75.0, 100.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 102.0, 83.0, 83.0, 84.0, 102.0, 84.0, 83.0, 114.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 53.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 57.0, 56.0, 57.0, 56.0, 57.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 81.0, 81.0, 81.0, 82.0, 84.0, 81.0, 82.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 149.0, 130.0, 136.0, 129.0, 128.0, 132.0, 129.0, 175.0, 132.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 192.0, 191.0, 188.0, 190.0, 189.0, 186.0, 187.0, 190.0, 190.0], "value": 188.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 72.0, 70.0, 75.0, 74.0, 72.0, 74.0, 71.0], "value": 73.0, "unit": "score"}]}]} 16:47:33 INFO - Return code: 0 16:47:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:47:34 INFO - # TBPL SUCCESS # 16:47:34 INFO - Running post-action listener: _resource_record_post_action 16:47:34 INFO - [mozharness: 2017-05-09 23:47:34.032123Z] Finished run-tests step (success) 16:47:34 INFO - Running post-run listener: _resource_record_post_run 16:47:34 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 375951360; Read time: 12; Write time: 218844 16:47:34 INFO - TinderboxPrint: CPU usage
12.9% 16:47:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:47:34 INFO - TinderboxPrint: I/O write bytes / time
375,951,360 / 218,844 16:47:34 INFO - TinderboxPrint: CPU idle
8,339.0 (87.1%) 16:47:34 INFO - TinderboxPrint: CPU user
1,196.9 (12.5%) 16:47:34 INFO - TinderboxPrint: Swap in / out
0 / 0 16:47:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106332160; Read time: 0; Write time: 75920 16:47:34 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 252178432; Read time: 0; Write time: 136272 16:47:34 INFO - Running post-run listener: _upload_blobber_files 16:47:34 INFO - Blob upload gear active. 16:47:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:47:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:47:34 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:47:34 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:47:35 INFO - (blobuploader) - INFO - Open directory for files ... 16:47:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:47:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:47:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:35 INFO - (blobuploader) - INFO - Done attempting. 16:47:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:47:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:47:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:36 INFO - (blobuploader) - INFO - Done attempting. 16:47:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:47:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:47:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:37 INFO - (blobuploader) - INFO - Done attempting. 16:47:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:47:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:47:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:40 INFO - (blobuploader) - INFO - Done attempting. 16:47:40 INFO - (blobuploader) - INFO - Iteration through files over. 16:47:40 INFO - Return code: 0 16:47:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:47:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:47:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/765e7afbaadb3d43f92940c778d2fa412e9585f07ba7549d2879f295a2184dd9c89cc4a366e21b1a120e6e549f958e46ca7535d7c81f72947087ace5e93866f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82a6bfd79ff1e760f0c7742ca7630078d43ee2ec76c8278505b9c8c433482ae7c9db81d560903dcb0ba0d04c0e84a80a701334d293d00097b24d627451221eae", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2537c37a20d3ba6d3d0ebb325b58b19aab33c704ce2be20f8ad0a8e35d4e6145bd39abf1199515ef30448a51fdba3e2647bcb38a5bd03cfd63abc93b285c99d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/413b8fc8937cace4575165b251f1078ac244a565620108edc055b71cf722f162d0187b8a3351687c91a3130bc8a8d004f5a96ff4d20f5f4e10d648cd540c6cbd"} 16:47:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:47:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:47:40 INFO - Contents: 16:47:40 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/765e7afbaadb3d43f92940c778d2fa412e9585f07ba7549d2879f295a2184dd9c89cc4a366e21b1a120e6e549f958e46ca7535d7c81f72947087ace5e93866f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82a6bfd79ff1e760f0c7742ca7630078d43ee2ec76c8278505b9c8c433482ae7c9db81d560903dcb0ba0d04c0e84a80a701334d293d00097b24d627451221eae", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2537c37a20d3ba6d3d0ebb325b58b19aab33c704ce2be20f8ad0a8e35d4e6145bd39abf1199515ef30448a51fdba3e2647bcb38a5bd03cfd63abc93b285c99d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/413b8fc8937cace4575165b251f1078ac244a565620108edc055b71cf722f162d0187b8a3351687c91a3130bc8a8d004f5a96ff4d20f5f4e10d648cd540c6cbd"} 16:47:40 INFO - Running post-run listener: copy_logs_to_upload_dir 16:47:40 INFO - Copying logs to upload dir... 16:47:40 INFO - mkdir: /builds/slave/test/build/upload/logs 16:47:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.089557 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-09 16:47:40.591686) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 16:47:40.594882) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/765e7afbaadb3d43f92940c778d2fa412e9585f07ba7549d2879f295a2184dd9c89cc4a366e21b1a120e6e549f958e46ca7535d7c81f72947087ace5e93866f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82a6bfd79ff1e760f0c7742ca7630078d43ee2ec76c8278505b9c8c433482ae7c9db81d560903dcb0ba0d04c0e84a80a701334d293d00097b24d627451221eae", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2537c37a20d3ba6d3d0ebb325b58b19aab33c704ce2be20f8ad0a8e35d4e6145bd39abf1199515ef30448a51fdba3e2647bcb38a5bd03cfd63abc93b285c99d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/413b8fc8937cace4575165b251f1078ac244a565620108edc055b71cf722f162d0187b8a3351687c91a3130bc8a8d004f5a96ff4d20f5f4e10d648cd540c6cbd"} build_url:https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/QpYdVLAaRvGC2Gvi6zA-yg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/765e7afbaadb3d43f92940c778d2fa412e9585f07ba7549d2879f295a2184dd9c89cc4a366e21b1a120e6e549f958e46ca7535d7c81f72947087ace5e93866f5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82a6bfd79ff1e760f0c7742ca7630078d43ee2ec76c8278505b9c8c433482ae7c9db81d560903dcb0ba0d04c0e84a80a701334d293d00097b24d627451221eae", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2537c37a20d3ba6d3d0ebb325b58b19aab33c704ce2be20f8ad0a8e35d4e6145bd39abf1199515ef30448a51fdba3e2647bcb38a5bd03cfd63abc93b285c99d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/413b8fc8937cace4575165b251f1078ac244a565620108edc055b71cf722f162d0187b8a3351687c91a3130bc8a8d004f5a96ff4d20f5f4e10d648cd540c6cbd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 16:47:40.622975) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:47:40.623560) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1494372404.934367-440671755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 16:47:40.708018) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 16:47:40.708684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 16:47:40.709202) ========= ========= Total master_lag: 0.18 =========