builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1491048115.43 results: success (0) revision: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:55.429161) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:55.429675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:55.430002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:55.445329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:55.445724) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-01 05:01:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2017-04-01 05:01:56 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121394 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:55.584446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:55.585184) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015311 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:55.639942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:55.640718) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c --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 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c --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=05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-01 05:01:56,786 truncating revision to first 12 chars 2017-04-01 05:01:56,786 Setting DEBUG logging. 2017-04-01 05:01:56,786 attempt 1/10 2017-04-01 05:01:56,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0d6ffde320ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-01 05:01:57,066 unpacking tar archive at: mozilla-central-0d6ffde320ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:56.240770) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:56.241086) ========= script_repo_revision: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:56.241467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:56.241786) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 05:01:56.252307) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-01 05:01:56.252600) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:57 INFO - MultiFileLogger online at 20170401 05:01:57 in /builds/slave/test 05:01:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:01:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:57 INFO - {'append_to_log': False, 05:01:57 INFO - 'base_work_dir': '/builds/slave/test', 05:01:57 INFO - 'blob_upload_branch': 'Firefox', 05:01:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:57 INFO - 'branch': 'Firefox', 05:01:57 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:57 INFO - 'config_files': ('talos/linux_config.py',), 05:01:57 INFO - 'default_actions': ('clobber', 05:01:57 INFO - 'read-buildbot-config', 05:01:57 INFO - 'download-and-extract', 05:01:57 INFO - 'populate-webroot', 05:01:57 INFO - 'create-virtualenv', 05:01:57 INFO - 'install', 05:01:57 INFO - 'run-tests'), 05:01:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:57 INFO - 'download_minidump_stackwalk': True, 05:01:57 INFO - 'download_symbols': 'ondemand', 05:01:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:57 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:57 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:57 INFO - 'gecko_profile': False, 05:01:57 INFO - 'gecko_profile_interval': 0, 05:01:57 INFO - 'installer_path': 'installer.exe', 05:01:57 INFO - 'log_level': 'info', 05:01:57 INFO - 'log_name': 'talos', 05:01:57 INFO - 'log_to_console': True, 05:01:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:57 INFO - 'opt_config_files': (), 05:01:57 INFO - 'pip_index': False, 05:01:57 INFO - 'suite': 'dromaeojs', 05:01:57 INFO - 'system_bits': '32', 05:01:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:57 INFO - 'title': 'talos-linux64-ix-069', 05:01:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:57 INFO - 'use_talos_json': True, 05:01:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:57 INFO - 'work_dir': 'build'} 05:01:57 INFO - [mozharness: 2017-04-01 12:01:57.498780Z] Running clobber step. 05:01:57 INFO - Running pre-action listener: _resource_record_pre_action 05:01:57 INFO - Running main action method: clobber 05:01:57 INFO - rmtree: /builds/slave/test/build 05:01:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:58 INFO - Running post-action listener: _resource_record_post_action 05:01:58 INFO - [mozharness: 2017-04-01 12:01:58.446589Z] Finished clobber step (success) 05:01:58 INFO - [mozharness: 2017-04-01 12:01:58.446687Z] Running read-buildbot-config step. 05:01:58 INFO - Running pre-action listener: _resource_record_pre_action 05:01:58 INFO - Running main action method: read_buildbot_config 05:01:58 INFO - Using buildbot properties: 05:01:58 INFO - { 05:01:58 INFO - "project": "", 05:01:58 INFO - "product": "firefox", 05:01:58 INFO - "who": "archaeopteryx@coole-files.de", 05:01:58 INFO - "installer_path": "public/build/target.tar.bz2", 05:01:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:01:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:01:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:01:58 INFO - "stage_platform": "linux64-pgo", 05:01:58 INFO - "basedir": "/builds/slave/test", 05:01:58 INFO - "buildnumber": 108, 05:01:58 INFO - "platform": "ubuntu64_hw", 05:01:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:01:58 INFO - "slavebuilddir": "test", 05:01:58 INFO - "taskId": "TM3diKwwQb-lT29SIPAqhg", 05:01:58 INFO - "branch": "mozilla-central", 05:01:58 INFO - "script_repo_revision": "production", 05:01:58 INFO - "revision": "0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c", 05:01:58 INFO - "slavename": "talos-linux64-ix-069", 05:01:58 INFO - "repo_path": "mozilla-central" 05:01:58 INFO - } 05:01:58 INFO - Finding installer, test and symbols from parent task. 05:01:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TM3diKwwQb-lT29SIPAqhg'}, attempt #1 05:01:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TM3diKwwQb-lT29SIPAqhg'}, attempt #1 05:01:59 INFO - Task dependencies: cbvSa2WdTp6sFrWD9TuMrw 05:01:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw'}, attempt #1 05:01:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.tar.bz2 05:01:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/test_packages.json 05:01:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.crashreporter-symbols.zip 05:01:59 INFO - Running post-action listener: _resource_record_post_action 05:01:59 INFO - [mozharness: 2017-04-01 12:01:59.825011Z] Finished read-buildbot-config step (success) 05:01:59 INFO - [mozharness: 2017-04-01 12:01:59.825230Z] Running download-and-extract step. 05:01:59 INFO - Running pre-action listener: _resource_record_pre_action 05:01:59 INFO - Running main action method: download_and_extract 05:01:59 INFO - mkdir: /builds/slave/test/build/tests 05:01:59 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')]} 05:01:59 INFO - trying https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.test_packages.json 05:01:59 INFO - Downloading https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:01:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:02:00 INFO - Downloaded 986 bytes. 05:02:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:02:00 INFO - Using the following test package requirements: 05:02:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:02:00 INFO - u'common': [u'target.common.tests.zip'], 05:02:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:02:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:02:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:02:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:02:00 INFO - u'mozbase': [u'target.common.tests.zip'], 05:02:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:02:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:02:00 INFO - u'web-platform': [u'target.common.tests.zip', 05:02:00 INFO - u'target.web-platform.tests.zip'], 05:02:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:02:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:02:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.common.tests.zip 05:02:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:02:00 INFO - Fetch https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.common.tests.zip into memory 05:02:01 INFO - Expected file size: 60361857 05:02:01 INFO - Obtained file size: 60361857 05:02:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:02:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.common.tests.zip 05:02:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:02:11 INFO - Fetch https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.common.tests.zip into memory 05:02:12 INFO - Expected file size: 60361857 05:02:12 INFO - Obtained file size: 60361857 05:02:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.talos.tests.zip 05:02:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:02:23 INFO - Fetch https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.talos.tests.zip into memory 05:02:23 INFO - Expected file size: 14404152 05:02:23 INFO - Obtained file size: 14404152 05:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:24 INFO - trying https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.tar.bz2 05:02:24 INFO - Downloading https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:02:25 INFO - Downloaded 67902994 bytes. 05:02:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.tar.bz2 05:02:25 INFO - mkdir: /builds/slave/test/properties 05:02:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:02:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:02:25 INFO - Contents: 05:02:25 INFO - build_url:https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.tar.bz2 05:02:25 INFO - Running post-action listener: _resource_record_post_action 05:02:25 INFO - Running post-action listener: set_extra_try_arguments 05:02:25 INFO - [mozharness: 2017-04-01 12:02:25.282217Z] Finished download-and-extract step (success) 05:02:25 INFO - [mozharness: 2017-04-01 12:02:25.282313Z] Running populate-webroot step. 05:02:25 INFO - Running pre-action listener: _resource_record_pre_action 05:02:25 INFO - Running main action method: populate_webroot 05:02:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:02:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:02:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:02:25 INFO - '--tppagecycles', 05:02:25 INFO - '7'], 05:02:25 INFO - 'tests': ['tsvgm']}}, 05:02:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:02:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:02:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:02:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:02:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['damp', 'tps']}, 05:02:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'tests': ['damp', 'tps']}, 05:02:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['dromaeo_dom']}, 05:02:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:02:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['basic_compositor_video']}, 05:02:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:02:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['a11yr', 05:02:25 INFO - 'ts_paint', 05:02:25 INFO - 'tpaint', 05:02:25 INFO - 'sessionrestore', 05:02:25 INFO - 'sessionrestore_no_auto_restore', 05:02:25 INFO - 'tabpaint']}, 05:02:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['tsvgx', 05:02:25 INFO - 'tsvgr_opacity', 05:02:25 INFO - 'tart', 05:02:25 INFO - 'tscrollx', 05:02:25 INFO - 'cart', 05:02:25 INFO - 'tsvg_static']}, 05:02:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:02:25 INFO - 'tsvgr_opacity', 05:02:25 INFO - 'tart', 05:02:25 INFO - 'tscrollx', 05:02:25 INFO - 'cart', 05:02:25 INFO - 'tsvg_static']}, 05:02:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--disable-e10s'], 05:02:25 INFO - 'tests': ['tp5o']}, 05:02:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:02:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--disable-e10s', 05:02:25 INFO - '--xperf_path', 05:02:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:25 INFO - 'tests': ['tp5n']}, 05:02:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:02:25 INFO - 'talos_options': ['--xperf_path', 05:02:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:25 INFO - 'tests': ['tp5n']}}, 05:02:25 INFO - 'talos.zip': {'path': '', 05:02:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:02:25 INFO - Running post-action listener: _resource_record_post_action 05:02:25 INFO - [mozharness: 2017-04-01 12:02:25.295505Z] Finished populate-webroot step (success) 05:02:25 INFO - [mozharness: 2017-04-01 12:02:25.295595Z] Running create-virtualenv step. 05:02:25 INFO - Running pre-action listener: _resource_record_pre_action 05:02:25 INFO - Running main action method: create_virtualenv 05:02:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:02:25 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 05:02:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:02:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:02:25 INFO - Using real prefix '/usr' 05:02:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:02:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:27 INFO - Installing pip.................done. 05:02:27 INFO - Return code: 0 05:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:02:28 INFO - Reading from file tmpfile_stdout 05:02:28 INFO - Output received: 05:02:28 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) 05:02:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:28 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 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02:28 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 05:02:28 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 05:02:28 INFO - Using env: {'DISPLAY': ':0', 05:02:28 INFO - 'HOME': '/home/cltbld', 05:02:28 INFO - 'LANG': 'en_US.UTF-8', 05:02:28 INFO - 'LANGUAGE': 'en_US:en', 05:02:28 INFO - 'LOGNAME': 'cltbld', 05:02:28 INFO - 'MAIL': '/var/mail/cltbld', 05:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:28 INFO - 'MOZ_NO_REMOTE': '1', 05:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:28 INFO - 'NO_EM_RESTART': '1', 05:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:28 INFO - 'PWD': '/builds/slave/test', 05:02:28 INFO - 'SHELL': '/bin/bash', 05:02:28 INFO - 'SHLVL': '1', 05:02:28 INFO - 'TERM': 'linux', 05:02:28 INFO - 'TMOUT': '86400', 05:02:28 INFO - 'USER': 'cltbld', 05:02:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:28 INFO - '_': '/tools/buildbot/bin/python'} 05:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:28 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 05:02:28 INFO - Cleaning up... 05:02:28 INFO - Return code: 0 05:02:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:28 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 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02:28 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 05:02:28 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 05:02:28 INFO - Using env: {'DISPLAY': ':0', 05:02:28 INFO - 'HOME': '/home/cltbld', 05:02:28 INFO - 'LANG': 'en_US.UTF-8', 05:02:28 INFO - 'LANGUAGE': 'en_US:en', 05:02:28 INFO - 'LOGNAME': 'cltbld', 05:02:28 INFO - 'MAIL': '/var/mail/cltbld', 05:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:28 INFO - 'MOZ_NO_REMOTE': '1', 05:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:28 INFO - 'NO_EM_RESTART': '1', 05:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:28 INFO - 'PWD': '/builds/slave/test', 05:02:28 INFO - 'SHELL': '/bin/bash', 05:02:28 INFO - 'SHLVL': '1', 05:02:28 INFO - 'TERM': 'linux', 05:02:28 INFO - 'TMOUT': '86400', 05:02:28 INFO - 'USER': 'cltbld', 05:02:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:28 INFO - '_': '/tools/buildbot/bin/python'} 05:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:28 INFO - Downloading/unpacking psutil>=3.1.1 05:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:30 INFO - Installing collected packages: psutil 05:02:30 INFO - Running setup.py install for psutil 05:02:30 INFO - building 'psutil._psutil_linux' extension 05:02:30 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 05:02:30 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 05:02:30 INFO - building 'psutil._psutil_posix' extension 05:02:30 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 05:02:31 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 05:02:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:31 INFO - Successfully installed psutil 05:02:31 INFO - Cleaning up... 05:02:31 INFO - Return code: 0 05:02:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:31 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')]} 05:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:31 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')]} 05:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:31 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 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02:31 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 05:02:31 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 05:02:31 INFO - Using env: {'DISPLAY': ':0', 05:02:31 INFO - 'HOME': '/home/cltbld', 05:02:31 INFO - 'LANG': 'en_US.UTF-8', 05:02:31 INFO - 'LANGUAGE': 'en_US:en', 05:02:31 INFO - 'LOGNAME': 'cltbld', 05:02:31 INFO - 'MAIL': '/var/mail/cltbld', 05:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:31 INFO - 'MOZ_NO_REMOTE': '1', 05:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:31 INFO - 'NO_EM_RESTART': '1', 05:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:31 INFO - 'PWD': '/builds/slave/test', 05:02:31 INFO - 'SHELL': '/bin/bash', 05:02:31 INFO - 'SHLVL': '1', 05:02:31 INFO - 'TERM': 'linux', 05:02:31 INFO - 'TMOUT': '86400', 05:02:31 INFO - 'USER': 'cltbld', 05:02:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:31 INFO - '_': '/tools/buildbot/bin/python'} 05:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:31 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 05:02:31 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 05:02:31 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 05:02:31 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 05:02:31 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 05:02:31 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 05:02:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:33 INFO - Installing collected packages: mozsystemmonitor 05:02:33 INFO - Running setup.py install for mozsystemmonitor 05:02:33 INFO - Successfully installed mozsystemmonitor 05:02:33 INFO - Cleaning up... 05:02:33 INFO - Return code: 0 05:02:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02: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==2.5.1'] in /builds/slave/test/build 05:02: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==2.5.1 05:02:33 INFO - Using env: {'DISPLAY': ':0', 05:02:33 INFO - 'HOME': '/home/cltbld', 05:02:33 INFO - 'LANG': 'en_US.UTF-8', 05:02:33 INFO - 'LANGUAGE': 'en_US:en', 05:02:33 INFO - 'LOGNAME': 'cltbld', 05:02:33 INFO - 'MAIL': '/var/mail/cltbld', 05:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:33 INFO - 'MOZ_NO_REMOTE': '1', 05:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:33 INFO - 'NO_EM_RESTART': '1', 05:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:33 INFO - 'PWD': '/builds/slave/test', 05:02:33 INFO - 'SHELL': '/bin/bash', 05:02:33 INFO - 'SHLVL': '1', 05:02:33 INFO - 'TERM': 'linux', 05:02:33 INFO - 'TMOUT': '86400', 05:02:33 INFO - 'USER': 'cltbld', 05:02:33 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:33 INFO - '_': '/tools/buildbot/bin/python'} 05:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:33 INFO - Downloading/unpacking jsonschema==2.5.1 05:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:36 INFO - warning: no files found matching '*.txt' 05:02:36 INFO - no previously-included directories found matching 'build' 05:02:36 INFO - no previously-included directories found matching 'dist' 05:02:36 INFO - no previously-included directories found matching '.git*' 05:02:36 INFO - Installing collected packages: jsonschema, functools32 05:02:36 INFO - Running setup.py install for functools32 05:02:36 INFO - warning: no files found matching '*.txt' 05:02:36 INFO - no previously-included directories found matching 'build' 05:02:36 INFO - no previously-included directories found matching 'dist' 05:02:36 INFO - no previously-included directories found matching '.git*' 05:02:36 INFO - Successfully installed jsonschema functools32 05:02:36 INFO - Cleaning up... 05:02:36 INFO - Return code: 0 05:02:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:36 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 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02:36 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 05:02:36 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 05:02:36 INFO - Using env: {'DISPLAY': ':0', 05:02:36 INFO - 'HOME': '/home/cltbld', 05:02:36 INFO - 'LANG': 'en_US.UTF-8', 05:02:36 INFO - 'LANGUAGE': 'en_US:en', 05:02:36 INFO - 'LOGNAME': 'cltbld', 05:02:36 INFO - 'MAIL': '/var/mail/cltbld', 05:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:36 INFO - 'MOZ_NO_REMOTE': '1', 05:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:36 INFO - 'NO_EM_RESTART': '1', 05:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:36 INFO - 'PWD': '/builds/slave/test', 05:02:36 INFO - 'SHELL': '/bin/bash', 05:02:36 INFO - 'SHLVL': '1', 05:02:36 INFO - 'TERM': 'linux', 05:02:36 INFO - 'TMOUT': '86400', 05:02:36 INFO - 'USER': 'cltbld', 05:02:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:36 INFO - '_': '/tools/buildbot/bin/python'} 05:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:02:36 INFO - Cleaning up... 05:02:36 INFO - Return code: 0 05:02:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:36 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 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02:36 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 05:02:36 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 05:02:36 INFO - Using env: {'DISPLAY': ':0', 05:02:36 INFO - 'HOME': '/home/cltbld', 05:02:36 INFO - 'LANG': 'en_US.UTF-8', 05:02:36 INFO - 'LANGUAGE': 'en_US:en', 05:02:36 INFO - 'LOGNAME': 'cltbld', 05:02:36 INFO - 'MAIL': '/var/mail/cltbld', 05:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:36 INFO - 'MOZ_NO_REMOTE': '1', 05:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:36 INFO - 'NO_EM_RESTART': '1', 05:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:36 INFO - 'PWD': '/builds/slave/test', 05:02:36 INFO - 'SHELL': '/bin/bash', 05:02:36 INFO - 'SHLVL': '1', 05:02:36 INFO - 'TERM': 'linux', 05:02:36 INFO - 'TMOUT': '86400', 05:02:36 INFO - 'USER': 'cltbld', 05:02:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:36 INFO - '_': '/tools/buildbot/bin/python'} 05:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:36 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:36 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 05:02:36 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 05:02:36 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 05:02:36 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 05:02:36 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 05:02:36 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 05:02:38 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:38 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 05:02:38 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 05:02:38 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 05:02:38 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 05:02:38 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 05:02:38 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 05:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:02:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:39 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 05:02:39 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 05:02:39 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 05:02:39 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 05:02:39 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 05:02:39 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 05:02:39 INFO - Downloading docopt-0.6.1.tar.gz 05:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:39 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:39 INFO - Running setup.py install for blobuploader 05:02:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:02:39 INFO - Running setup.py install for requests 05:02:40 INFO - Running setup.py install for docopt 05:02:40 INFO - Successfully installed blobuploader requests docopt 05:02:40 INFO - Cleaning up... 05:02:40 INFO - Return code: 0 05:02:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:40 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 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02:40 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 05:02:40 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 05:02:40 INFO - Using env: {'DISPLAY': ':0', 05:02:40 INFO - 'HOME': '/home/cltbld', 05:02:40 INFO - 'LANG': 'en_US.UTF-8', 05:02:40 INFO - 'LANGUAGE': 'en_US:en', 05:02:40 INFO - 'LOGNAME': 'cltbld', 05:02:40 INFO - 'MAIL': '/var/mail/cltbld', 05:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:40 INFO - 'MOZ_NO_REMOTE': '1', 05:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:40 INFO - 'NO_EM_RESTART': '1', 05:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:40 INFO - 'PWD': '/builds/slave/test', 05:02:40 INFO - 'SHELL': '/bin/bash', 05:02:40 INFO - 'SHLVL': '1', 05:02:40 INFO - 'TERM': 'linux', 05:02:40 INFO - 'TMOUT': '86400', 05:02:40 INFO - 'USER': 'cltbld', 05:02:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:40 INFO - '_': '/tools/buildbot/bin/python'} 05:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:40 INFO - Running setup.py (path:/tmp/pip-EsbfF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:40 INFO - Running setup.py (path:/tmp/pip-pyQYMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:40 INFO - Running setup.py (path:/tmp/pip-LHoL7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:40 INFO - Running setup.py (path:/tmp/pip-LZxhT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:40 INFO - Running setup.py (path:/tmp/pip-FAxDWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:40 INFO - Running setup.py (path:/tmp/pip-U__vMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:40 INFO - Running setup.py (path:/tmp/pip-zblzmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:40 INFO - Running setup.py (path:/tmp/pip-lyC2_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:41 INFO - Running setup.py (path:/tmp/pip-GQmqur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:41 INFO - Running setup.py (path:/tmp/pip-j9W_2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:41 INFO - Running setup.py (path:/tmp/pip-_N_Plt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:41 INFO - Running setup.py (path:/tmp/pip-z27dAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:41 INFO - Running setup.py (path:/tmp/pip-QB2LEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:41 INFO - Running setup.py (path:/tmp/pip-aTjmh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:41 INFO - Running setup.py (path:/tmp/pip-gGrJco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:41 INFO - Running setup.py (path:/tmp/pip-mvedIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:41 INFO - Running setup.py (path:/tmp/pip-GBgsbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:41 INFO - Running setup.py install for manifestparser 05:02:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:41 INFO - Running setup.py install for mozcrash 05:02:41 INFO - Running setup.py install for mozdebug 05:02:41 INFO - Running setup.py install for mozdevice 05:02:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Running setup.py install for mozfile 05:02:42 INFO - Running setup.py install for mozhttpd 05:02:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Running setup.py install for mozinfo 05:02:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Running setup.py install for mozInstall 05:02:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Running setup.py install for mozleak 05:02:42 INFO - Running setup.py install for mozlog 05:02:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Running setup.py install for moznetwork 05:02:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Running setup.py install for mozprocess 05:02:42 INFO - Running setup.py install for mozprofile 05:02:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:42 INFO - Running setup.py install for mozrunner 05:02:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:43 INFO - Running setup.py install for mozscreenshot 05:02:43 INFO - Running setup.py install for moztest 05:02:43 INFO - Running setup.py install for mozversion 05:02:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:43 INFO - Cleaning up... 05:02:43 INFO - Return code: 0 05:02:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:43 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 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02:43 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 05:02:43 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 05:02:43 INFO - Using env: {'DISPLAY': ':0', 05:02:43 INFO - 'HOME': '/home/cltbld', 05:02:43 INFO - 'LANG': 'en_US.UTF-8', 05:02:43 INFO - 'LANGUAGE': 'en_US:en', 05:02:43 INFO - 'LOGNAME': 'cltbld', 05:02:43 INFO - 'MAIL': '/var/mail/cltbld', 05:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:43 INFO - 'MOZ_NO_REMOTE': '1', 05:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:43 INFO - 'NO_EM_RESTART': '1', 05:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:43 INFO - 'PWD': '/builds/slave/test', 05:02:43 INFO - 'SHELL': '/bin/bash', 05:02:43 INFO - 'SHLVL': '1', 05:02:43 INFO - 'TERM': 'linux', 05:02:43 INFO - 'TMOUT': '86400', 05:02:43 INFO - 'USER': 'cltbld', 05:02:43 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:43 INFO - '_': '/tools/buildbot/bin/python'} 05:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:43 INFO - Running setup.py (path:/tmp/pip-e8LTH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:43 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)) 05:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:43 INFO - Running setup.py (path:/tmp/pip-2WU1l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:43 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)) 05:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:43 INFO - Running setup.py (path:/tmp/pip-h17gWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:43 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)) 05:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:43 INFO - Running setup.py (path:/tmp/pip-gOiACt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:43 INFO - Running setup.py (path:/tmp/pip-JUaXTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:44 INFO - Running setup.py (path:/tmp/pip-9KcpYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:44 INFO - Running setup.py (path:/tmp/pip-edS1F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:44 INFO - Running setup.py (path:/tmp/pip-2p2NfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:44 INFO - Running setup.py (path:/tmp/pip-tosX_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:44 INFO - Running setup.py (path:/tmp/pip-lTVTAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:44 INFO - Running setup.py (path:/tmp/pip-NdQB1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:44 INFO - Running setup.py (path:/tmp/pip-RAHCPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:44 INFO - Running setup.py (path:/tmp/pip-T5459N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:44 INFO - Running setup.py (path:/tmp/pip-SHw4T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:44 INFO - Running setup.py (path:/tmp/pip-xkQ7uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:44 INFO - Running setup.py (path:/tmp/pip-gpf1BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:44 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)) 05:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:44 INFO - Running setup.py (path:/tmp/pip-Yqm9jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:44 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)) 05:02:44 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)) 05:02:44 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)) 05:02:44 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)) 05:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:44 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 05:02:44 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 05:02:44 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 05:02:44 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 05:02:44 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 05:02:44 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 05:02:47 INFO - Downloading blessings-1.6.tar.gz 05:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:47 INFO - Installing collected packages: blessings 05:02:47 INFO - Running setup.py install for blessings 05:02:47 INFO - Successfully installed blessings 05:02:47 INFO - Cleaning up... 05:02:47 INFO - Return code: 0 05:02:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:47 INFO - Reading from file tmpfile_stdout 05:02:47 INFO - Current package versions: 05:02:47 INFO - argparse == 1.2.1 05:02:47 INFO - blessings == 1.6 05:02:47 INFO - blobuploader == 1.2.4 05:02:47 INFO - docopt == 0.6.1 05:02:47 INFO - functools32 == 3.2.3-2 05:02:47 INFO - jsonschema == 2.5.1 05:02:47 INFO - manifestparser == 1.1 05:02:47 INFO - mozInstall == 1.12 05:02:47 INFO - mozcrash == 1.0 05:02:47 INFO - mozdebug == 0.1 05:02:47 INFO - mozdevice == 0.49 05:02:47 INFO - mozfile == 1.2 05:02:47 INFO - mozhttpd == 0.7 05:02:47 INFO - mozinfo == 0.9 05:02:47 INFO - mozleak == 0.1 05:02:47 INFO - mozlog == 3.4 05:02:47 INFO - moznetwork == 0.27 05:02:47 INFO - mozprocess == 0.25 05:02:47 INFO - mozprofile == 0.28 05:02:47 INFO - mozrunner == 6.13 05:02:47 INFO - mozscreenshot == 0.1 05:02:47 INFO - mozsystemmonitor == 0.3 05:02:47 INFO - moztest == 0.8 05:02:47 INFO - mozversion == 1.4 05:02:47 INFO - psutil == 3.1.1 05:02:47 INFO - requests == 1.2.3 05:02:47 INFO - wsgiref == 0.1.2 05:02:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:47 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 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02:47 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 05:02:47 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 05:02:47 INFO - Using env: {'DISPLAY': ':0', 05:02:47 INFO - 'HOME': '/home/cltbld', 05:02:47 INFO - 'LANG': 'en_US.UTF-8', 05:02:47 INFO - 'LANGUAGE': 'en_US:en', 05:02:47 INFO - 'LOGNAME': 'cltbld', 05:02:47 INFO - 'MAIL': '/var/mail/cltbld', 05:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:47 INFO - 'MOZ_NO_REMOTE': '1', 05:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:47 INFO - 'NO_EM_RESTART': '1', 05:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:47 INFO - 'PWD': '/builds/slave/test', 05:02:47 INFO - 'SHELL': '/bin/bash', 05:02:47 INFO - 'SHLVL': '1', 05:02:47 INFO - 'TERM': 'linux', 05:02:47 INFO - 'TMOUT': '86400', 05:02:47 INFO - 'USER': 'cltbld', 05:02:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:47 INFO - '_': '/tools/buildbot/bin/python'} 05:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:47 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)) 05:02:47 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)) 05:02:47 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)) 05:02:47 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)) 05:02:47 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)) 05:02:47 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)) 05:02:47 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)) 05:02:47 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)) 05:02:47 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)) 05:02:47 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)) 05:02:47 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)) 05:02:47 INFO - Cleaning up... 05:02:47 INFO - Return code: 0 05:02:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:47 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 0x16241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1661a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c2310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', '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 05:02:47 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 05:02:47 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 05:02:47 INFO - Using env: {'DISPLAY': ':0', 05:02:47 INFO - 'HOME': '/home/cltbld', 05:02:47 INFO - 'LANG': 'en_US.UTF-8', 05:02:47 INFO - 'LANGUAGE': 'en_US:en', 05:02:47 INFO - 'LOGNAME': 'cltbld', 05:02:47 INFO - 'MAIL': '/var/mail/cltbld', 05:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:47 INFO - 'MOZ_NO_REMOTE': '1', 05:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:47 INFO - 'NO_EM_RESTART': '1', 05:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:47 INFO - 'PWD': '/builds/slave/test', 05:02:47 INFO - 'SHELL': '/bin/bash', 05:02:47 INFO - 'SHLVL': '1', 05:02:47 INFO - 'TERM': 'linux', 05:02:47 INFO - 'TMOUT': '86400', 05:02:47 INFO - 'USER': 'cltbld', 05:02:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:47 INFO - '_': '/tools/buildbot/bin/python'} 05:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:02:48 INFO - Cleaning up... 05:02:48 INFO - Return code: 0 05:02:48 INFO - Running post-action listener: _resource_record_post_action 05:02:48 INFO - Running post-action listener: _start_resource_monitoring 05:02:48 INFO - Starting resource monitoring. 05:02:48 INFO - [mozharness: 2017-04-01 12:02:48.053127Z] Finished create-virtualenv step (success) 05:02:48 INFO - [mozharness: 2017-04-01 12:02:48.053642Z] Running install step. 05:02:48 INFO - Running pre-action listener: _resource_record_pre_action 05:02:48 INFO - Running main action method: install 05:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:48 INFO - Reading from file tmpfile_stdout 05:02:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:48 INFO - Reading from file tmpfile_stdout 05:02:48 INFO - Output received: 05:02:48 INFO - Usage: mozinstall [options] installer 05:02:48 INFO - Options: 05:02:48 INFO - -h, --help show this help message and exit 05:02:48 INFO - -d DEST, --destination=DEST 05:02:48 INFO - Directory to install application into. [default: 05:02:48 INFO - "/builds/slave/test"] 05:02:48 INFO - --app=APP Application being installed. [default: firefox] 05:02:48 INFO - mkdir: /builds/slave/test/build/application 05:02:48 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'] 05:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:03:05 INFO - Reading from file tmpfile_stdout 05:03:05 INFO - Output received: 05:03:05 INFO - /builds/slave/test/build/application/firefox/firefox 05:03:05 INFO - Running post-action listener: _resource_record_post_action 05:03:05 INFO - [mozharness: 2017-04-01 12:03:05.248354Z] Finished install step (success) 05:03:05 INFO - [mozharness: 2017-04-01 12:03:05.248629Z] Running run-tests step. 05:03:05 INFO - Running pre-action listener: _resource_record_pre_action 05:03:05 INFO - Running main action method: run_tests 05:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:03:05 INFO - Python 2.7.3 05:03:05 INFO - Return code: 0 05:03:05 INFO - grabbing minidump binary from tooltool 05:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:05 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 0x18bf400>, '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 0x18c03b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c0840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:03:05 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 05:03:05 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 05:03:05 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 05:03:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:03:05 INFO - Return code: 0 05:03:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:03:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:03:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:03:05 INFO - ENV: RUST_BACKTRACE is now 1 05:03:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:03:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 05:03:05 INFO - Using env: {'DISPLAY': ':0', 05:03:05 INFO - 'HOME': '/home/cltbld', 05:03:05 INFO - 'LANG': 'en_US.UTF-8', 05:03:05 INFO - 'LANGUAGE': 'en_US:en', 05:03:05 INFO - 'LOGNAME': 'cltbld', 05:03:05 INFO - 'MAIL': '/var/mail/cltbld', 05:03:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:03:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:05 INFO - 'MOZ_NO_REMOTE': '1', 05:03:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:05 INFO - 'NO_EM_RESTART': '1', 05:03:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:05 INFO - 'PWD': '/builds/slave/test', 05:03:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:03:05 INFO - 'RUST_BACKTRACE': '1', 05:03:05 INFO - 'SHELL': '/bin/bash', 05:03:05 INFO - 'SHLVL': '1', 05:03:05 INFO - 'TERM': 'linux', 05:03:05 INFO - 'TMOUT': '86400', 05:03:05 INFO - 'USER': 'cltbld', 05:03:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977', 05:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:05 INFO - '_': '/tools/buildbot/bin/python'} 05:03:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:03:05 INFO - mozversion application_buildid: 20170401110736 05:03:05 INFO - mozversion application_changeset: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c 05:03:05 INFO - mozversion application_display_name: Nightly 05:03:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:03:05 INFO - mozversion application_name: Firefox 05:03:05 INFO - mozversion application_remotingname: firefox 05:03:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:03:05 INFO - mozversion application_vendor: Mozilla 05:03:05 INFO - mozversion application_version: 55.0a1 05:03:05 INFO - mozversion platform_buildid: 20170401110736 05:03:05 INFO - mozversion platform_changeset: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c 05:03:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:03:05 INFO - mozversion platform_version: 55.0a1 05:03:05 INFO - using testdate: 1491048185 05:03:05 INFO - actual date: 1491048185 05:03:05 INFO - starting webserver on 'localhost:40509' 05:03:05 INFO - SUITE-START | Running 2 tests 05:03:05 INFO - TEST-START | dromaeo_css 05:03:05 INFO - operating with platform_type : linux_ 05:03:05 INFO - Initialising browser for dromaeo_css test... 05:03:05 INFO - TEST-INFO | started process 26595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9CAz8d/profile http://localhost:40509/getInfo.html) 05:03:09 INFO - PID 26595 | __metrics Screen width/height:1600/1200 05:03:09 INFO - PID 26595 | colorDepth:24 05:03:09 INFO - PID 26595 | Browser inner width/height: 1024/697 05:03:09 INFO - PID 26595 | __metrics 05:03:10 INFO - PID 26595 | 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" 05:03:10 INFO - PID 26595 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:03:11 INFO - TEST-INFO | 26595: exit 0 05:03:11 INFO - Browser initialized. 05:03:11 INFO - Running cycle 1/1 for dromaeo_css test... 05:03:11 INFO - TEST-INFO | started process 26686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9CAz8d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:23 INFO - PID 26686 | RSS: Main: 144302080 05:03:23 INFO - PID 26686 | 05:06:26 INFO - PID 26686 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40509/tests/dromaeo/cssquery-ext.html) 05:06:27 INFO - PID 26686 | RSS: Main: 280903680 05:06:27 INFO - PID 26686 | 05:08:13 INFO - PID 26686 | ************************* 05:08:13 INFO - PID 26686 | A coding exception was thrown and uncaught in a Task. 05:08:13 INFO - PID 26686 | 05:08:13 ERROR - PID 26686 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:08:13 INFO - PID 26686 | Full stack: 05:08:13 INFO - PID 26686 | ************************* 05:08:13 INFO - PID 26686 | ************************* 05:08:13 INFO - PID 26686 | A coding exception was thrown and uncaught in a Task. 05:08:13 INFO - PID 26686 | 05:08:13 ERROR - PID 26686 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:08:13 INFO - PID 26686 | Full stack: 05:08:13 INFO - PID 26686 | ************************* 05:08:13 INFO - PID 26686 | ************************* 05:08:13 INFO - PID 26686 | A coding exception was thrown and uncaught in a Task. 05:08:13 INFO - PID 26686 | 05:08:13 ERROR - PID 26686 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:08:13 INFO - PID 26686 | Full stack: 05:08:13 INFO - PID 26686 | ************************* 05:08:13 INFO - PID 26686 | ************************* 05:08:13 INFO - PID 26686 | A coding exception was thrown and uncaught in a Task. 05:08:13 INFO - PID 26686 | 05:08:13 ERROR - PID 26686 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:08:13 INFO - PID 26686 | Full stack: 05:08:13 INFO - PID 26686 | ************************* 05:09:29 INFO - PID 26686 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-ext.html (next: http://localhost:40509/tests/dromaeo/cssquery-jquery.html) 05:09:30 INFO - PID 26686 | RSS: Main: 238518272 05:09:30 INFO - PID 26686 | 05:12:32 INFO - PID 26686 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40509/tests/dromaeo/cssquery-mootools.html) 05:12:32 INFO - PID 26686 | RSS: Main: 209371136 05:12:32 INFO - PID 26686 | 05:15:34 INFO - PID 26686 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40509/tests/dromaeo/cssquery-prototype.html) 05:15:35 INFO - PID 26686 | RSS: Main: 176705536 05:15:35 INFO - PID 26686 | 05:18:38 INFO - PID 26686 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40509/tests/dromaeo/cssquery-yui.html) 05:18:38 INFO - PID 26686 | RSS: Main: 183783424 05:18:38 INFO - PID 26686 | 05:21:41 INFO - PID 26686 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-yui.html (next: http://localhost:40509/tests/dromaeo/cssquery-dojo.html) 05:21:41 INFO - PID 26686 | RSS: Main: 266797056 05:21:41 INFO - PID 26686 | 05:21:41 INFO - PID 26686 | __start_tp_report 05:21:41 INFO - PID 26686 | _x_x_mozilla_page_load 05:21:41 INFO - PID 26686 | _x_x_mozilla_page_load_details 05:21:41 INFO - PID 26686 | |i|pagename|runs| 05:21:41 INFO - PID 26686 | |0;dojo.html;3311.652276510965;3328.550645662835;3356.379069872074;3366.680165384289;3373.207296285374;5701.543876489881;5815.621984571;5862.179294898712;5867.119932010195;5867.794627188049;5799.101139323411;5852.092925596528;5853.560982926277;5923.28920529536;5985.042393217086;5195.999999999991;5207.661502002376;5245.6852588844795;5275.050490911634;5291.68249905005;5158.638895277332;5203.349581302337;5257.474252574731;5268.657537260085;5276.762545685453;5216.4522725114075;5232.398274198478;5269.894602107975;5286.814961476349;5331.573474122061;5092.79628814847;5149.3305870237;5155.639105262633;5166.741662916839;5204.29741984831;5162.406323272797;5191.325127733408;5214.06146893559;5238.947610523884;5255.054090263751;5809.796657116981;5855.209546711182;5857.7949771757785;5877.5591830612875;5881.206037185011;6111.682900513629;6199.287081985584;6325.588836725598;6376.553641245115;6376.776812811576;6414.262359828633;6425.485961123099;6433.646149461778;6433.903491447632;6442.420182183626;5920.141579471038;5922.775356881976;5924.081767326072;5925.20009798676;5964.821055368346;6220;6300.527460440485;6434.099226108348;6475.902861457082;6525.836854078591;6054.727537260834;6123.2652081750475;6172.105044768484;6201.286852011986;6233.065040243909;6183.690815459209;6337.841553961188;6344.904826427607;6382;6391.137196478416;6211.16149319845;6329;6329.430351268408;6330.1454303668415;6338.207724034496;6135.877282454415;6141.100401245241;6327.651979141191;6329.177206963065;6346.587471814318;4771.021940502258;4835.709857408567;4871.975640121847;4902.730349830794;4903.558679718771;4319.9784001080425;4332.068605249887;4336.609705126553;4339.370791235253;4366.6506679465565;6003.789867354709;6019.067044608093;6024.0662697282;6027.306859711101;6028.065649824284;6129.8784197560135;6201.255849298113;6374.458171055419;6400.263969643457;6436.195475565554;5965.135055417027;6005.489533389711;6013.609115407485;6016.157737916607;6049.848753781191;5420.997115533639;5453.881954199459;5462.562994960473;5465.07093794056;5473.698946557898;6365.522585806083;6453.580517266362;6550.082988381726;6627.768028118992;6701.9611960145285;6409.294977552372;6422.32565580626;6426.807195784134;6429.4534964526665;6429.807105786834;6638.668066596748;6643.568168069253;6643.9335606645245;6643.966780166068;6645.501587380869;6099;6105.3384459501285;6233.657148856856;6245.219347581552;6324.683765811783;6340.556161068866;6391.872162556816;6408.23101227837;6410.166678331787;6416.844967905635;6142.201513803177;6193.535484838565;6212.627242365473;6218.409251121137;6227.314995350417;5979.701014949148;5979.880402392015;6056.273247210187;6140.84169297792;6217.844553886189;6148.877022459616;6192.721327540181;6197.380261973766;6198.0702894566175;6201.193844800147;6210.347913469202;6268.059791031382;6271.278802937721;6278.466330361788;6283.96858015707;5905.143754155709;5906.970465147647;6053.878922421439;6112.847178820387;6114.052321890114 05:21:41 INFO - PID 26686 | |1;ext.html;727.6543641770156;793.9642716077777;805.0982899152949;1076.9983914959084;1081.0594782539192;31560.842195789017;40338;40806.59193408072;40877.182456350856;41094.58905410945;43108.56891431085;43552;43581.56418435815;43607.78196109023;43649.563504364945;7927.92072079279;8107.432479726422;8125.674973001072;8125.674973001072;8129.268365847072;6111.847203819895;6315.652639104847;8108.797280068016;8367.623456944422;8374.874376884352;8314;8391.832163356728;8391.916080839204;8403.327733781283;8404.747857564284;8315.958420207891;8352.331813454908;8371.58142092899;8387.496750195009;8388.748337549883;8199.836003279901;8263.091059983397;8266;8270.669173233064;8279.172082791672;40712.796436017925;40976.180476390306;41030.38454423186;41032.794836025925;41077.178456431;2791.8324900506036;2817.971820281812;2824.364517983458;2838.247864315958;2860.0990687933236;28340.574891376647;28545.143645690456;28906.132816015343;29235.707642923724;29391;3662.212624285791;3667.9266414671824;3695.667389934919;3716.8513259469587;3760.9435858462143;209521;209790.9510452453;210287;210377;210419;49411.258831117564;49731.75134124306;49813.750931245835;49825.750871245415;49855.501444985086;52030;52345;52488;52510.73744631252;52547;14678.779818302733;14820.481283155254;14833.92583037078;14840.480583179537;14841.257937103102;10010.249231307682;11876.10929180315;11885.940570297093;11917.463714132884;11933.761324773455;12522.248665080124;13408.865911340958;13554.661133471742;13598.592042238748;13764.93117534406;5248.606354523426;5276.92084618731;5294.311739473844;5304.257403963371;5311.601629877775;1000.7348052766023;1004.4525733475274;1007.471077684207;1014.8629934958834;1015.9847602285971;25582.872085639454;25602.103926362488;25778.355541111247;25891.74108258931;25930.092446764273;1102.9007389334838;1108.9001989820954;1124.1007194244735;1125.1224045244721;1131.6095946898306;12983.675408114872;13306.600801975956;13354.399052042681;13521.729565408637;13559.45762169522;304195;304435;304783;307559;308430;54261.45738542643;54327;54392;54411.18383224255;54486.182707259424;1383.8685324894118;1464.9047811892406;1467.1123969998212;1470.3897882378692;1486.2940103450774;23595.646065309378;24578.877105615073;25487.960963123278;25693.871530642977;25764.742352576235;41335.793321033205;41353.586464134976;41377.58622413858;41425;41475.58524414838;308678;309180;309483;309900;310049;28048;28697.713022869502;34380.656193437746;34829.65170348366;35055;41392.37911431391;41634.1673166541;41702.79148604238;42265.366019510344;42690.78654606707;31181.53227701541;31462.528062079546;31466.528002080446;31490.842545787124;32314.192145196557;31328.686713132578;31653.20866978344;31892.202694932814;31892.84053579717;31959;36234;36298.637013630585;37173.25653486861;37272;37377.4393384094;30277.394452111275;30432.543511847784;30568.84715576408;30679.53980690336;31542.211444714067;23890.64164037506;24619.384515387257;24752.752472475044;24919.252422427355;25258.621120683572 05:21:41 INFO - PID 26686 | |2;jquery.html;436.8623883476707;442.1576896013095;443.1624230204913;443.6184881002337;454.7998880492583;19776.90111549442;21084.367468975935;21585.244516441926;21660.675089873665;21729.78270217297;21246.89376553119;21932.561348773015;22265;22419;22652.66021009682;5953.523718102563;6127.958247098004;6129.938700612981;6132.816015519519;6136.570440069197;5729.197912292261;5975.372585878486;5995.640261584319;6017.157597936292;6030.33666296707;5843.415658434165;5974.4921681657115;5980.940190598104;5982.79060232892;5991.370906054867;5889.1755154278435;5977.910331345011;6024.48791852693;6033.245844269488;6036.124761909498;5388.084025715638;5406.783728650849;5461.098918678414;5461.590380721462;5467.507924286793;25072.49855002908;25222.873885630637;25261.368465788502;25330.620040699403;25338.239852804447;1863.4595967169505;1865.4310435317223;1871.3076161820213;1882.9340973065878;1895.1282410091374;15401.691966160726;15667.92166039174;15873.761893571605;16017.519474415787;16383.918080409521;2016.1632922337212;2091.2471510256296;2103.852730308879;2128.680697895328;2134.893255337227;77127.43088536765;91159;95749;100735.49632251865;105530.28106346203;11990.724081404154;12136.696582585506;12220.327881966577;12335.814962775565;12515;17195.742063869053;17350.30598776035;17385.652286954442;17414;17415.73876391855;8866.33502487316;9003.549822508849;9018.729438116867;9286.396384235004;9354;8407.201315874981;8434.451760635538;8454.15458454162;8683.348748843862;8683.826323473495;7679.808004799925;7809.882851757228;7810.648520816577;7843.254890785366;8149.511029338259;2058.5779915117364;2126.6809978503347;2166.804987551128;2225.8775767332627;2285.8399912006334;984.699666601679;989.0702739424918;999.5701848205196;1011.079917275276;1015.6292953072224;20530;21234.256801011892;23574.882125589604;25722.09972650948;25828.8708556456;1024.6106479537877;1028.496036941908;1040.3445829127752;1055.3456856748865;1066.5360568152878;10743.731406714895;11438.313701177956;11507.769844603228;11514.366709830872;11521.020713239468;664718;668475;677029;677889;691575;92583.81814910291;98947.50526247466;112784.43607781909;113857;117536;1083.6044843632017;1108.2020944919807;1129.8700649425257;1144.7824913266452;1154.2958795134962;20100.899495502428;20329.49176270605;20544.69182962227;20910;20989.89505052465;48156.27765583589;48699.75650121726;49789.25316120189;49845.25232121449;51601;64789;65389;65709.67145164244;67390;67563;9025.962014368431;9141.497217653094;9371.671991480265;9447.574859131493;10024.498775061364;14352.354144063751;14698.41206351734;14708;14758.188299643623;14798.48205312809;12619.432125554189;12766.744665106831;12876.420561074587;12985.675358116123;13033.804492932803;11649.76700465969;11775.705607359541;11864.644060678194;11987.100967427652;12651.620451386472;12689.555865544662;12942.288174150135;13044.217346959213;13090.80363794563;13109.016823738068;9408.200302974325;9597.952010239904;9606.087421694929;9630.711078667651;9794.265430092913;12482.375881206084;12704.618861434172;12718.173318734252;12772.489100435878;12831.230126192459 05:21:41 INFO - PID 26686 | |3;mootools.html;1164.5167255588929;1180.415694231355;1185.816198489234;1193.9343336116522;1201.2071635627212;10588.894111058888;11080.390578518189;11080.556777728902;11095.611653592126;11097.33415995041;10820.458977051156;10842.566297348096;11082.224244302903;11164.832527512073;11165.330080195174;2281.7147856517895;2316.9884150579223;2321.466062805556;2321.6169332060276;2323.546908352872;1926.2872737087298;2214.6677998300224;2300.781425764558;2348.6477028445697;2357.281029286067;1946.4160751774411;2273.3407311879537;2335.2177020698086;2342.730585982617;2343.1798870395396;2202.977970220293;2267.4784799496124;2275.590393729128;2276.2602154299834;2316.6061769499056;2285.325828880484;2289.072925465189;2291.942701432461;2299.2067736630834;2304.9308520744403;10790.352578845215;11113.83329250062;11122.666320010332;11124.888751112467;11125.109991200685;6001.579889407743;6210.96894515529;6227.1282020517165;6227.813165604994;6243.594166379216;3555.6266592007983;3692.7968961707097;3713.721470889694;3744.981275093607;3793.5447746270625;1418.4538952503258;1418.772996320594;1438.9568312950628;1441.8630230128122;1460.7005563859384;16509.33962641493;16589.336426542923;16720.08039557824;16724.74912876308;16761.832381676148;4877.853664390074;5001.1498045331655;5048.924266136011;5051.116054690415;5087.592992560586;12136.575219867438;12141.757164856654;12156.5137394505;12177.69555761113;12182.208156469978;5974.3428222895445;5984.640921544721;5994.490468310155;5996.130561068708;5996.67018313997;5342.412334643186;5400.297961265089;5406.432324605859;5416.295881535375;5557.3331200256225;4081.591840815954;4144.191882582928;4152.231837110145;4157.937630935538;4238.554951730024;1024.1499555369026;1051.321897376188;1150.6893138852631;1161.355447726503;1181.8345431639577;809.817790997021;836.9414141010071;850.6342272822621;852.2031900173358;861.3539845116163;6715.7985260442265;6845.383915447534;6895.103636527219;7004.124484439445;7092.4326053915565;912.762681702762;958.7986522830283;972.9416235025922;984.6849008317413;994.145035269682;4151.605597468236;4279.935800962988;4320.956790432118;4331.436913201263;4389.736615803062;14163.50427735045;14687.023205257427;14764.26178691061;14798.63003424923;14850.851491484947;14290.499832505813;14345.78481322781;14528.564143075513;14533.709325813425;14556.126632402089;10380.792384152426;10558.736031599117;10567.894321056845;10597.41714205726;10630.362178269328;6672.4328432081875;6679.432248258952;6719.193696756421;6748.907838570059;6830.897536537055;12679.746405072032;12890.355482225663;13217;13231.40458679381;13239.867601323864;13189.80215296752;13265;13313.534026309033;13346.733065338445;13409.865901340861;8649.524276164871;8704.303655707656;8740.475571465733;8767.386282960131;8820.691275805317;10226;10422.374657520573;10424.061834434937;10433.061024507831;10439.686809395731;8332;8390.664373424994;8465.61904714277;8501.95749021251;8748.99386570527;8808.119188081397;8819.250363718898;8886.822263554563;8896.199342059246;8972.596233169392;7746;7877.330426913776;7887.802804929923;7893.644785984529;7896.210378962058;5924.555658325729;5941.287045554561;5992.43071908168;6022.915875142517;6169.2288463942;5557.36090349615;5565.3599836019375;5891.941080589139;6104.786332478342;6408.1349017881985 05:21:41 INFO - PID 26686 | |4;prototype.html;411.45687692246236;415.68200326750025;419.8005947175091;429.2788115965177;430.13972055888223;5796.942030579693;5974.163617093605;5993.10103484477;6011.458968692817;6038.577299589019;5816.418358164182;5885.970570147154;5898.941010589903;5899.557533185018;5901.321348044976;4398.296272596385;4514.119746649405;4519.389882365871;4521.095780843844;4526.230540808054;4537.2286711259;4537.568930951555;4542.818287268506;4544.84093056743;4553.544645535453;4494.438195225597;4500.414946057024;4506.87328167958;4512.796924138422;4518.954810451903;4444.155610434007;4505.076459325846;4518.43519560055;4519.045834894484;4524.954750452486;3950.407438884162;3958.7030972676876;3959.1289916218675;3984.4620976168135;3995.3407687731487;5703.857403564903;5727.1695604137585;5730.025895597759;5741.167530708066;5777.59556831022;5046.21783623539;5292.52367286946;5307.389650190239;5315.176147697113;5321.175217841241;6209.875802483925;6231.158793562857;6247.687615619247;6257.2491301044165;6274.403931626488;4437.844675436377;4446.533114023014;4467.994701192239;4470.994026344079;4481.484629267643;6362.840928976766;6500.674966251716;6523;6592.208934927839;6597.340265973412;4598.609118224921;4602.355670206174;4602.355670206174;4610.76946152691;4611.792469338888;4662.207424737802;4668.85993420198;4675.22858728306;4684.1334353144775;4686.695364801345;5123.590112790967;5269.473052694777;5313.787448502017;5319.148936170194;5328.934213157384;6235.441139715072;6245.781397651061;6257.2804127525915;6291.496680265568;6292.307846136921;1566.6631674190103;1592.235726851118;1597.18543542794;1604.3662753212416;1610.0581160021284;1040.7554224757175;1065.4938904020682;1086.3373342261214;1090.9672709818717;1099.5162128663362;5898.292204935436;5933.851653708605;5936.7031648417405;5953.107033944856;5953.434423729739;6201.96899015502;6431.871362572816;6433.710483028275;6448.451881590024;6451.354904499322;5910.556708246899;5926.407359264039;5933.317668468095;5935.39744269045;5991.7603295867675;3378.290558982641;3384.509246159293;3385.7799243049617;3393.355262500117;3396.3207358527898;6415.743370265231;6589.505787065989;6610.239822420387;6613.66931653425;6665.533752511602;6198.411150940653;6501.577397469244;6518.240075179675;6524.543281970311;6524.706388212542;6460.483161347081;6533.738650454024;6594.604323740591;6623.052741529973;6635.402813746882;6113.969430152821;6287.088372186099;6346;6426.196725409324;6432.292447830829;6273.9372606273355;6333.334999824952;6335.746570137143;6352.841178970378;6395.360463953753;6413.903791443226;6620.404163625297;6627.403533681992;6649.202095748347;6709.530332876847;4528.573499347826;4548.996882743165;4573.908521829611;4576.977115114403;4578.954210457853;6424.453921416732;6467.482601391972;6472.644004579794;6515.315891831289;6527.51043671717;6041.486473649613;6269.777393408242;6287.717052732546;6289.905651415141;6377.202849643794;6262.4990000800735;6269.404406581368;6287.402696743802;6292.402221788922;6294.244690637152;6152.876942461036;6256;6281.96859015702;6333.334999824952;6368.840778980562;6323.23767358421;6326.936730632819;6339.90490142639;6345.524085693683;6350.110984462087;6186.752529898754;6196.194494715658;6224.51427200769;6225.533085018732;6233.812985610439 05:21:41 INFO - PID 26686 | |5;yui.html;696.5368030259878;697.6337422853005;700.0689083518919;706.660802814649;747.0624366420142;15999.440019599317;16982.065986370744;16997.830021699778;17010.999999999985;17053.82946170538;13834.745551263994;15667.216639168024;15709.84290157098;15735.527934161964;15823.84176158238;877.1623099939559;892.3040028777564;901.5807649443008;903.8192361527688;903.932205084618;901.1709227510673;917.206616276919;917.9954100229489;919.3932004876783;920.7559996600907;953.3612479638658;963.8120566489538;964.6912987843892;964.9710508684751;966.3670295956125;951.8667386565886;955.7658373698418;957.0190554681437;959.7024922274118;961.2262128986164;702.5644100657574;704.1303989572873;704.7674267491716;705.6542294275819;706.883364244899;14504.274786260645;14701.705965880623;15278.541643750705;15433.845661543353;15443.150626715526;12645.367731613382;12806.167599106122;13035.608931732064;13177.670558236025;13221.537246196433;11401.828972565418;11431.065870996288;11468.776961294743;11716.297022178696;11968.10239232061;2982.3587928595457;2982.567527708492;2983.970160298413;3008.4283986042583;3087.799293045945;75343.62328188324;76439.6178019112;76576.25678074111;76880;81102;12627.558035468715;12680.556180533637;12705.936470317589;12758.234505929673;12953.417096230693;23645.763542364355;23848.761512385;23887.641685374732;23900.641490377657;24078.51842963131;8241.79395515117;8288.129746376544;8343.874841877378;8397.538135402612;8528.40301178924;4015.317396042621;4018.618231268025;4122.876313710593;4178.331466965332;4196.559361267084;4229.577042295746;4284.67864910133;4321.805518751664;4336.0460698646875;4358.106588149421;718.6263143165525;723.316465939682;733.0909672006674;737.9410545866591;844.5481667308084;571.2373980735681;600.4835841176584;600.8137477382026;602.7890238416607;607.6202373516552;10372.273940824221;10695.465226738632;10785.298955567863;11358.488868000959;11470.942645286887;579.8347470970754;596.153462083842;599.7151353107239;605.5851741557047;608.6287364707525;4785.760711964388;5086.567641750418;5094.439611642716;5097.260897169889;5104.285400043997;75920.24079759132;77533.22466775373;77534;77961.61019194868;79541.20458795453;47070.76464617655;52017.219741703906;71265.28734712586;73435;74206;57626;58746.70626646925;58767.706161468916;58896.41103588909;61867;10902.509387077442;11582.131340149692;11672.416379180837;11860.288382697066;11913.702157446132;33374.499382508795;34358.141046473036;34587.4811877817;34760.82619586987;35109.648903510635;40676.79661601673;40741.796291018356;41315.7934210327;41345;41568.376474353514;13818.723625527635;13877.722445551235;14035.578932632037;14232.35954382076;14244.359003844645;15026.248687565796;15201.543953681406;15311.770323444935;15544.689106218038;15596.766048509508;13958;14423.42306307736;14448.927755361156;15290;15319.310631021408;13485.528006519724;13678.658033549242;13991.524793695879;14036.578902632937;14547.636309092357;14090.295485225903;14090.75978220831;14291.142531448146;14298.57104286873;15174.24128793578;10807.729806754895;11167;11283.32300061966;11298.83051754208;11357.716057098638;12226.87773122293;12253.632391028283;12323.938380308042;12406.751864962831;12470.875291246972 05:21:41 INFO - PID 26686 | __end_tp_report 05:21:41 INFO - PID 26686 | __start_cc_report 05:21:41 INFO - PID 26686 | _x_x_mozilla_cycle_collect,1374 05:21:41 INFO - PID 26686 | __end_cc_report 05:21:41 INFO - PID 26686 | __startTimestamp1491049301675__endTimestamp 05:21:41 INFO - PID 26686 | 05:21:41 INFO - PID 26686 | ------- Summary: start ------- 05:21:41 INFO - PID 26686 | Number of tests: 6 05:21:41 INFO - PID 26686 | 05:21:41 INFO - PID 26686 | [#0] dojo.html Cycles:165 Average:5849.45 Median:6099.00 stddev:696.50 (11.4%) stddev-sans-first:669.58 05:21:41 INFO - PID 26686 | Values: 3311.7 3328.6 3356.4 3366.7 3373.2 5701.5 5815.6 5862.2 5867.1 5867.8 5799.1 5852.1 5853.6 5923.3 5985.0 5196.0 5207.7 5245.7 5275.1 5291.7 5158.6 5203.3 5257.5 5268.7 5276.8 5216.5 5232.4 5269.9 5286.8 5331.6 5092.8 5149.3 5155.6 5166.7 5204.3 5162.4 5191.3 5214.1 5238.9 5255.1 5809.8 5855.2 5857.8 5877.6 5881.2 6111.7 6199.3 6325.6 6376.6 6376.8 6414.3 6425.5 6433.6 6433.9 6442.4 5920.1 5922.8 5924.1 5925.2 5964.8 6220.0 6300.5 6434.1 6475.9 6525.8 6054.7 6123.3 6172.1 6201.3 6233.1 6183.7 6337.8 6344.9 6382.0 6391.1 6211.2 6329.0 6329.4 6330.1 6338.2 6135.9 6141.1 6327.7 6329.2 6346.6 4771.0 4835.7 4872.0 4902.7 4903.6 4320.0 4332.1 4336.6 4339.4 4366.7 6003.8 6019.1 6024.1 6027.3 6028.1 6129.9 6201.3 6374.5 6400.3 6436.2 5965.1 6005.5 6013.6 6016.2 6049.8 5421.0 5453.9 5462.6 5465.1 5473.7 6365.5 6453.6 6550.1 6627.8 6702.0 6409.3 6422.3 6426.8 6429.5 6429.8 6638.7 6643.6 6643.9 6644.0 6645.5 6099.0 6105.3 6233.7 6245.2 6324.7 6340.6 6391.9 6408.2 6410.2 6416.8 6142.2 6193.5 6212.6 6218.4 6227.3 5979.7 5979.9 6056.3 6140.8 6217.8 6148.9 6192.7 6197.4 6198.1 6201.2 6210.3 6268.1 6271.3 6278.5 6284.0 5905.1 5907.0 6053.9 6112.8 6114.1 05:21:41 INFO - PID 26686 | 05:21:41 INFO - PID 26686 | [#1] ext.html Cycles:180 Average:43499.06 Median:31772.71 stddev:73095.15 (230.1%) stddev-sans-first:73229.65 05:21:41 INFO - PID 26686 | Values: 727.7 794.0 805.1 1077.0 1081.1 31560.8 40338.0 40806.6 40877.2 41094.6 43108.6 43552.0 43581.6 43607.8 43649.6 7927.9 8107.4 8125.7 8125.7 8129.3 6111.8 6315.7 8108.8 8367.6 8374.9 8314.0 8391.8 8391.9 8403.3 8404.7 8316.0 8352.3 8371.6 8387.5 8388.7 8199.8 8263.1 8266.0 8270.7 8279.2 40712.8 40976.2 41030.4 41032.8 41077.2 2791.8 2818.0 2824.4 2838.2 2860.1 28340.6 28545.1 28906.1 29235.7 29391.0 3662.2 3667.9 3695.7 3716.9 3760.9 209521.0 209791.0 210287.0 210377.0 210419.0 49411.3 49731.8 49813.8 49825.8 49855.5 52030.0 52345.0 52488.0 52510.7 52547.0 14678.8 14820.5 14833.9 14840.5 14841.3 10010.2 11876.1 11885.9 11917.5 11933.8 12522.2 13408.9 13554.7 13598.6 13764.9 5248.6 5276.9 5294.3 5304.3 5311.6 1000.7 1004.5 1007.5 1014.9 1016.0 25582.9 25602.1 25778.4 25891.7 25930.1 1102.9 1108.9 1124.1 1125.1 1131.6 12983.7 13306.6 13354.4 13521.7 13559.5 304195.0 304435.0 304783.0 307559.0 308430.0 54261.5 54327.0 54392.0 54411.2 54486.2 1383.9 1464.9 1467.1 1470.4 1486.3 23595.6 24578.9 25488.0 25693.9 25764.7 41335.8 41353.6 41377.6 41425.0 41475.6 308678.0 309180.0 309483.0 309900.0 310049.0 28048.0 28697.7 34380.7 34829.7 35055.0 41392.4 41634.2 41702.8 42265.4 42690.8 31181.5 31462.5 31466.5 31490.8 32314.2 31328.7 31653.2 31892.2 31892.8 31959.0 36234.0 36298.6 37173.3 37272.0 37377.4 30277.4 30432.5 30568.8 30679.5 31542.2 23890.6 24619.4 24752.8 24919.3 25258.6 05:21:41 INFO - PID 26686 | 05:21:41 INFO - PID 26686 | [#2] jquery.html Cycles:180 Average:36418.71 Median:12245.44 stddev:111040.03 (906.8%) stddev-sans-first:111318.66 05:21:41 INFO - PID 26686 | Values: 436.9 442.2 443.2 443.6 454.8 19776.9 21084.4 21585.2 21660.7 21729.8 21246.9 21932.6 22265.0 22419.0 22652.7 5953.5 6128.0 6129.9 6132.8 6136.6 5729.2 5975.4 5995.6 6017.2 6030.3 5843.4 5974.5 5980.9 5982.8 5991.4 5889.2 5977.9 6024.5 6033.2 6036.1 5388.1 5406.8 5461.1 5461.6 5467.5 25072.5 25222.9 25261.4 25330.6 25338.2 1863.5 1865.4 1871.3 1882.9 1895.1 15401.7 15667.9 15873.8 16017.5 16383.9 2016.2 2091.2 2103.9 2128.7 2134.9 77127.4 91159.0 95749.0 100735.5 105530.3 11990.7 12136.7 12220.3 12335.8 12515.0 17195.7 17350.3 17385.7 17414.0 17415.7 8866.3 9003.5 9018.7 9286.4 9354.0 8407.2 8434.5 8454.2 8683.3 8683.8 7679.8 7809.9 7810.6 7843.3 8149.5 2058.6 2126.7 2166.8 2225.9 2285.8 984.7 989.1 999.6 1011.1 1015.6 20530.0 21234.3 23574.9 25722.1 25828.9 1024.6 1028.5 1040.3 1055.3 1066.5 10743.7 11438.3 11507.8 11514.4 11521.0 664718.0 668475.0 677029.0 677889.0 691575.0 92583.8 98947.5 112784.4 113857.0 117536.0 1083.6 1108.2 1129.9 1144.8 1154.3 20100.9 20329.5 20544.7 20910.0 20989.9 48156.3 48699.8 49789.3 49845.3 51601.0 64789.0 65389.0 65709.7 67390.0 67563.0 9026.0 9141.5 9371.7 9447.6 10024.5 14352.4 14698.4 14708.0 14758.2 14798.5 12619.4 12766.7 12876.4 12985.7 13033.8 11649.8 11775.7 11864.6 11987.1 12651.6 12689.6 12942.3 13044.2 13090.8 13109.0 9408.2 9598.0 9606.1 9630.7 9794.3 12482.4 12704.6 12718.2 12772.5 12831.2 05:21:41 INFO - PID 26686 | 05:21:41 INFO - PID 26686 | [#3] mootools.html Cycles:180 Average:6929.07 Median:2338.97 stddev:4469.14 (191.1%) stddev-sans-first:4460.68 05:21:41 INFO - PID 26686 | Values: 1164.5 1180.4 1185.8 1193.9 1201.2 10588.9 11080.4 11080.6 11095.6 11097.3 10820.5 10842.6 11082.2 11164.8 11165.3 2281.7 2317.0 2321.5 2321.6 2323.5 1926.3 2214.7 2300.8 2348.6 2357.3 1946.4 2273.3 2335.2 2342.7 2343.2 2203.0 2267.5 2275.6 2276.3 2316.6 2285.3 2289.1 2291.9 2299.2 2304.9 10790.4 11113.8 11122.7 11124.9 11125.1 6001.6 6211.0 6227.1 6227.8 6243.6 3555.6 3692.8 3713.7 3745.0 3793.5 1418.5 1418.8 1439.0 1441.9 1460.7 16509.3 16589.3 16720.1 16724.7 16761.8 4877.9 5001.1 5048.9 5051.1 5087.6 12136.6 12141.8 12156.5 12177.7 12182.2 5974.3 5984.6 5994.5 5996.1 5996.7 5342.4 5400.3 5406.4 5416.3 5557.3 4081.6 4144.2 4152.2 4157.9 4238.6 1024.1 1051.3 1150.7 1161.4 1181.8 809.8 836.9 850.6 852.2 861.4 6715.8 6845.4 6895.1 7004.1 7092.4 912.8 958.8 972.9 984.7 994.1 4151.6 4279.9 4321.0 4331.4 4389.7 14163.5 14687.0 14764.3 14798.6 14850.9 14290.5 14345.8 14528.6 14533.7 14556.1 10380.8 10558.7 10567.9 10597.4 10630.4 6672.4 6679.4 6719.2 6748.9 6830.9 12679.7 12890.4 13217.0 13231.4 13239.9 13189.8 13265.0 13313.5 13346.7 13409.9 8649.5 8704.3 8740.5 8767.4 8820.7 10226.0 10422.4 10424.1 10433.1 10439.7 8332.0 8390.7 8465.6 8502.0 8749.0 8808.1 8819.3 8886.8 8896.2 8972.6 7746.0 7877.3 7887.8 7893.6 7896.2 5924.6 5941.3 5992.4 6022.9 6169.2 5557.4 5565.4 5891.9 6104.8 6408.1 05:21:41 INFO - PID 26686 | 05:21:41 INFO - PID 26686 | [#4] prototype.html Cycles:180 Average:5247.48 Median:5934.62 stddev:1552.07 (26.2%) stddev-sans-first:1513.39 05:21:41 INFO - PID 26686 | Values: 411.5 415.7 419.8 429.3 430.1 5796.9 5974.2 5993.1 6011.5 6038.6 5816.4 5886.0 5898.9 5899.6 5901.3 4398.3 4514.1 4519.4 4521.1 4526.2 4537.2 4537.6 4542.8 4544.8 4553.5 4494.4 4500.4 4506.9 4512.8 4519.0 4444.2 4505.1 4518.4 4519.0 4525.0 3950.4 3958.7 3959.1 3984.5 3995.3 5703.9 5727.2 5730.0 5741.2 5777.6 5046.2 5292.5 5307.4 5315.2 5321.2 6209.9 6231.2 6247.7 6257.2 6274.4 4437.8 4446.5 4468.0 4471.0 4481.5 6362.8 6500.7 6523.0 6592.2 6597.3 4598.6 4602.4 4602.4 4610.8 4611.8 4662.2 4668.9 4675.2 4684.1 4686.7 5123.6 5269.5 5313.8 5319.1 5328.9 6235.4 6245.8 6257.3 6291.5 6292.3 1566.7 1592.2 1597.2 1604.4 1610.1 1040.8 1065.5 1086.3 1091.0 1099.5 5898.3 5933.9 5936.7 5953.1 5953.4 6202.0 6431.9 6433.7 6448.5 6451.4 5910.6 5926.4 5933.3 5935.4 5991.8 3378.3 3384.5 3385.8 3393.4 3396.3 6415.7 6589.5 6610.2 6613.7 6665.5 6198.4 6501.6 6518.2 6524.5 6524.7 6460.5 6533.7 6594.6 6623.1 6635.4 6114.0 6287.1 6346.0 6426.2 6432.3 6273.9 6333.3 6335.7 6352.8 6395.4 6413.9 6620.4 6627.4 6649.2 6709.5 4528.6 4549.0 4573.9 4577.0 4579.0 6424.5 6467.5 6472.6 6515.3 6527.5 6041.5 6269.8 6287.7 6289.9 6377.2 6262.5 6269.4 6287.4 6292.4 6294.2 6152.9 6256.0 6282.0 6333.3 6368.8 6323.2 6326.9 6339.9 6345.5 6350.1 6186.8 6196.2 6224.5 6225.5 6233.8 05:21:41 INFO - PID 26686 | 05:21:41 INFO - PID 26686 | [#5] yui.html Cycles:180 Average:17002.56 Median:4016.97 stddev:20926.10 (520.9%) stddev-sans-first:20948.97 05:21:41 INFO - PID 26686 | Values: 696.5 697.6 700.1 706.7 747.1 15999.4 16982.1 16997.8 17011.0 17053.8 13834.7 15667.2 15709.8 15735.5 15823.8 877.2 892.3 901.6 903.8 903.9 901.2 917.2 918.0 919.4 920.8 953.4 963.8 964.7 965.0 966.4 951.9 955.8 957.0 959.7 961.2 702.6 704.1 704.8 705.7 706.9 14504.3 14701.7 15278.5 15433.8 15443.2 12645.4 12806.2 13035.6 13177.7 13221.5 11401.8 11431.1 11468.8 11716.3 11968.1 2982.4 2982.6 2984.0 3008.4 3087.8 75343.6 76439.6 76576.3 76880.0 81102.0 12627.6 12680.6 12705.9 12758.2 12953.4 23645.8 23848.8 23887.6 23900.6 24078.5 8241.8 8288.1 8343.9 8397.5 8528.4 4015.3 4018.6 4122.9 4178.3 4196.6 4229.6 4284.7 4321.8 4336.0 4358.1 718.6 723.3 733.1 737.9 844.5 571.2 600.5 600.8 602.8 607.6 10372.3 10695.5 10785.3 11358.5 11470.9 579.8 596.2 599.7 605.6 608.6 4785.8 5086.6 5094.4 5097.3 5104.3 75920.2 77533.2 77534.0 77961.6 79541.2 47070.8 52017.2 71265.3 73435.0 74206.0 57626.0 58746.7 58767.7 58896.4 61867.0 10902.5 11582.1 11672.4 11860.3 11913.7 33374.5 34358.1 34587.5 34760.8 35109.6 40676.8 40741.8 41315.8 41345.0 41568.4 13818.7 13877.7 14035.6 14232.4 14244.4 15026.2 15201.5 15311.8 15544.7 15596.8 13958.0 14423.4 14448.9 15290.0 15319.3 13485.5 13678.7 13991.5 14036.6 14547.6 14090.3 14090.8 14291.1 14298.6 15174.2 10807.7 11167.0 11283.3 11298.8 11357.7 12226.9 12253.6 12323.9 12406.8 12470.9 05:21:41 INFO - PID 26686 | -------- Summary: end -------- 05:21:41 INFO - PID 26686 | 05:21:42 INFO - TEST-INFO | 26686: exit 0 05:21:42 INFO - TEST-OK | dromaeo_css | took 1116932ms 05:21:42 INFO - TEST-START | kraken 05:21:42 INFO - operating with platform_type : linux_ 05:21:42 INFO - Initialising browser for kraken test... 05:21:42 INFO - TEST-INFO | started process 27019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnKeqBD/profile http://localhost:40509/getInfo.html) 05:21:46 INFO - PID 27019 | __metrics Screen width/height:1600/1200 05:21:46 INFO - PID 27019 | colorDepth:24 05:21:46 INFO - PID 27019 | Browser inner width/height: 1024/697 05:21:46 INFO - PID 27019 | __metrics 05:21:47 INFO - PID 27019 | 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" 05:21:47 INFO - PID 27019 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:48 INFO - TEST-INFO | 27019: exit 0 05:21:48 INFO - Browser initialized. 05:21:48 INFO - Running cycle 1/1 for kraken test... 05:21:48 INFO - TEST-INFO | started process 27113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnKeqBD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:00 INFO - PID 27113 | RSS: Main: 143929344 05:22:00 INFO - PID 27113 | 05:22:02 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40509/tests/kraken/driver.html?testName=audio-beat-detection) 05:22:03 INFO - PID 27113 | RSS: Main: 197558272 05:22:03 INFO - PID 27113 | 05:22:06 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40509/tests/kraken/driver.html?testName=audio-dft) 05:22:06 INFO - PID 27113 | RSS: Main: 178569216 05:22:06 INFO - PID 27113 | 05:22:09 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40509/tests/kraken/driver.html?testName=audio-fft) 05:22:10 INFO - PID 27113 | RSS: Main: 260763648 05:22:10 INFO - PID 27113 | 05:22:12 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40509/tests/kraken/driver.html?testName=audio-oscillator) 05:22:13 INFO - PID 27113 | RSS: Main: 171659264 05:22:13 INFO - PID 27113 | 05:22:15 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:15 INFO - PID 27113 | RSS: Main: 175874048 05:22:15 INFO - PID 27113 | 05:22:18 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40509/tests/kraken/driver.html?testName=imaging-darkroom) 05:22:19 INFO - PID 27113 | RSS: Main: 213897216 05:22:19 INFO - PID 27113 | 05:22:22 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40509/tests/kraken/driver.html?testName=imaging-desaturate) 05:22:23 INFO - PID 27113 | RSS: Main: 223580160 05:22:23 INFO - PID 27113 | 05:22:26 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40509/tests/kraken/driver.html?testName=json-parse-financial) 05:22:26 INFO - PID 27113 | RSS: Main: 233377792 05:22:26 INFO - PID 27113 | 05:22:28 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:22:29 INFO - PID 27113 | RSS: Main: 176816128 05:22:29 INFO - PID 27113 | 05:22:30 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:31 INFO - PID 27113 | RSS: Main: 183816192 05:22:31 INFO - PID 27113 | 05:22:33 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:33 INFO - PID 27113 | RSS: Main: 192770048 05:22:33 INFO - PID 27113 | 05:22:36 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:37 INFO - PID 27113 | RSS: Main: 203096064 05:22:37 INFO - PID 27113 | 05:22:40 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:40 INFO - PID 27113 | RSS: Main: 198090752 05:22:40 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40509/tests/kraken/driver.html?testName=ai-astar) 05:22:42 INFO - PID 27113 | RSS: Main: 268378112 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | __start_tp_report 05:22:42 INFO - PID 27113 | _x_x_mozilla_page_load 05:22:42 INFO - PID 27113 | _x_x_mozilla_page_load_details 05:22:42 INFO - PID 27113 | |i|pagename|runs| 05:22:42 INFO - PID 27113 | |0;ai-astar;107;112;110;109;109;113;109;110;110;110 05:22:42 INFO - PID 27113 | |1;audio-beat-detection;149;124;117;169;118;122;118;123;146;118 05:22:42 INFO - PID 27113 | |2;audio-dft;170;165;164;167;166;164;165;166;166;164 05:22:42 INFO - PID 27113 | |3;audio-fft;75;74;75;110;78;74;78;74;92;75 05:22:42 INFO - PID 27113 | |4;audio-oscillator;82;83;111;82;82;83;94;82;82;107 05:22:42 INFO - PID 27113 | |5;imaging-gaussian-blur;114;114;114;115;115;114;114;114;115;115 05:22:42 INFO - PID 27113 | |6;imaging-darkroom;148;149;147;147;148;148;148;148;149;147 05:22:42 INFO - PID 27113 | |7;imaging-desaturate;95;94;95;95;94;94;95;98;95;94 05:22:42 INFO - PID 27113 | |8;json-parse-financial;47;46;45;46;47;47;48;49;47;47 05:22:42 INFO - PID 27113 | |9;json-stringify-tinderbox;59;60;60;55;57;55;55;55;55;56 05:22:42 INFO - PID 27113 | |10;stanford-crypto-aes;82;79;81;80;81;81;80;81;80;82 05:22:42 INFO - PID 27113 | |11;stanford-crypto-ccm;129;134;137;129;130;133;128;141;188;128 05:22:42 INFO - PID 27113 | |12;stanford-crypto-pbkdf2;192;188;194;185;175;185;184;186;183;183 05:22:42 INFO - PID 27113 | |13;stanford-crypto-sha256-iterative;65;67;67;70;64;65;66;68;64;71 05:22:42 INFO - PID 27113 | __end_tp_report 05:22:42 INFO - PID 27113 | __start_cc_report 05:22:42 INFO - PID 27113 | _x_x_mozilla_cycle_collect,1739 05:22:42 INFO - PID 27113 | __end_cc_report 05:22:42 INFO - PID 27113 | __startTimestamp1491049362930__endTimestamp 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | ------- Summary: start ------- 05:22:42 INFO - PID 27113 | Number of tests: 14 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.66 (1.5%) stddev-sans-first:1.39 05:22:42 INFO - PID 27113 | Values: 107.0 112.0 110.0 109.0 109.0 113.0 109.0 110.0 110.0 110.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:123.50 stddev:17.91 (14.5%) stddev-sans-first:17.68 05:22:42 INFO - PID 27113 | Values: 149.0 124.0 117.0 169.0 118.0 122.0 118.0 123.0 146.0 118.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.00 stddev:1.83 (1.1%) stddev-sans-first:1.09 05:22:42 INFO - PID 27113 | Values: 170.0 165.0 164.0 167.0 166.0 164.0 165.0 166.0 166.0 164.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:11.70 (15.6%) stddev-sans-first:12.24 05:22:42 INFO - PID 27113 | Values: 75.0 74.0 75.0 110.0 78.0 74.0 78.0 74.0 92.0 75.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:11.30 (13.8%) stddev-sans-first:11.72 05:22:42 INFO - PID 27113 | Values: 82.0 83.0 111.0 82.0 82.0 83.0 94.0 82.0 82.0 107.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:22:42 INFO - PID 27113 | Values: 114.0 114.0 114.0 115.0 115.0 114.0 114.0 114.0 115.0 115.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:22:42 INFO - PID 27113 | Values: 148.0 149.0 147.0 147.0 148.0 148.0 148.0 148.0 149.0 147.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.20 (1.3%) stddev-sans-first:1.27 05:22:42 INFO - PID 27113 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 98.0 95.0 94.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.00 stddev:1.10 (2.3%) stddev-sans-first:1.17 05:22:42 INFO - PID 27113 | Values: 47.0 46.0 45.0 46.0 47.0 47.0 48.0 49.0 47.0 47.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:56.50 stddev:2.16 (3.8%) stddev-sans-first:2.13 05:22:42 INFO - PID 27113 | Values: 59.0 60.0 60.0 55.0 57.0 55.0 55.0 55.0 55.0 56.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.00 stddev:0.95 (1.2%) stddev-sans-first:0.88 05:22:42 INFO - PID 27113 | Values: 82.0 79.0 81.0 80.0 81.0 81.0 80.0 81.0 80.0 82.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:133.50 stddev:18.18 (13.6%) stddev-sans-first:19.01 05:22:42 INFO - PID 27113 | Values: 129.0 134.0 137.0 129.0 130.0 133.0 128.0 141.0 188.0 128.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.50 Median:185.50 stddev:5.23 (2.8%) stddev-sans-first:4.99 05:22:42 INFO - PID 27113 | Values: 192.0 188.0 194.0 185.0 175.0 185.0 184.0 186.0 183.0 183.0 05:22:42 INFO - PID 27113 | 05:22:42 INFO - PID 27113 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.41 (3.6%) stddev-sans-first:2.47 05:22:42 INFO - PID 27113 | Values: 65.0 67.0 67.0 70.0 64.0 65.0 66.0 68.0 64.0 71.0 05:22:42 INFO - PID 27113 | -------- Summary: end -------- 05:22:42 INFO - PID 27113 | 05:22:43 INFO - TEST-INFO | 27113: exit 0 05:22:44 INFO - TEST-OK | kraken | took 61558ms 05:22:44 INFO - SUITE-END | took 1178s 05:22:44 INFO - Completed test suite (00:19:38) 05:22:44 INFO - javascript benchmark 05:22:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7580.8794366874035, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3311.652276510965, 3328.550645662835, 3356.379069872074, 3366.680165384289, 3373.207296285374, 5701.543876489881, 5815.621984571, 5862.179294898712, 5867.119932010195, 5867.794627188049, 5799.101139323411, 5852.092925596528, 5853.560982926277, 5923.28920529536, 5985.042393217086, 5195.999999999991, 5207.661502002376, 5245.6852588844795, 5275.050490911634, 5291.68249905005, 5158.638895277332, 5203.349581302337, 5257.474252574731, 5268.657537260085, 5276.762545685453, 5216.4522725114075, 5232.398274198478, 5269.894602107975, 5286.814961476349, 5331.573474122061, 5092.79628814847, 5149.3305870237, 5155.639105262633, 5166.741662916839, 5204.29741984831, 5162.406323272797, 5191.325127733408, 5214.06146893559, 5238.947610523884, 5255.054090263751, 5809.796657116981, 5855.209546711182, 5857.7949771757785, 5877.5591830612875, 5881.206037185011, 6111.682900513629, 6199.287081985584, 6325.588836725598, 6376.553641245115, 6376.776812811576, 6414.262359828633, 6425.485961123099, 6433.646149461778, 6433.903491447632, 6442.420182183626, 5920.141579471038, 5922.775356881976, 5924.081767326072, 5925.20009798676, 5964.821055368346, 6220.0, 6300.527460440485, 6434.099226108348, 6475.902861457082, 6525.836854078591, 6054.727537260834, 6123.2652081750475, 6172.105044768484, 6201.286852011986, 6233.065040243909, 6183.690815459209, 6337.841553961188, 6344.904826427607, 6382.0, 6391.137196478416, 6211.16149319845, 6329.0, 6329.430351268408, 6330.1454303668415, 6338.207724034496, 6135.877282454415, 6141.100401245241, 6327.651979141191, 6329.177206963065, 6346.587471814318, 4771.021940502258, 4835.709857408567, 4871.975640121847, 4902.730349830794, 4903.558679718771, 4319.9784001080425, 4332.068605249887, 4336.609705126553, 4339.370791235253, 4366.6506679465565, 6003.789867354709, 6019.067044608093, 6024.0662697282, 6027.306859711101, 6028.065649824284, 6129.8784197560135, 6201.255849298113, 6374.458171055419, 6400.263969643457, 6436.195475565554, 5965.135055417027, 6005.489533389711, 6013.609115407485, 6016.157737916607, 6049.848753781191, 5420.997115533639, 5453.881954199459, 5462.562994960473, 5465.07093794056, 5473.698946557898, 6365.522585806083, 6453.580517266362, 6550.082988381726, 6627.768028118992, 6701.9611960145285, 6409.294977552372, 6422.32565580626, 6426.807195784134, 6429.4534964526665, 6429.807105786834, 6638.668066596748, 6643.568168069253, 6643.9335606645245, 6643.966780166068, 6645.501587380869, 6099.0, 6105.3384459501285, 6233.657148856856, 6245.219347581552, 6324.683765811783, 6340.556161068866, 6391.872162556816, 6408.23101227837, 6410.166678331787, 6416.844967905635, 6142.201513803177, 6193.535484838565, 6212.627242365473, 6218.409251121137, 6227.314995350417, 5979.701014949148, 5979.880402392015, 6056.273247210187, 6140.84169297792, 6217.844553886189, 6148.877022459616, 6192.721327540181, 6197.380261973766, 6198.0702894566175, 6201.193844800147, 6210.347913469202, 6268.059791031382, 6271.278802937721, 6278.466330361788, 6283.96858015707, 5905.143754155709, 5906.970465147647, 6053.878922421439, 6112.847178820387, 6114.052321890114], "value": 5800.463973121717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.6543641770156, 793.9642716077777, 805.0982899152949, 1076.9983914959084, 1081.0594782539192, 31560.842195789017, 40338.0, 40806.59193408072, 40877.182456350856, 41094.58905410945, 43108.56891431085, 43552.0, 43581.56418435815, 43607.78196109023, 43649.563504364945, 7927.92072079279, 8107.432479726422, 8125.674973001072, 8125.674973001072, 8129.268365847072, 6111.847203819895, 6315.652639104847, 8108.797280068016, 8367.623456944422, 8374.874376884352, 8314.0, 8391.832163356728, 8391.916080839204, 8403.327733781283, 8404.747857564284, 8315.958420207891, 8352.331813454908, 8371.58142092899, 8387.496750195009, 8388.748337549883, 8199.836003279901, 8263.091059983397, 8266.0, 8270.669173233064, 8279.172082791672, 40712.796436017925, 40976.180476390306, 41030.38454423186, 41032.794836025925, 41077.178456431, 2791.8324900506036, 2817.971820281812, 2824.364517983458, 2838.247864315958, 2860.0990687933236, 28340.574891376647, 28545.143645690456, 28906.132816015343, 29235.707642923724, 29391.0, 3662.212624285791, 3667.9266414671824, 3695.667389934919, 3716.8513259469587, 3760.9435858462143, 209521.0, 209790.9510452453, 210287.0, 210377.0, 210419.0, 49411.258831117564, 49731.75134124306, 49813.750931245835, 49825.750871245415, 49855.501444985086, 52030.0, 52345.0, 52488.0, 52510.73744631252, 52547.0, 14678.779818302733, 14820.481283155254, 14833.92583037078, 14840.480583179537, 14841.257937103102, 10010.249231307682, 11876.10929180315, 11885.940570297093, 11917.463714132884, 11933.761324773455, 12522.248665080124, 13408.865911340958, 13554.661133471742, 13598.592042238748, 13764.93117534406, 5248.606354523426, 5276.92084618731, 5294.311739473844, 5304.257403963371, 5311.601629877775, 1000.7348052766023, 1004.4525733475274, 1007.471077684207, 1014.8629934958834, 1015.9847602285971, 25582.872085639454, 25602.103926362488, 25778.355541111247, 25891.74108258931, 25930.092446764273, 1102.9007389334838, 1108.9001989820954, 1124.1007194244735, 1125.1224045244721, 1131.6095946898306, 12983.675408114872, 13306.600801975956, 13354.399052042681, 13521.729565408637, 13559.45762169522, 304195.0, 304435.0, 304783.0, 307559.0, 308430.0, 54261.45738542643, 54327.0, 54392.0, 54411.18383224255, 54486.182707259424, 1383.8685324894118, 1464.9047811892406, 1467.1123969998212, 1470.3897882378692, 1486.2940103450774, 23595.646065309378, 24578.877105615073, 25487.960963123278, 25693.871530642977, 25764.742352576235, 41335.793321033205, 41353.586464134976, 41377.58622413858, 41425.0, 41475.58524414838, 308678.0, 309180.0, 309483.0, 309900.0, 310049.0, 28048.0, 28697.713022869502, 34380.656193437746, 34829.65170348366, 35055.0, 41392.37911431391, 41634.1673166541, 41702.79148604238, 42265.366019510344, 42690.78654606707, 31181.53227701541, 31462.528062079546, 31466.528002080446, 31490.842545787124, 32314.192145196557, 31328.686713132578, 31653.20866978344, 31892.202694932814, 31892.84053579717, 31959.0, 36234.0, 36298.637013630585, 37173.25653486861, 37272.0, 37377.4393384094, 30277.394452111275, 30432.543511847784, 30568.84715576408, 30679.53980690336, 31542.211444714067, 23890.64164037506, 24619.384515387257, 24752.752472475044, 24919.252422427355, 25258.621120683572], "value": 17438.17008460483, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.8623883476707, 442.1576896013095, 443.1624230204913, 443.6184881002337, 454.7998880492583, 19776.90111549442, 21084.367468975935, 21585.244516441926, 21660.675089873665, 21729.78270217297, 21246.89376553119, 21932.561348773015, 22265.0, 22419.0, 22652.66021009682, 5953.523718102563, 6127.958247098004, 6129.938700612981, 6132.816015519519, 6136.570440069197, 5729.197912292261, 5975.372585878486, 5995.640261584319, 6017.157597936292, 6030.33666296707, 5843.415658434165, 5974.4921681657115, 5980.940190598104, 5982.79060232892, 5991.370906054867, 5889.1755154278435, 5977.910331345011, 6024.48791852693, 6033.245844269488, 6036.124761909498, 5388.084025715638, 5406.783728650849, 5461.098918678414, 5461.590380721462, 5467.507924286793, 25072.49855002908, 25222.873885630637, 25261.368465788502, 25330.620040699403, 25338.239852804447, 1863.4595967169505, 1865.4310435317223, 1871.3076161820213, 1882.9340973065878, 1895.1282410091374, 15401.691966160726, 15667.92166039174, 15873.761893571605, 16017.519474415787, 16383.918080409521, 2016.1632922337212, 2091.2471510256296, 2103.852730308879, 2128.680697895328, 2134.893255337227, 77127.43088536765, 91159.0, 95749.0, 100735.49632251865, 105530.28106346203, 11990.724081404154, 12136.696582585506, 12220.327881966577, 12335.814962775565, 12515.0, 17195.742063869053, 17350.30598776035, 17385.652286954442, 17414.0, 17415.73876391855, 8866.33502487316, 9003.549822508849, 9018.729438116867, 9286.396384235004, 9354.0, 8407.201315874981, 8434.451760635538, 8454.15458454162, 8683.348748843862, 8683.826323473495, 7679.808004799925, 7809.882851757228, 7810.648520816577, 7843.254890785366, 8149.511029338259, 2058.5779915117364, 2126.6809978503347, 2166.804987551128, 2225.8775767332627, 2285.8399912006334, 984.699666601679, 989.0702739424918, 999.5701848205196, 1011.079917275276, 1015.6292953072224, 20530.0, 21234.256801011892, 23574.882125589604, 25722.09972650948, 25828.8708556456, 1024.6106479537877, 1028.496036941908, 1040.3445829127752, 1055.3456856748865, 1066.5360568152878, 10743.731406714895, 11438.313701177956, 11507.769844603228, 11514.366709830872, 11521.020713239468, 664718.0, 668475.0, 677029.0, 677889.0, 691575.0, 92583.81814910291, 98947.50526247466, 112784.43607781909, 113857.0, 117536.0, 1083.6044843632017, 1108.2020944919807, 1129.8700649425257, 1144.7824913266452, 1154.2958795134962, 20100.899495502428, 20329.49176270605, 20544.69182962227, 20910.0, 20989.89505052465, 48156.27765583589, 48699.75650121726, 49789.25316120189, 49845.25232121449, 51601.0, 64789.0, 65389.0, 65709.67145164244, 67390.0, 67563.0, 9025.962014368431, 9141.497217653094, 9371.671991480265, 9447.574859131493, 10024.498775061364, 14352.354144063751, 14698.41206351734, 14708.0, 14758.188299643623, 14798.48205312809, 12619.432125554189, 12766.744665106831, 12876.420561074587, 12985.675358116123, 13033.804492932803, 11649.76700465969, 11775.705607359541, 11864.644060678194, 11987.100967427652, 12651.620451386472, 12689.555865544662, 12942.288174150135, 13044.217346959213, 13090.80363794563, 13109.016823738068, 9408.200302974325, 9597.952010239904, 9606.087421694929, 9630.711078667651, 9794.265430092913, 12482.375881206084, 12704.618861434172, 12718.173318734252, 12772.489100435878, 12831.230126192459], "value": 10322.828829481201, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1164.5167255588929, 1180.415694231355, 1185.816198489234, 1193.9343336116522, 1201.2071635627212, 10588.894111058888, 11080.390578518189, 11080.556777728902, 11095.611653592126, 11097.33415995041, 10820.458977051156, 10842.566297348096, 11082.224244302903, 11164.832527512073, 11165.330080195174, 2281.7147856517895, 2316.9884150579223, 2321.466062805556, 2321.6169332060276, 2323.546908352872, 1926.2872737087298, 2214.6677998300224, 2300.781425764558, 2348.6477028445697, 2357.281029286067, 1946.4160751774411, 2273.3407311879537, 2335.2177020698086, 2342.730585982617, 2343.1798870395396, 2202.977970220293, 2267.4784799496124, 2275.590393729128, 2276.2602154299834, 2316.6061769499056, 2285.325828880484, 2289.072925465189, 2291.942701432461, 2299.2067736630834, 2304.9308520744403, 10790.352578845215, 11113.83329250062, 11122.666320010332, 11124.888751112467, 11125.109991200685, 6001.579889407743, 6210.96894515529, 6227.1282020517165, 6227.813165604994, 6243.594166379216, 3555.6266592007983, 3692.7968961707097, 3713.721470889694, 3744.981275093607, 3793.5447746270625, 1418.4538952503258, 1418.772996320594, 1438.9568312950628, 1441.8630230128122, 1460.7005563859384, 16509.33962641493, 16589.336426542923, 16720.08039557824, 16724.74912876308, 16761.832381676148, 4877.853664390074, 5001.1498045331655, 5048.924266136011, 5051.116054690415, 5087.592992560586, 12136.575219867438, 12141.757164856654, 12156.5137394505, 12177.69555761113, 12182.208156469978, 5974.3428222895445, 5984.640921544721, 5994.490468310155, 5996.130561068708, 5996.67018313997, 5342.412334643186, 5400.297961265089, 5406.432324605859, 5416.295881535375, 5557.3331200256225, 4081.591840815954, 4144.191882582928, 4152.231837110145, 4157.937630935538, 4238.554951730024, 1024.1499555369026, 1051.321897376188, 1150.6893138852631, 1161.355447726503, 1181.8345431639577, 809.817790997021, 836.9414141010071, 850.6342272822621, 852.2031900173358, 861.3539845116163, 6715.7985260442265, 6845.383915447534, 6895.103636527219, 7004.124484439445, 7092.4326053915565, 912.762681702762, 958.7986522830283, 972.9416235025922, 984.6849008317413, 994.145035269682, 4151.605597468236, 4279.935800962988, 4320.956790432118, 4331.436913201263, 4389.736615803062, 14163.50427735045, 14687.023205257427, 14764.26178691061, 14798.63003424923, 14850.851491484947, 14290.499832505813, 14345.78481322781, 14528.564143075513, 14533.709325813425, 14556.126632402089, 10380.792384152426, 10558.736031599117, 10567.894321056845, 10597.41714205726, 10630.362178269328, 6672.4328432081875, 6679.432248258952, 6719.193696756421, 6748.907838570059, 6830.897536537055, 12679.746405072032, 12890.355482225663, 13217.0, 13231.40458679381, 13239.867601323864, 13189.80215296752, 13265.0, 13313.534026309033, 13346.733065338445, 13409.865901340861, 8649.524276164871, 8704.303655707656, 8740.475571465733, 8767.386282960131, 8820.691275805317, 10226.0, 10422.374657520573, 10424.061834434937, 10433.061024507831, 10439.686809395731, 8332.0, 8390.664373424994, 8465.61904714277, 8501.95749021251, 8748.99386570527, 8808.119188081397, 8819.250363718898, 8886.822263554563, 8896.199342059246, 8972.596233169392, 7746.0, 7877.330426913776, 7887.802804929923, 7893.644785984529, 7896.210378962058, 5924.555658325729, 5941.287045554561, 5992.43071908168, 6022.915875142517, 6169.2288463942, 5557.36090349615, 5565.3599836019375, 5891.941080589139, 6104.786332478342, 6408.1349017881985], "value": 5195.278931087931, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.45687692246236, 415.68200326750025, 419.8005947175091, 429.2788115965177, 430.13972055888223, 5796.942030579693, 5974.163617093605, 5993.10103484477, 6011.458968692817, 6038.577299589019, 5816.418358164182, 5885.970570147154, 5898.941010589903, 5899.557533185018, 5901.321348044976, 4398.296272596385, 4514.119746649405, 4519.389882365871, 4521.095780843844, 4526.230540808054, 4537.2286711259, 4537.568930951555, 4542.818287268506, 4544.84093056743, 4553.544645535453, 4494.438195225597, 4500.414946057024, 4506.87328167958, 4512.796924138422, 4518.954810451903, 4444.155610434007, 4505.076459325846, 4518.43519560055, 4519.045834894484, 4524.954750452486, 3950.407438884162, 3958.7030972676876, 3959.1289916218675, 3984.4620976168135, 3995.3407687731487, 5703.857403564903, 5727.1695604137585, 5730.025895597759, 5741.167530708066, 5777.59556831022, 5046.21783623539, 5292.52367286946, 5307.389650190239, 5315.176147697113, 5321.175217841241, 6209.875802483925, 6231.158793562857, 6247.687615619247, 6257.2491301044165, 6274.403931626488, 4437.844675436377, 4446.533114023014, 4467.994701192239, 4470.994026344079, 4481.484629267643, 6362.840928976766, 6500.674966251716, 6523.0, 6592.208934927839, 6597.340265973412, 4598.609118224921, 4602.355670206174, 4602.355670206174, 4610.76946152691, 4611.792469338888, 4662.207424737802, 4668.85993420198, 4675.22858728306, 4684.1334353144775, 4686.695364801345, 5123.590112790967, 5269.473052694777, 5313.787448502017, 5319.148936170194, 5328.934213157384, 6235.441139715072, 6245.781397651061, 6257.2804127525915, 6291.496680265568, 6292.307846136921, 1566.6631674190103, 1592.235726851118, 1597.18543542794, 1604.3662753212416, 1610.0581160021284, 1040.7554224757175, 1065.4938904020682, 1086.3373342261214, 1090.9672709818717, 1099.5162128663362, 5898.292204935436, 5933.851653708605, 5936.7031648417405, 5953.107033944856, 5953.434423729739, 6201.96899015502, 6431.871362572816, 6433.710483028275, 6448.451881590024, 6451.354904499322, 5910.556708246899, 5926.407359264039, 5933.317668468095, 5935.39744269045, 5991.7603295867675, 3378.290558982641, 3384.509246159293, 3385.7799243049617, 3393.355262500117, 3396.3207358527898, 6415.743370265231, 6589.505787065989, 6610.239822420387, 6613.66931653425, 6665.533752511602, 6198.411150940653, 6501.577397469244, 6518.240075179675, 6524.543281970311, 6524.706388212542, 6460.483161347081, 6533.738650454024, 6594.604323740591, 6623.052741529973, 6635.402813746882, 6113.969430152821, 6287.088372186099, 6346.0, 6426.196725409324, 6432.292447830829, 6273.9372606273355, 6333.334999824952, 6335.746570137143, 6352.841178970378, 6395.360463953753, 6413.903791443226, 6620.404163625297, 6627.403533681992, 6649.202095748347, 6709.530332876847, 4528.573499347826, 4548.996882743165, 4573.908521829611, 4576.977115114403, 4578.954210457853, 6424.453921416732, 6467.482601391972, 6472.644004579794, 6515.315891831289, 6527.51043671717, 6041.486473649613, 6269.777393408242, 6287.717052732546, 6289.905651415141, 6377.202849643794, 6262.4990000800735, 6269.404406581368, 6287.402696743802, 6292.402221788922, 6294.244690637152, 6152.876942461036, 6256.0, 6281.96859015702, 6333.334999824952, 6368.840778980562, 6323.23767358421, 6326.936730632819, 6339.90490142639, 6345.524085693683, 6350.110984462087, 6186.752529898754, 6196.194494715658, 6224.51427200769, 6225.533085018732, 6233.812985610439], "value": 4768.003245675954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.5368030259878, 697.6337422853005, 700.0689083518919, 706.660802814649, 747.0624366420142, 15999.440019599317, 16982.065986370744, 16997.830021699778, 17010.999999999985, 17053.82946170538, 13834.745551263994, 15667.216639168024, 15709.84290157098, 15735.527934161964, 15823.84176158238, 877.1623099939559, 892.3040028777564, 901.5807649443008, 903.8192361527688, 903.932205084618, 901.1709227510673, 917.206616276919, 917.9954100229489, 919.3932004876783, 920.7559996600907, 953.3612479638658, 963.8120566489538, 964.6912987843892, 964.9710508684751, 966.3670295956125, 951.8667386565886, 955.7658373698418, 957.0190554681437, 959.7024922274118, 961.2262128986164, 702.5644100657574, 704.1303989572873, 704.7674267491716, 705.6542294275819, 706.883364244899, 14504.274786260645, 14701.705965880623, 15278.541643750705, 15433.845661543353, 15443.150626715526, 12645.367731613382, 12806.167599106122, 13035.608931732064, 13177.670558236025, 13221.537246196433, 11401.828972565418, 11431.065870996288, 11468.776961294743, 11716.297022178696, 11968.10239232061, 2982.3587928595457, 2982.567527708492, 2983.970160298413, 3008.4283986042583, 3087.799293045945, 75343.62328188324, 76439.6178019112, 76576.25678074111, 76880.0, 81102.0, 12627.558035468715, 12680.556180533637, 12705.936470317589, 12758.234505929673, 12953.417096230693, 23645.763542364355, 23848.761512385, 23887.641685374732, 23900.641490377657, 24078.51842963131, 8241.79395515117, 8288.129746376544, 8343.874841877378, 8397.538135402612, 8528.40301178924, 4015.317396042621, 4018.618231268025, 4122.876313710593, 4178.331466965332, 4196.559361267084, 4229.577042295746, 4284.67864910133, 4321.805518751664, 4336.0460698646875, 4358.106588149421, 718.6263143165525, 723.316465939682, 733.0909672006674, 737.9410545866591, 844.5481667308084, 571.2373980735681, 600.4835841176584, 600.8137477382026, 602.7890238416607, 607.6202373516552, 10372.273940824221, 10695.465226738632, 10785.298955567863, 11358.488868000959, 11470.942645286887, 579.8347470970754, 596.153462083842, 599.7151353107239, 605.5851741557047, 608.6287364707525, 4785.760711964388, 5086.567641750418, 5094.439611642716, 5097.260897169889, 5104.285400043997, 75920.24079759132, 77533.22466775373, 77534.0, 77961.61019194868, 79541.20458795453, 47070.76464617655, 52017.219741703906, 71265.28734712586, 73435.0, 74206.0, 57626.0, 58746.70626646925, 58767.706161468916, 58896.41103588909, 61867.0, 10902.509387077442, 11582.131340149692, 11672.416379180837, 11860.288382697066, 11913.702157446132, 33374.499382508795, 34358.141046473036, 34587.4811877817, 34760.82619586987, 35109.648903510635, 40676.79661601673, 40741.796291018356, 41315.7934210327, 41345.0, 41568.376474353514, 13818.723625527635, 13877.722445551235, 14035.578932632037, 14232.35954382076, 14244.359003844645, 15026.248687565796, 15201.543953681406, 15311.770323444935, 15544.689106218038, 15596.766048509508, 13958.0, 14423.42306307736, 14448.927755361156, 15290.0, 15319.310631021408, 13485.528006519724, 13678.658033549242, 13991.524793695879, 14036.578902632937, 14547.636309092357, 14090.295485225903, 14090.75978220831, 14291.142531448146, 14298.57104286873, 15174.24128793578, 10807.729806754895, 11167.0, 11283.32300061966, 11298.83051754208, 11357.716057098638, 12226.87773122293, 12253.632391028283, 12323.938380308042, 12406.751864962831, 12470.875291246972], "value": 7338.001279877787, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 110.0, 109.0, 109.0, 113.0, 109.0, 110.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 117.0, 169.0, 118.0, 122.0, 118.0, 123.0, 146.0, 118.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 165.0, 164.0, 167.0, 166.0, 164.0, 165.0, 166.0, 166.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 110.0, 78.0, 74.0, 78.0, 74.0, 92.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 111.0, 82.0, 82.0, 83.0, 94.0, 82.0, 82.0, 107.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 98.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 46.0, 45.0, 46.0, 47.0, 47.0, 48.0, 49.0, 47.0, 47.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 55.0, 57.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 80.0, 81.0, 81.0, 80.0, 81.0, 80.0, 82.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 134.0, 137.0, 129.0, 130.0, 133.0, 128.0, 141.0, 188.0, 128.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 188.0, 194.0, 185.0, 175.0, 185.0, 184.0, 186.0, 183.0, 183.0], "value": 185.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 70.0, 64.0, 65.0, 66.0, 68.0, 64.0, 71.0], "value": 66.7, "unit": "score"}]}]} 05:22:44 INFO - Return code: 0 05:22:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:22:44 ERROR - # TBPL SUCCESS # 05:22:44 INFO - Running post-action listener: _resource_record_post_action 05:22:44 INFO - [mozharness: 2017-04-01 12:22:44.253362Z] Finished run-tests step (success) 05:22:44 INFO - Running post-run listener: _resource_record_post_run 05:22:44 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370155520; Read time: 12; Write time: 409604 05:22:44 INFO - TinderboxPrint: CPU usage
13.0% 05:22:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:22:44 INFO - TinderboxPrint: I/O write bytes / time
370,155,520 / 409,604 05:22:44 INFO - TinderboxPrint: CPU idle
8,305.9 (87.0%) 05:22:44 INFO - TinderboxPrint: CPU user
1,191.2 (12.5%) 05:22:44 INFO - TinderboxPrint: Swap in / out
0 / 0 05:22:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111915008; Read time: 0; Write time: 139332 05:22:44 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 258240512; Read time: 0; Write time: 270272 05:22:44 INFO - Running post-run listener: _upload_blobber_files 05:22:44 INFO - Blob upload gear active. 05:22:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:22:44 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 05:22:44 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:22:44 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:22:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:46 INFO - (blobuploader) - INFO - Done attempting. 05:22:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:22:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:49 INFO - (blobuploader) - INFO - Done attempting. 05:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:50 INFO - (blobuploader) - INFO - Done attempting. 05:22:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:22:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:22:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:51 INFO - (blobuploader) - INFO - Done attempting. 05:22:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:51 INFO - Return code: 0 05:22:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ffc507204f8e89e5f9f8b3a27183cd46b7f7bdaf0b1603c44904f98fb1ad6a891bec3a2783eb995c1486c09a3556b4a7b00ec433d814e79bee1f9361797b791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f5eab20a2697948a0ce43a33752f56a2ea8f6bd3ce0550d574f1d6308c78ccdc4055b9e17b81e6ea453f129d2dfbb95f64c830b9ee01cb2612fbb8f335299a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0d06134b7dc6663c53d0d5726d95259df432d3976369e2bc2dd8e2e263158510134d022266072556b7f1509b2f933c6ceb1ea09d89c23db20eef9ab375d2695", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d1cb329ba5852a2040732d5ce4003b011384e80c7ff604386a3f78a6792edb3b802124f208f02accda7fef56de5453e5e788920cb0aa7ba72933e7454fba141"} 05:22:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:51 INFO - Contents: 05:22:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ffc507204f8e89e5f9f8b3a27183cd46b7f7bdaf0b1603c44904f98fb1ad6a891bec3a2783eb995c1486c09a3556b4a7b00ec433d814e79bee1f9361797b791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f5eab20a2697948a0ce43a33752f56a2ea8f6bd3ce0550d574f1d6308c78ccdc4055b9e17b81e6ea453f129d2dfbb95f64c830b9ee01cb2612fbb8f335299a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0d06134b7dc6663c53d0d5726d95259df432d3976369e2bc2dd8e2e263158510134d022266072556b7f1509b2f933c6ceb1ea09d89c23db20eef9ab375d2695", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d1cb329ba5852a2040732d5ce4003b011384e80c7ff604386a3f78a6792edb3b802124f208f02accda7fef56de5453e5e788920cb0aa7ba72933e7454fba141"} 05:22:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:51 INFO - Copying logs to upload dir... 05:22:51 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.878050 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-01 05:22:50.141149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 05:22:50.145163) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ffc507204f8e89e5f9f8b3a27183cd46b7f7bdaf0b1603c44904f98fb1ad6a891bec3a2783eb995c1486c09a3556b4a7b00ec433d814e79bee1f9361797b791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f5eab20a2697948a0ce43a33752f56a2ea8f6bd3ce0550d574f1d6308c78ccdc4055b9e17b81e6ea453f129d2dfbb95f64c830b9ee01cb2612fbb8f335299a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0d06134b7dc6663c53d0d5726d95259df432d3976369e2bc2dd8e2e263158510134d022266072556b7f1509b2f933c6ceb1ea09d89c23db20eef9ab375d2695", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d1cb329ba5852a2040732d5ce4003b011384e80c7ff604386a3f78a6792edb3b802124f208f02accda7fef56de5453e5e788920cb0aa7ba72933e7454fba141"} build_url:https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/cbvSa2WdTp6sFrWD9TuMrw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ffc507204f8e89e5f9f8b3a27183cd46b7f7bdaf0b1603c44904f98fb1ad6a891bec3a2783eb995c1486c09a3556b4a7b00ec433d814e79bee1f9361797b791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f5eab20a2697948a0ce43a33752f56a2ea8f6bd3ce0550d574f1d6308c78ccdc4055b9e17b81e6ea453f129d2dfbb95f64c830b9ee01cb2612fbb8f335299a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0d06134b7dc6663c53d0d5726d95259df432d3976369e2bc2dd8e2e263158510134d022266072556b7f1509b2f933c6ceb1ea09d89c23db20eef9ab375d2695", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d1cb329ba5852a2040732d5ce4003b011384e80c7ff604386a3f78a6792edb3b802124f208f02accda7fef56de5453e5e788920cb0aa7ba72933e7454fba141"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 05:22:50.178663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:22:50.179400) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1491047822.414092-636584977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:22:50.258880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 05:22:50.259193) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 05:22:50.259519) ========= ========= Total master_lag: 0.18 =========