builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-087 starttime: 1491454836.32 results: success (0) revision: ec8d1d3db50c85037e8077c32c8403570a5df493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:36.321823) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:36.322320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:36.322663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:36.336153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:36.336519) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 22:00:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.7M=0s 2017-04-05 22:00:36 (67.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:36.472925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:36.473295) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:36.523839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-05 22:00:36.524224) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec8d1d3db50c85037e8077c32c8403570a5df493 --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 ec8d1d3db50c85037e8077c32c8403570a5df493 --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=ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 22:00:36,784 truncating revision to first 12 chars 2017-04-05 22:00:36,784 Setting DEBUG logging. 2017-04-05 22:00:36,784 attempt 1/10 2017-04-05 22:00:36,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec8d1d3db50c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 22:00:38,517 unpacking tar archive at: mozilla-central-ec8d1d3db50c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.026031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-05 22:00:38.567451) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:38.567846) ========= script_repo_revision: ec8d1d3db50c85037e8077c32c8403570a5df493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:38.568412) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:38.568745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 22:00:38.578756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-05 22:00:38.579152) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:38 INFO - MultiFileLogger online at 20170405 22:00:38 in /builds/slave/test 22:00:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 22:00:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:00:38 INFO - {'append_to_log': False, 22:00:38 INFO - 'base_work_dir': '/builds/slave/test', 22:00:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:00:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:00:38 INFO - 'branch': 'Firefox-Non-PGO', 22:00:38 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:38 INFO - 'config_files': ('talos/linux_config.py',), 22:00:38 INFO - 'default_actions': ('clobber', 22:00:38 INFO - 'read-buildbot-config', 22:00:38 INFO - 'download-and-extract', 22:00:38 INFO - 'populate-webroot', 22:00:38 INFO - 'create-virtualenv', 22:00:38 INFO - 'install', 22:00:38 INFO - 'run-tests'), 22:00:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:38 INFO - 'download_minidump_stackwalk': True, 22:00:38 INFO - 'download_symbols': 'ondemand', 22:00:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:38 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:38 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:38 INFO - 'gecko_profile': False, 22:00:38 INFO - 'gecko_profile_interval': 0, 22:00:38 INFO - 'installer_path': 'installer.exe', 22:00:38 INFO - 'log_level': 'info', 22:00:38 INFO - 'log_name': 'talos', 22:00:38 INFO - 'log_to_console': True, 22:00:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:38 INFO - 'opt_config_files': (), 22:00:38 INFO - 'pip_index': False, 22:00:38 INFO - 'suite': 'dromaeojs', 22:00:38 INFO - 'system_bits': '32', 22:00:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:38 INFO - 'title': 'talos-linux64-ix-087', 22:00:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:38 INFO - 'use_talos_json': True, 22:00:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:00:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:38 INFO - 'work_dir': 'build'} 22:00:38 INFO - [mozharness: 2017-04-06 05:00:38.937207Z] Running clobber step. 22:00:38 INFO - Running pre-action listener: _resource_record_pre_action 22:00:38 INFO - Running main action method: clobber 22:00:38 INFO - rmtree: /builds/slave/test/build 22:00:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:00:39 INFO - Running post-action listener: _resource_record_post_action 22:00:39 INFO - [mozharness: 2017-04-06 05:00:39.874810Z] Finished clobber step (success) 22:00:39 INFO - [mozharness: 2017-04-06 05:00:39.874910Z] Running read-buildbot-config step. 22:00:39 INFO - Running pre-action listener: _resource_record_pre_action 22:00:39 INFO - Running main action method: read_buildbot_config 22:00:39 INFO - Using buildbot properties: 22:00:39 INFO - { 22:00:39 INFO - "project": "", 22:00:39 INFO - "product": "firefox", 22:00:39 INFO - "who": "philringnalda@gmail.com", 22:00:39 INFO - "installer_path": "public/build/target.tar.bz2", 22:00:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:00:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:00:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 22:00:39 INFO - "stage_platform": "linux64", 22:00:39 INFO - "basedir": "/builds/slave/test", 22:00:39 INFO - "buildnumber": 920, 22:00:39 INFO - "platform": "ubuntu64_hw", 22:00:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:00:39 INFO - "slavebuilddir": "test", 22:00:39 INFO - "taskId": "MqPrlVoYQuWjvl_F2UX_ww", 22:00:39 INFO - "branch": "mozilla-central", 22:00:39 INFO - "script_repo_revision": "production", 22:00:39 INFO - "revision": "ec8d1d3db50c85037e8077c32c8403570a5df493", 22:00:39 INFO - "slavename": "talos-linux64-ix-087", 22:00:39 INFO - "repo_path": "mozilla-central" 22:00:39 INFO - } 22:00:39 INFO - Finding installer, test and symbols from parent task. 22:00:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MqPrlVoYQuWjvl_F2UX_ww'}, attempt #1 22:00:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MqPrlVoYQuWjvl_F2UX_ww'}, attempt #1 22:00:40 INFO - Task dependencies: e6TNkw5mQ_6tCd-jEbizhg 22:00:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg'}, attempt #1 22:00:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 22:00:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/test_packages.json 22:00:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.crashreporter-symbols.zip 22:00:41 INFO - Running post-action listener: _resource_record_post_action 22:00:41 INFO - [mozharness: 2017-04-06 05:00:41.217536Z] Finished read-buildbot-config step (success) 22:00:41 INFO - [mozharness: 2017-04-06 05:00:41.217759Z] Running download-and-extract step. 22:00:41 INFO - Running pre-action listener: _resource_record_pre_action 22:00:41 INFO - Running main action method: download_and_extract 22:00:41 INFO - mkdir: /builds/slave/test/build/tests 22:00:41 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')]} 22:00:41 INFO - trying https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.test_packages.json 22:00:41 INFO - Downloading https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:00:41 INFO - Downloaded 986 bytes. 22:00:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:00:41 INFO - Using the following test package requirements: 22:00:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:00:41 INFO - u'common': [u'target.common.tests.zip'], 22:00:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:00:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:00:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:00:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:00:41 INFO - u'mozbase': [u'target.common.tests.zip'], 22:00:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:00:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:00:41 INFO - u'web-platform': [u'target.common.tests.zip', 22:00:41 INFO - u'target.web-platform.tests.zip'], 22:00:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:00:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:00:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip 22:00:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:00:41 INFO - Fetch https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip into memory 22:00:42 INFO - Expected file size: 58244177 22:00:42 INFO - Obtained file size: 58244177 22:00:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:00:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip 22:00:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:00:52 INFO - Fetch https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip into memory 22:00:53 INFO - Expected file size: 58244177 22:00:53 INFO - Obtained file size: 58244177 22:01:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.talos.tests.zip 22:01:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:01:04 INFO - Fetch https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.talos.tests.zip into memory 22:01:05 INFO - Expected file size: 14404152 22:01:05 INFO - Obtained file size: 14404152 22:01: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')]} 22:01:05 INFO - trying https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 22:01:05 INFO - Downloading https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:01:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:01:06 INFO - Downloaded 57692474 bytes. 22:01:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 22:01:06 INFO - mkdir: /builds/slave/test/properties 22:01:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:01:06 INFO - Writing to file /builds/slave/test/properties/build_url 22:01:06 INFO - Contents: 22:01:06 INFO - build_url:https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 22:01:06 INFO - Running post-action listener: _resource_record_post_action 22:01:06 INFO - Running post-action listener: set_extra_try_arguments 22:01:06 INFO - [mozharness: 2017-04-06 05:01:06.585895Z] Finished download-and-extract step (success) 22:01:06 INFO - [mozharness: 2017-04-06 05:01:06.585991Z] Running populate-webroot step. 22:01:06 INFO - Running pre-action listener: _resource_record_pre_action 22:01:06 INFO - Running main action method: populate_webroot 22:01:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:06 INFO - '--tppagecycles', 22:01:06 INFO - '7'], 22:01:06 INFO - 'tests': ['tsvgm']}}, 22:01:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:01:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:01:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:01:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:01:06 INFO - 'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:01:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:01:06 INFO - 'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['damp', 'tps']}, 22:01:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:01:06 INFO - 'tests': ['damp', 'tps']}, 22:01:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['dromaeo_dom']}, 22:01:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['basic_compositor_video']}, 22:01:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:01:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['a11yr', 22:01:06 INFO - 'ts_paint', 22:01:06 INFO - 'tpaint', 22:01:06 INFO - 'sessionrestore', 22:01:06 INFO - 'sessionrestore_no_auto_restore', 22:01:06 INFO - 'tabpaint']}, 22:01:06 INFO - 'other-e10s': {'tests': ['a11yr', 22:01:06 INFO - 'ts_paint', 22:01:06 INFO - 'tpaint', 22:01:06 INFO - 'sessionrestore', 22:01:06 INFO - 'sessionrestore_no_auto_restore', 22:01:06 INFO - 'tabpaint']}, 22:01:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:01:06 INFO - 'ts_paint', 22:01:06 INFO - 'tpaint', 22:01:06 INFO - 'sessionrestore', 22:01:06 INFO - 'sessionrestore_no_auto_restore', 22:01:06 INFO - 'tabpaint']}, 22:01:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:01:06 INFO - 'ts_paint', 22:01:06 INFO - 'tpaint', 22:01:06 INFO - 'sessionrestore', 22:01:06 INFO - 'sessionrestore_no_auto_restore', 22:01:06 INFO - 'tabpaint']}, 22:01:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['a11yr', 22:01:06 INFO - 'ts_paint', 22:01:06 INFO - 'tpaint', 22:01:06 INFO - 'sessionrestore', 22:01:06 INFO - 'sessionrestore_no_auto_restore', 22:01:06 INFO - 'tabpaint']}, 22:01:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['a11yr', 22:01:06 INFO - 'ts_paint', 22:01:06 INFO - 'tpaint', 22:01:06 INFO - 'sessionrestore', 22:01:06 INFO - 'sessionrestore_no_auto_restore', 22:01:06 INFO - 'tabpaint']}, 22:01:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['tsvgx', 22:01:06 INFO - 'tsvgr_opacity', 22:01:06 INFO - 'tart', 22:01:06 INFO - 'tscrollx', 22:01:06 INFO - 'cart', 22:01:06 INFO - 'tsvg_static']}, 22:01:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:01:06 INFO - 'tsvgr_opacity', 22:01:06 INFO - 'tart', 22:01:06 INFO - 'tscrollx', 22:01:06 INFO - 'cart', 22:01:06 INFO - 'tsvg_static']}, 22:01:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:01:06 INFO - 'talos_options': ['--disable-e10s'], 22:01:06 INFO - 'tests': ['tp5o']}, 22:01:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:01:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:01:06 INFO - 'talos_options': ['--disable-e10s', 22:01:06 INFO - '--xperf_path', 22:01:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:06 INFO - 'tests': ['tp5n']}, 22:01:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:01:06 INFO - 'talos_options': ['--xperf_path', 22:01:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:06 INFO - 'tests': ['tp5n']}}, 22:01:06 INFO - 'talos.zip': {'path': '', 22:01:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:06 INFO - Running post-action listener: _resource_record_post_action 22:01:06 INFO - [mozharness: 2017-04-06 05:01:06.599062Z] Finished populate-webroot step (success) 22:01:06 INFO - [mozharness: 2017-04-06 05:01:06.599151Z] Running create-virtualenv step. 22:01:06 INFO - Running pre-action listener: _resource_record_pre_action 22:01:06 INFO - Running main action method: create_virtualenv 22:01:06 INFO - Creating virtualenv /builds/slave/test/build/venv 22:01:06 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 22:01:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:01:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:06 INFO - Using real prefix '/usr' 22:01:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:01:07 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:09 INFO - Installing pip.................done. 22:01:09 INFO - Return code: 0 22:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:01:09 INFO - Reading from file tmpfile_stdout 22:01:09 INFO - Output received: 22:01:09 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) 22:01:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:01:09 INFO - Using env: {'DISPLAY': ':0', 22:01:09 INFO - 'HOME': '/home/cltbld', 22:01:09 INFO - 'LANG': 'en_US.UTF-8', 22:01:09 INFO - 'LANGUAGE': 'en_US:en', 22:01:09 INFO - 'LOGNAME': 'cltbld', 22:01:09 INFO - 'MAIL': '/var/mail/cltbld', 22:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:09 INFO - 'MOZ_NO_REMOTE': '1', 22:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:09 INFO - 'NO_EM_RESTART': '1', 22:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:09 INFO - 'PWD': '/builds/slave/test', 22:01:09 INFO - 'SHELL': '/bin/bash', 22:01:09 INFO - 'SHLVL': '1', 22:01:09 INFO - 'TERM': 'linux', 22:01:09 INFO - 'TMOUT': '86400', 22:01:09 INFO - 'USER': 'cltbld', 22:01:09 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:09 INFO - '_': '/tools/buildbot/bin/python'} 22:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:09 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 22:01:09 INFO - Cleaning up... 22:01:09 INFO - Return code: 0 22:01:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:01:09 INFO - Using env: {'DISPLAY': ':0', 22:01:09 INFO - 'HOME': '/home/cltbld', 22:01:09 INFO - 'LANG': 'en_US.UTF-8', 22:01:09 INFO - 'LANGUAGE': 'en_US:en', 22:01:09 INFO - 'LOGNAME': 'cltbld', 22:01:09 INFO - 'MAIL': '/var/mail/cltbld', 22:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:09 INFO - 'MOZ_NO_REMOTE': '1', 22:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:09 INFO - 'NO_EM_RESTART': '1', 22:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:09 INFO - 'PWD': '/builds/slave/test', 22:01:09 INFO - 'SHELL': '/bin/bash', 22:01:09 INFO - 'SHLVL': '1', 22:01:09 INFO - 'TERM': 'linux', 22:01:09 INFO - 'TMOUT': '86400', 22:01:09 INFO - 'USER': 'cltbld', 22:01:09 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:09 INFO - '_': '/tools/buildbot/bin/python'} 22:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:09 INFO - Downloading/unpacking psutil>=3.1.1 22:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:11 INFO - Installing collected packages: psutil 22:01:11 INFO - Running setup.py install for psutil 22:01:12 INFO - building 'psutil._psutil_linux' extension 22:01:12 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 22:01:12 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 22:01:12 INFO - building 'psutil._psutil_posix' extension 22:01:12 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 22:01:12 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 22:01:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:12 INFO - Successfully installed psutil 22:01:12 INFO - Cleaning up... 22:01:12 INFO - Return code: 0 22:01:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:01:12 INFO - Using env: {'DISPLAY': ':0', 22:01:12 INFO - 'HOME': '/home/cltbld', 22:01:12 INFO - 'LANG': 'en_US.UTF-8', 22:01:12 INFO - 'LANGUAGE': 'en_US:en', 22:01:12 INFO - 'LOGNAME': 'cltbld', 22:01:12 INFO - 'MAIL': '/var/mail/cltbld', 22:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:12 INFO - 'MOZ_NO_REMOTE': '1', 22:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:12 INFO - 'NO_EM_RESTART': '1', 22:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:12 INFO - 'PWD': '/builds/slave/test', 22:01:12 INFO - 'SHELL': '/bin/bash', 22:01:12 INFO - 'SHLVL': '1', 22:01:12 INFO - 'TERM': 'linux', 22:01:12 INFO - 'TMOUT': '86400', 22:01:12 INFO - 'USER': 'cltbld', 22:01:12 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:12 INFO - '_': '/tools/buildbot/bin/python'} 22:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:01:14 INFO - Installing collected packages: mozsystemmonitor 22:01:14 INFO - Running setup.py install for mozsystemmonitor 22:01:14 INFO - Successfully installed mozsystemmonitor 22:01:14 INFO - Cleaning up... 22:01:14 INFO - Return code: 0 22:01:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:01:14 INFO - Using env: {'DISPLAY': ':0', 22:01:14 INFO - 'HOME': '/home/cltbld', 22:01:14 INFO - 'LANG': 'en_US.UTF-8', 22:01:14 INFO - 'LANGUAGE': 'en_US:en', 22:01:14 INFO - 'LOGNAME': 'cltbld', 22:01:14 INFO - 'MAIL': '/var/mail/cltbld', 22:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:14 INFO - 'MOZ_NO_REMOTE': '1', 22:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:14 INFO - 'NO_EM_RESTART': '1', 22:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:14 INFO - 'PWD': '/builds/slave/test', 22:01:14 INFO - 'SHELL': '/bin/bash', 22:01:14 INFO - 'SHLVL': '1', 22:01:14 INFO - 'TERM': 'linux', 22:01:14 INFO - 'TMOUT': '86400', 22:01:14 INFO - 'USER': 'cltbld', 22:01:14 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:14 INFO - '_': '/tools/buildbot/bin/python'} 22:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:15 INFO - Downloading/unpacking jsonschema==2.5.1 22:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:01:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:17 INFO - Downloading functools32-3.2.3-2.tar.gz 22:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:01:17 INFO - warning: no files found matching '*.txt' 22:01:17 INFO - no previously-included directories found matching 'build' 22:01:17 INFO - no previously-included directories found matching 'dist' 22:01:17 INFO - no previously-included directories found matching '.git*' 22:01:17 INFO - Installing collected packages: jsonschema, functools32 22:01:17 INFO - Running setup.py install for functools32 22:01:17 INFO - warning: no files found matching '*.txt' 22:01:17 INFO - no previously-included directories found matching 'build' 22:01:17 INFO - no previously-included directories found matching 'dist' 22:01:17 INFO - no previously-included directories found matching '.git*' 22:01:17 INFO - Successfully installed jsonschema functools32 22:01:17 INFO - Cleaning up... 22:01:17 INFO - Return code: 0 22:01:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:01:17 INFO - Using env: {'DISPLAY': ':0', 22:01:17 INFO - 'HOME': '/home/cltbld', 22:01:17 INFO - 'LANG': 'en_US.UTF-8', 22:01:17 INFO - 'LANGUAGE': 'en_US:en', 22:01:17 INFO - 'LOGNAME': 'cltbld', 22:01:17 INFO - 'MAIL': '/var/mail/cltbld', 22:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:17 INFO - 'MOZ_NO_REMOTE': '1', 22:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:17 INFO - 'NO_EM_RESTART': '1', 22:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:17 INFO - 'PWD': '/builds/slave/test', 22:01:17 INFO - 'SHELL': '/bin/bash', 22:01:17 INFO - 'SHLVL': '1', 22:01:17 INFO - 'TERM': 'linux', 22:01:17 INFO - 'TMOUT': '86400', 22:01:17 INFO - 'USER': 'cltbld', 22:01:17 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:17 INFO - '_': '/tools/buildbot/bin/python'} 22:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:01:17 INFO - Cleaning up... 22:01:17 INFO - Return code: 0 22:01:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:01:17 INFO - Using env: {'DISPLAY': ':0', 22:01:17 INFO - 'HOME': '/home/cltbld', 22:01:17 INFO - 'LANG': 'en_US.UTF-8', 22:01:17 INFO - 'LANGUAGE': 'en_US:en', 22:01:17 INFO - 'LOGNAME': 'cltbld', 22:01:17 INFO - 'MAIL': '/var/mail/cltbld', 22:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:17 INFO - 'MOZ_NO_REMOTE': '1', 22:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:17 INFO - 'NO_EM_RESTART': '1', 22:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:17 INFO - 'PWD': '/builds/slave/test', 22:01:17 INFO - 'SHELL': '/bin/bash', 22:01:17 INFO - 'SHLVL': '1', 22:01:17 INFO - 'TERM': 'linux', 22:01:17 INFO - 'TMOUT': '86400', 22:01:17 INFO - 'USER': 'cltbld', 22:01:17 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:17 INFO - '_': '/tools/buildbot/bin/python'} 22:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:18 INFO - Downloading/unpacking blobuploader==1.2.4 22:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:20 INFO - Downloading blobuploader-1.2.4.tar.gz 22:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:01:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:01:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 INFO - Downloading docopt-0.6.1.tar.gz 22:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:01:20 INFO - Installing collected packages: blobuploader, requests, docopt 22:01:20 INFO - Running setup.py install for blobuploader 22:01:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:01:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:01:21 INFO - Running setup.py install for requests 22:01:21 INFO - Running setup.py install for docopt 22:01:21 INFO - Successfully installed blobuploader requests docopt 22:01:21 INFO - Cleaning up... 22:01:21 INFO - Return code: 0 22:01:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:21 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 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01:21 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 22:01:21 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 22:01:21 INFO - Using env: {'DISPLAY': ':0', 22:01:21 INFO - 'HOME': '/home/cltbld', 22:01:21 INFO - 'LANG': 'en_US.UTF-8', 22:01:21 INFO - 'LANGUAGE': 'en_US:en', 22:01:21 INFO - 'LOGNAME': 'cltbld', 22:01:21 INFO - 'MAIL': '/var/mail/cltbld', 22:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:21 INFO - 'MOZ_NO_REMOTE': '1', 22:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:21 INFO - 'NO_EM_RESTART': '1', 22:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:21 INFO - 'PWD': '/builds/slave/test', 22:01:21 INFO - 'SHELL': '/bin/bash', 22:01:21 INFO - 'SHLVL': '1', 22:01:21 INFO - 'TERM': 'linux', 22:01:21 INFO - 'TMOUT': '86400', 22:01:21 INFO - 'USER': 'cltbld', 22:01:21 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:21 INFO - '_': '/tools/buildbot/bin/python'} 22:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:21 INFO - Running setup.py (path:/tmp/pip-wyzQua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:21 INFO - Running setup.py (path:/tmp/pip-V1risV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:21 INFO - Running setup.py (path:/tmp/pip-Jj5yfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:21 INFO - Running setup.py (path:/tmp/pip-6B7pHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:22 INFO - Running setup.py (path:/tmp/pip-vw8sB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:22 INFO - Running setup.py (path:/tmp/pip-cxn4Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:22 INFO - Running setup.py (path:/tmp/pip-ZitC5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:22 INFO - Running setup.py (path:/tmp/pip-Sv4UZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:22 INFO - Running setup.py (path:/tmp/pip-CdQS1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:22 INFO - Running setup.py (path:/tmp/pip-3jeIAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:22 INFO - Running setup.py (path:/tmp/pip-109_yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:22 INFO - Running setup.py (path:/tmp/pip-6TnWkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:22 INFO - Running setup.py (path:/tmp/pip-4FlcNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:22 INFO - Running setup.py (path:/tmp/pip-OFcV66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:22 INFO - Running setup.py (path:/tmp/pip-T9aKEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:22 INFO - Running setup.py (path:/tmp/pip-7djHED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:22 INFO - Running setup.py (path:/tmp/pip-hxMzGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:01:22 INFO - Running setup.py install for manifestparser 22:01:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:01:23 INFO - Running setup.py install for mozcrash 22:01:23 INFO - Running setup.py install for mozdebug 22:01:23 INFO - Running setup.py install for mozdevice 22:01:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:01:23 INFO - Running setup.py install for mozfile 22:01:23 INFO - Running setup.py install for mozhttpd 22:01:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:01:23 INFO - Running setup.py install for mozinfo 22:01:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:01:23 INFO - Running setup.py install for mozInstall 22:01:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:01:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:01:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:01:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:01:23 INFO - Running setup.py install for mozleak 22:01:23 INFO - Running setup.py install for mozlog 22:01:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:01:23 INFO - Running setup.py install for moznetwork 22:01:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:01:24 INFO - Running setup.py install for mozprocess 22:01:24 INFO - Running setup.py install for mozprofile 22:01:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:01:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:01:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:01:24 INFO - Running setup.py install for mozrunner 22:01:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:01:24 INFO - Running setup.py install for mozscreenshot 22:01:24 INFO - Running setup.py install for moztest 22:01:24 INFO - Running setup.py install for mozversion 22:01:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:01:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:24 INFO - Cleaning up... 22:01:24 INFO - Return code: 0 22:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:24 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 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01:24 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 22:01:24 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 22:01:24 INFO - Using env: {'DISPLAY': ':0', 22:01:24 INFO - 'HOME': '/home/cltbld', 22:01:24 INFO - 'LANG': 'en_US.UTF-8', 22:01:24 INFO - 'LANGUAGE': 'en_US:en', 22:01:24 INFO - 'LOGNAME': 'cltbld', 22:01:24 INFO - 'MAIL': '/var/mail/cltbld', 22:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:24 INFO - 'MOZ_NO_REMOTE': '1', 22:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:24 INFO - 'NO_EM_RESTART': '1', 22:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:24 INFO - 'PWD': '/builds/slave/test', 22:01:24 INFO - 'SHELL': '/bin/bash', 22:01:24 INFO - 'SHLVL': '1', 22:01:24 INFO - 'TERM': 'linux', 22:01:24 INFO - 'TMOUT': '86400', 22:01:24 INFO - 'USER': 'cltbld', 22:01:24 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:24 INFO - '_': '/tools/buildbot/bin/python'} 22:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:24 INFO - Running setup.py (path:/tmp/pip-mFEP2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:25 INFO - Running setup.py (path:/tmp/pip-rPHJSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:25 INFO - Running setup.py (path:/tmp/pip-c30w1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:25 INFO - Running setup.py (path:/tmp/pip-T5CsL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:25 INFO - Running setup.py (path:/tmp/pip-GKnT9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:25 INFO - Running setup.py (path:/tmp/pip-xWwfRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:25 INFO - Running setup.py (path:/tmp/pip-WlUZzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:25 INFO - Running setup.py (path:/tmp/pip-wNthgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:25 INFO - Running setup.py (path:/tmp/pip-WmHJ8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:25 INFO - Running setup.py (path:/tmp/pip-_sM8Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:25 INFO - Running setup.py (path:/tmp/pip-jVvLID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:25 INFO - Running setup.py (path:/tmp/pip-0ymQFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:25 INFO - Running setup.py (path:/tmp/pip-kCaWr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:25 INFO - Running setup.py (path:/tmp/pip-KU_zXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:25 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)) 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:25 INFO - Running setup.py (path:/tmp/pip-4_RyVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:26 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)) 22:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:26 INFO - Running setup.py (path:/tmp/pip-zof3ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:26 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)) 22:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:26 INFO - Running setup.py (path:/tmp/pip-SWO_Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:26 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)) 22:01:26 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)) 22:01:26 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)) 22:01:26 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)) 22:01:26 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)) 22:01:26 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)) 22:01:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:28 INFO - Downloading blessings-1.6.tar.gz 22:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:28 INFO - Installing collected packages: blessings 22:01:28 INFO - Running setup.py install for blessings 22:01:28 INFO - Successfully installed blessings 22:01:28 INFO - Cleaning up... 22:01:28 INFO - Return code: 0 22:01:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:01:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:28 INFO - Reading from file tmpfile_stdout 22:01:28 INFO - Current package versions: 22:01:28 INFO - argparse == 1.2.1 22:01:28 INFO - blessings == 1.6 22:01:28 INFO - blobuploader == 1.2.4 22:01:28 INFO - docopt == 0.6.1 22:01:28 INFO - functools32 == 3.2.3-2 22:01:28 INFO - jsonschema == 2.5.1 22:01:28 INFO - manifestparser == 1.1 22:01:28 INFO - mozInstall == 1.12 22:01:28 INFO - mozcrash == 1.0 22:01:28 INFO - mozdebug == 0.1 22:01:28 INFO - mozdevice == 0.49 22:01:28 INFO - mozfile == 1.2 22:01:28 INFO - mozhttpd == 0.7 22:01:28 INFO - mozinfo == 0.9 22:01:28 INFO - mozleak == 0.1 22:01:28 INFO - mozlog == 3.4 22:01:28 INFO - moznetwork == 0.27 22:01:28 INFO - mozprocess == 0.25 22:01:28 INFO - mozprofile == 0.28 22:01:28 INFO - mozrunner == 6.13 22:01:28 INFO - mozscreenshot == 0.1 22:01:28 INFO - mozsystemmonitor == 0.3 22:01:28 INFO - moztest == 0.8 22:01:28 INFO - mozversion == 1.4 22:01:28 INFO - psutil == 3.1.1 22:01:28 INFO - requests == 1.2.3 22:01:28 INFO - wsgiref == 0.1.2 22:01:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:28 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 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01:28 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 22:01:28 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 22:01:28 INFO - Using env: {'DISPLAY': ':0', 22:01:28 INFO - 'HOME': '/home/cltbld', 22:01:28 INFO - 'LANG': 'en_US.UTF-8', 22:01:28 INFO - 'LANGUAGE': 'en_US:en', 22:01:28 INFO - 'LOGNAME': 'cltbld', 22:01:28 INFO - 'MAIL': '/var/mail/cltbld', 22:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:28 INFO - 'MOZ_NO_REMOTE': '1', 22:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:28 INFO - 'NO_EM_RESTART': '1', 22:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:28 INFO - 'PWD': '/builds/slave/test', 22:01:28 INFO - 'SHELL': '/bin/bash', 22:01:28 INFO - 'SHLVL': '1', 22:01:28 INFO - 'TERM': 'linux', 22:01:28 INFO - 'TMOUT': '86400', 22:01:28 INFO - 'USER': 'cltbld', 22:01:28 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:28 INFO - '_': '/tools/buildbot/bin/python'} 22:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 INFO - Cleaning up... 22:01:28 INFO - Return code: 0 22:01:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', '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 22:01: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', 'jsonschema'] in /builds/slave/test/build 22:01: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 jsonschema 22:01:28 INFO - Using env: {'DISPLAY': ':0', 22:01:28 INFO - 'HOME': '/home/cltbld', 22:01:28 INFO - 'LANG': 'en_US.UTF-8', 22:01:28 INFO - 'LANGUAGE': 'en_US:en', 22:01:28 INFO - 'LOGNAME': 'cltbld', 22:01:28 INFO - 'MAIL': '/var/mail/cltbld', 22:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:28 INFO - 'MOZ_NO_REMOTE': '1', 22:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:28 INFO - 'NO_EM_RESTART': '1', 22:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:28 INFO - 'PWD': '/builds/slave/test', 22:01:28 INFO - 'SHELL': '/bin/bash', 22:01:28 INFO - 'SHLVL': '1', 22:01:28 INFO - 'TERM': 'linux', 22:01:28 INFO - 'TMOUT': '86400', 22:01:28 INFO - 'USER': 'cltbld', 22:01:28 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:28 INFO - '_': '/tools/buildbot/bin/python'} 22:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:01:29 INFO - Cleaning up... 22:01:29 INFO - Return code: 0 22:01:29 INFO - Running post-action listener: _resource_record_post_action 22:01:29 INFO - Running post-action listener: _start_resource_monitoring 22:01:29 INFO - Starting resource monitoring. 22:01:29 INFO - [mozharness: 2017-04-06 05:01:29.161563Z] Finished create-virtualenv step (success) 22:01:29 INFO - [mozharness: 2017-04-06 05:01:29.162041Z] Running install step. 22:01:29 INFO - Running pre-action listener: _resource_record_pre_action 22:01:29 INFO - Running main action method: install 22:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:29 INFO - Reading from file tmpfile_stdout 22:01:29 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:01:29 INFO - Reading from file tmpfile_stdout 22:01:29 INFO - Output received: 22:01:29 INFO - Usage: mozinstall [options] installer 22:01:29 INFO - Options: 22:01:29 INFO - -h, --help show this help message and exit 22:01:29 INFO - -d DEST, --destination=DEST 22:01:29 INFO - Directory to install application into. [default: 22:01:29 INFO - "/builds/slave/test"] 22:01:29 INFO - --app=APP Application being installed. [default: firefox] 22:01:29 INFO - mkdir: /builds/slave/test/build/application 22:01:29 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'] 22:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:01:44 INFO - Reading from file tmpfile_stdout 22:01:44 INFO - Output received: 22:01:44 INFO - /builds/slave/test/build/application/firefox/firefox 22:01:44 INFO - Running post-action listener: _resource_record_post_action 22:01:44 INFO - [mozharness: 2017-04-06 05:01:44.157841Z] Finished install step (success) 22:01:44 INFO - [mozharness: 2017-04-06 05:01:44.158115Z] Running run-tests step. 22:01:44 INFO - Running pre-action listener: _resource_record_pre_action 22:01:44 INFO - Running main action method: run_tests 22:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:01:44 INFO - Python 2.7.3 22:01:44 INFO - Return code: 0 22:01:44 INFO - grabbing minidump binary from tooltool 22:01:44 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')]} 22:01:44 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 0x1118290>, '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 0x1118b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1119040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:01:44 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 22:01:44 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 22:01:44 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 22:01:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:44 INFO - Return code: 0 22:01:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:01:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:01:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:01:44 INFO - ENV: RUST_BACKTRACE is now 1 22:01:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:01:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 22:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --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 22:01:44 INFO - Using env: {'DISPLAY': ':0', 22:01:44 INFO - 'HOME': '/home/cltbld', 22:01:44 INFO - 'LANG': 'en_US.UTF-8', 22:01:44 INFO - 'LANGUAGE': 'en_US:en', 22:01:44 INFO - 'LOGNAME': 'cltbld', 22:01:44 INFO - 'MAIL': '/var/mail/cltbld', 22:01:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:01:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:44 INFO - 'MOZ_NO_REMOTE': '1', 22:01:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:44 INFO - 'NO_EM_RESTART': '1', 22:01:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:44 INFO - 'PWD': '/builds/slave/test', 22:01:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:01:44 INFO - 'RUST_BACKTRACE': '1', 22:01:44 INFO - 'SHELL': '/bin/bash', 22:01:44 INFO - 'SHLVL': '1', 22:01:44 INFO - 'TERM': 'linux', 22:01:44 INFO - 'TMOUT': '86400', 22:01:44 INFO - 'USER': 'cltbld', 22:01:44 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831', 22:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:44 INFO - '_': '/tools/buildbot/bin/python'} 22:01:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 22:01:44 INFO - mozversion application_buildid: 20170406043223 22:01:44 INFO - mozversion application_changeset: ec8d1d3db50c85037e8077c32c8403570a5df493 22:01:44 INFO - mozversion application_display_name: Nightly 22:01:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:44 INFO - mozversion application_name: Firefox 22:01:44 INFO - mozversion application_remotingname: firefox 22:01:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:01:44 INFO - mozversion application_vendor: Mozilla 22:01:44 INFO - mozversion application_version: 55.0a1 22:01:44 INFO - mozversion platform_buildid: 20170406043223 22:01:44 INFO - mozversion platform_changeset: ec8d1d3db50c85037e8077c32c8403570a5df493 22:01:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:01:44 INFO - mozversion platform_version: 55.0a1 22:01:44 INFO - using testdate: 1491454904 22:01:44 INFO - actual date: 1491454904 22:01:44 INFO - starting webserver on 'localhost:37817' 22:01:44 INFO - SUITE-START | Running 2 tests 22:01:44 INFO - TEST-START | dromaeo_css 22:01:44 INFO - operating with platform_type : linux_ 22:01:44 INFO - Initialising browser for dromaeo_css test... 22:01:44 INFO - TEST-INFO | started process 27026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS4DJDl/profile http://localhost:37817/getInfo.html) 22:01:48 INFO - PID 27026 | __metrics Screen width/height:1600/1200 22:01:48 INFO - PID 27026 | colorDepth:24 22:01:48 INFO - PID 27026 | Browser inner width/height: 1024/697 22:01:48 INFO - PID 27026 | __metrics 22:01:50 INFO - PID 27026 | 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" 22:01:50 INFO - PID 27026 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:01:51 INFO - TEST-INFO | 27026: exit 0 22:01:51 INFO - Browser initialized. 22:01:51 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:51 INFO - TEST-INFO | started process 27117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS4DJDl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:03 INFO - PID 27117 | RSS: Main: 154796032 22:02:03 INFO - PID 27117 | 22:05:10 INFO - PID 27117 | Cycle 1(1): loaded http://localhost:37817/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37817/tests/dromaeo/cssquery-ext.html) 22:05:12 INFO - PID 27117 | RSS: Main: 318074880 22:05:12 INFO - PID 27117 | 22:06:53 INFO - PID 27117 | ************************* 22:06:53 INFO - PID 27117 | A coding exception was thrown and uncaught in a Task. 22:06:53 INFO - PID 27117 | 22:06:53 ERROR - PID 27117 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:06:53 INFO - PID 27117 | Full stack: 22:06:53 INFO - PID 27117 | ************************* 22:06:53 INFO - PID 27117 | ************************* 22:06:53 INFO - PID 27117 | A coding exception was thrown and uncaught in a Task. 22:06:53 INFO - PID 27117 | 22:06:53 ERROR - PID 27117 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:06:53 INFO - PID 27117 | Full stack: 22:06:53 INFO - PID 27117 | ************************* 22:06:53 INFO - PID 27117 | ************************* 22:06:53 INFO - PID 27117 | A coding exception was thrown and uncaught in a Task. 22:06:53 INFO - PID 27117 | 22:06:53 ERROR - PID 27117 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:06:53 INFO - PID 27117 | Full stack: 22:06:53 INFO - PID 27117 | ************************* 22:06:53 INFO - PID 27117 | ************************* 22:06:53 INFO - PID 27117 | A coding exception was thrown and uncaught in a Task. 22:06:53 INFO - PID 27117 | 22:06:53 ERROR - PID 27117 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:06:53 INFO - PID 27117 | Full stack: 22:06:53 INFO - PID 27117 | ************************* 22:08:14 INFO - PID 27117 | Cycle 1(1): loaded http://localhost:37817/tests/dromaeo/cssquery-ext.html (next: http://localhost:37817/tests/dromaeo/cssquery-jquery.html) 22:08:15 INFO - PID 27117 | RSS: Main: 234369024 22:08:15 INFO - PID 27117 | 22:11:17 INFO - PID 27117 | Cycle 1(1): loaded http://localhost:37817/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37817/tests/dromaeo/cssquery-mootools.html) 22:11:17 INFO - PID 27117 | RSS: Main: 220438528 22:11:17 INFO - PID 27117 | 22:14:19 INFO - PID 27117 | Cycle 1(1): loaded http://localhost:37817/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37817/tests/dromaeo/cssquery-prototype.html) 22:14:20 INFO - PID 27117 | RSS: Main: 178274304 22:14:20 INFO - PID 27117 | 22:17:23 INFO - PID 27117 | Cycle 1(1): loaded http://localhost:37817/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37817/tests/dromaeo/cssquery-yui.html) 22:17:24 INFO - PID 27117 | RSS: Main: 188149760 22:17:24 INFO - PID 27117 | 22:20:26 INFO - PID 27117 | Cycle 1(1): loaded http://localhost:37817/tests/dromaeo/cssquery-yui.html (next: http://localhost:37817/tests/dromaeo/cssquery-dojo.html) 22:20:27 INFO - PID 27117 | RSS: Main: 272031744 22:20:27 INFO - PID 27117 | 22:20:27 INFO - PID 27117 | __start_tp_report 22:20:27 INFO - PID 27117 | _x_x_mozilla_page_load 22:20:27 INFO - PID 27117 | _x_x_mozilla_page_load_details 22:20:27 INFO - PID 27117 | |i|pagename|runs| 22:20:27 INFO - PID 27117 | |0;dojo.html;2678.9196324110276;2709.7696695780855;2734.097747743245;2743.149623616679;2743.2181828178973;5127.743612819353;5189.247559103927;5219.451957544456;5241.056609810242;5276.8153114640945;5194.740262986855;5234.895302093965;5261.184516399954;5306.469353064692;5316.6544174628625;4571.771411429432;4599.218132917412;4636.2118439865135;4746.620270378361;4750.287456881478;4677.83627573035;4688.648351373644;4703.694259873115;4732.361131247289;4804.735739534324;4575.473820510617;4628.703962890396;4645.86062418128;4655.767211639404;4657.836975705834;4618.491965883783;4658.417697787777;4662.976685116552;4663.743494107823;4710.858674239778;4600.907981840344;4624.930626040612;4637.582617564435;4679.181143299909;4689.859304220879;5239.842804715827;5246.317978662788;5265.552428043621;5266.7366631668265;5267.789288428458;5566.2207290979295;5655.773769049233;5676.971615141898;5696.743646535874;5746.569007324468;5682.7442765075675;5699.544036477072;5745.1382292656435;5748.540116790688;5759.020966435716;5283.656562323436;5327.786888524415;5328.520433160957;5330.360356757136;5331.466853314638;5749.54003679713;5835.883282334415;5843.620164689281;5860.648361098348;5937;5569.10894256917;5597.524210442077;5632.04255276604;5652.067408877571;5670.036093863971;5696.829095127153;5711.485966263056;5713.914291285634;5718.085106382959;5720.8283751487525;5607;5669.40471250521;5671;5684.54523638108;5684.971575142098;5543.667379957215;5619.185218143346;5625.746841392147;5648.378678345379;5750.913736293875;4740.597049250783;4758.42898852133;4771.165046116916;4787.784549695272;4788.7366194859615;3989.7007724420782;4038.63652271297;4039.3335099708806;4066.79666016698;4093.2427500912427;4731.408573928259;4889.168841296988;4892.486288939681;4894.559489645949;4915.26271059344;5615.326160860641;5663.405342439067;5683.2895888014;5687.40282270364;5735.713214339266;4876.439209490883;4886;4892.3884514435695;4900;4930.235813448921;5083.517065878736;5087.3386459759995;5089.3638295213095;5101.234814777813;5102.540771330598;5244.659097158673;5330.227117067926;5351.277577527139;5353.384360798403;5396.0556902542685;5637.154426835843;5692.658440493584;5759.308882934075;5775.5090817281;5826.796062137974;5320.228566857862;5337.839864804062;5386.48828361305;5414.891702166014;5415.702136382537;5626.5780066496;5639.379668236573;5646.265985421869;5652.378238393691;5653.491185793134;5616.634918730269;5700.857478563069;5761.078227483583;5778.046622307273;5782.2942232040805;5514;5547.916781248204;5606.467385598362;5619.157126431068;5620.85947851307;5540;5552.194931734956;5552.222688823487;5554.888902222014;5557.861053473695;5462.371827239918;5491.28613280271;5500.3949565548555;5503.504684578247;5553.666779993213;5464.371597266365;5504.9174262385295;5550.167474878801;5551.389347171888;5571.7492712828835;5326.067938110893;5359.812406565751;5411.134218525017;5436.809711660073;5532.1425179097305 22:20:27 INFO - PID 27117 | |1;ext.html;642.2966851297828;714.556974675701;741.3253938915586;1048.737815546114;1080.5461706083445;25367.365815854613;31812.522812157807;32182.839085804597;32206.67793322069;32286.67713322866;33611.15972100699;33734.8313258434;34009.659903400956;34061.14847128823;34129.48805767909;5614.522765564931;5741.081426971686;7267.309605587474;7436.888446673304;7447;7157.89263161053;7320.780376588684;7324.597147156905;7327.560346379208;7328.303811137934;7337.926620733804;7425.2574742525585;7426.145993210769;7430.814229644248;7434.925650743505;7335.523190992569;7355.77932662021;7367;7378.151512576069;7393.112826460805;7258.201597824235;7305.342519173247;7332.596707181103;7345.926540734577;7346.926530734678;31444.37111257785;31570.210744731336;31684.524732129037;31693.04920852355;31743;2981.135470713512;2998.5502174673757;3004.4141392428487;3011.909642710722;3020.9879690303774;24162.758372416225;24203.515929681485;24263.87868060666;24313.513729725484;24362.390940226458;2900.5069138246336;2941.4264218477406;2947.1158652404406;2951.557266410034;2960.0231923465203;134622;134646;134889.3255533716;134943;135026;40970;41084;41096;41164.58835411607;41247;41842.79078604587;42019;42343.788281059016;42405;42420.363694544605;11633.88366116328;11636.650900473;11669.766604667859;11705.88294117065;11748.941255293668;7687.5387476751575;7979.241972012649;9288.11762882525;9316.114969077928;9318.767030824149;11410.201285909907;11467.426628668532;11646.76706465866;11711.824322635168;11735.4132293385;4692.554207350297;4741.454732705714;4754.0491901619125;4759.857204283877;4782.282657601388;867.8307729992591;876.9561521923878;887.5074333744705;888.1739981816972;908.7228395339353;19764.523840225393;20384.694229586567;20579.4855128623;20652;21037.579248414946;943.7401069572198;960.0969032655187;973.4256788494822;982.611868312027;992.5781542844262;10444.425556594308;11027.779444411068;11034.337939723642;11052.281601695864;11230.10159187263;182731;183853;184142;184198.0790096041;184984;40208.798956005034;40342.59657403447;40371.59628403679;40386.1922761549;40443.19113617711;1175.4451742960218;1222.1139673736648;1225.2036176485178;1225.4546726706708;1232.2483285196024;18936.242550297833;19152;19977.800221997593;20115.39653810388;20724;29583.556246656746;29601.25996850096;29612.111636650934;29682;29686.851565742898;179380;179487;179607;179733;179916.1004195023;22498.550028999;28269.71730282671;28377.858110709316;28397.574036389884;28458.288542786595;29368.853155734083;31739.365212696077;32682.673173267962;32737.836310818293;32931.83534082314;24809.88355524042;25320.620190697522;26401.471970560866;26980.19059428142;27344.453110938066;26505.867470662524;26618.7338126624;26730.59904101401;27758.16725498238;27808.44383112367;29288;29489;29636;30061;30117.3976520464;25537.74462255428;25858.870705647103;26344.736552634997;26476.470470590095;26989.325266868484;20760.48098797542;21299.78700212978;21374.14503419908;21396.465088372293;21604.45988850291 22:20:27 INFO - PID 27117 | |2;jquery.html;402.92143032108714;424.9213895429345;425.973976690021;435.6950134905566;441.07154439904;17583.38458153965;17984.91007544962;18650.720239196387;18664.16011279492;18721.251149954;18140.092995350213;18316.633667326645;18358.816411835876;18495.07524623767;18497.630047399045;5463.31708536433;5487.780488780454;5592.189132575774;5646.54827613792;5649.406812284713;5554.305711786027;5641.633293835887;5652.717364131798;5656.717164141797;5658.8019419320335;5420.457954204568;5554.750036248358;5624.100143976964;5640.887182256352;5647.407022262665;5431.565474762009;5617.269754931853;5657.57568182388;5666.9716651416475;5675.318961724599;5019.548240658321;5085.186370180753;5085.466026067246;5088.211327244283;5089.338386009795;21565.568688626296;21639.45901352463;21672.783272167235;21675.458113547287;21789.564208715736;1582.1535478519052;1647.8764092693095;1656.1222552047313;1657.5027491752546;1669.6410271791501;14421.134731916118;14423.495177668836;14529.927350363287;14662.853371466255;14825.18461484618;2023.7369142011592;2101.159536185523;2124.5538436928264;2161.3299877038166;2171.29432934297;67036.66481667609;74128.62935685342;91383;92125;93167.28576213754;10528.263021588415;10611.151107911348;10710.357378557312;10943.124550035978;11025.188576912837;15148.469803556822;15149.242537873282;15178.924105379403;15182.392704291704;15194.544163675107;7136.286371362926;7357.632118394166;7423.4061275097865;7500.249975002565;7557;6638.5684930479365;6655.667216639149;6698.497612678971;6830;6899.655017249117;6797.388235058868;6804.183497980175;6828.556143850634;6894.931050689529;6896.724131034703;1944.3583617406223;2001.699745038256;2005.2327787652946;2009.5378063045582;2014.9597008059757;801.5831767480877;846.699421705298;877.5787621941377;884.8806260081003;887.1261807119981;16325;16526.917365413337;16624.58438539022;16844.663106737797;17328.566785830455;851.5529347092826;854.7222152800365;857.6355049104105;861.5390765940192;879.8856148700628;8750.649974001097;9129.908700913038;9343.34596578233;9369.62521499146;9512.239020878313;493375;509017;510050;530039;532052;88260;93353;93876.53061734785;94120.52939735257;94293;1046.4767616191905;1067.2689207892618;1073.238001019285;1077.1275267033727;1077.488193108283;14266.643333916734;16435;18436.26254949787;18443.985580793185;18448.723269150705;43526.56473435225;45406.77296613496;45858.54141458676;46013.309800353694;46042.30936535887;54071.837126514496;54125;54837.725811370685;55215;55764;7977.8404431912195;8136.959315203386;8164.306033987177;8331.333493320399;8586.356023298153;11545.942270288595;12225.449854756735;12898.226106433644;13346.13250138738;13617.22976013112;11194.608188713355;11428.314301141958;11430.82814265287;11545.268209768601;11789.174757767218;10761.461926903467;10928.562857485611;10998.945005274922;11053;11077.612283570037;11579.652610421701;11611.303321800719;11716.238444501421;11895;12204;7924.722634707758;8036.87944680842;8236.876446853183;8267.338612910833;8335.367524347876;10700.250982431155;10800.891991079989;10827;11186.105111591216;11227.55089796399 22:20:27 INFO - PID 27117 | |3;mootools.html;1290.2903403128278;1360.8026836108766;1361.9591412257623;1371.1635902099724;1373.1006190944931;9774.31579789415;10143.188544916407;10162.441065741381;10165.440900750456;10171.542280597381;9879.802403951917;9987.550560224789;10080.949595252014;10195.694129176118;10202.438865862374;2240.271911628723;2306.9538609227807;2308.8730119843403;2310.514791893696;2315.80315673168;1956.1979588368772;2195.4182141732454;2271.136967952176;2315.2012555668266;2317.44381348476;2000.0899590686276;2233.2630232023394;2325.360525855386;2337.5208082343165;2342.273895092518;2179.0738935952318;2243.517643706603;2250.8424410291286;2252.0203711385434;2256.17649557911;2152.5156839711094;2159.946001349963;2160.91356345746;2161.848670593059;2161.945951351213;9628.71113866585;9711.465869377182;9714.31999760017;9733.2213422926;9740.415575065448;5612.158176273591;5833.591648584601;5835.912461313083;5842.5618078644275;5844.386339434341;3237.902862914116;3463.5324231228715;3616.385214513539;3663.816809159558;3672.797996110213;1062.8352605346183;1070.8072546941548;1079.4309543286927;1097.6158344579412;1099.8405231241504;14634;15044.623884402868;15047.021943573633;15061.548153555521;15071.773923391158;5013.39839219296;5047.470015648378;5338.54622357104;5355.758990845344;5373.811916582901;12439.129260951828;12447.875521244852;12455.564055258023;12457.1902826316;12462.501499940083;5869.090291004901;5882.176495290662;5888.440598143256;5891.175235467038;5897.2038774765715;5106.540411362921;5143.537081662668;5233.764480598306;5289.70906600133;5309.070912590281;3889.844406223776;3902.297586434469;3933.292007438631;4003.159336539359;4038.1519880825354;1097.2319376436526;1142.194752699345;1156.8553930758655;1168.8480497535265;1178.2341478039343;619.2414292491752;710.9431245500348;719.5898337947319;731.7036600176937;746.1680226547361;6000.489958353589;6156.384361563897;6238.844028899223;6251.281102673251;6360.236771587439;803.9678412863537;811.7645882693953;823.2014945502852;823.3495538524618;827.2875148442786;3752.7373083884413;3780.4140358244517;3797.8101094945696;3869.845206191777;4023.456833327522;12279.324637145042;12811.295378754072;12855.16441431304;12868.227906325463;12887.09790314669;12607.243565385923;12613.810792838114;12625.179363341353;12652.683682907817;12662.556810511587;9152.771180720536;9598;9607.51962401877;9608.375455595364;9612.567434465465;6015.4586087252355;6181.289151747606;6193.102000210034;6370.490360771035;6496.447801936888;11884.58403955892;11996.820047699117;12058.758824823279;12140.089493288215;12291.631251062483;11938.22401543897;12388.938055309665;12413.317267550372;12437.689057773629;12469.127161098637;8429.873551896604;8437.789055273668;8608.397412181088;8618.224359807647;8622.568871556272;9248.722538323862;9367.250619950524;9371.062893710574;9391.107844754737;9401.952990235006;8130.593470326342;8202.589870506332;8269.586520674062;8324.6670133194;8512.276456501018;7928.682852686059;7970.003749531309;8047.87928181066;8092.150324215872;8129.4715843469985;7124.073870396815;7152.713891444284;7152.9284707152265;7210.351068403869;7255;5009.123403404316;5029.748512574283;5076.543111120017;5204.193350030751;5222.477752224747;5446.1558458439;5466.972665136808;5493.890122197614;5698.601097923106;5727.570432217517 22:20:27 INFO - PID 27117 | |4;prototype.html;369.94820725098475;387.64336810134677;396.85514787102716;396.85911501416984;399.084101985942;5274.604404669651;5317.494837990394;5332.093544097503;5340.092184328664;5351.4380989996025;4975.950240497594;5221.817236396727;5234;5236.711980841062;5254.106801843686;4031.173609410064;4042.8989275268204;4045.757254564721;4054.97972510137;4073.388991651246;4017.3572228443454;4034.374671925856;4041.737287076345;4050.534188568323;4063.7358571692744;3989.9002524936964;4000.299947509174;4008.939865902014;4014.6386825185728;4033.6974726895455;3808.504894363729;3983.3029219886403;3991.720579559432;3998.280309544281;4007.5391329997133;3513.9297214055578;3529.4882242074755;3532.6290739472242;3533.169705119295;3538.8938331850086;5146.356705411824;5150.995555866608;5152.613553983429;5154.304168937183;5168.302279192299;4564.794584243717;4686.390769199982;4718.221493453576;4766.618670506351;4782.282657601353;5580.441955804427;5596.3284405871145;5621.831345059614;5627.240322556484;5628.746706398222;3990.102226998902;4001.099752555681;4002.8198731057173;4015.4980627421573;4019.8995025124314;5785.247917770705;5892.587518873637;5895.204147440084;5952.553558483131;5965.5525835562075;4038.5355684096116;4041.5150181977765;4050.8125612169097;4058.8782336529953;4066.1054567995584;4081.8775436736946;4091.6931230157857;4091.734037287567;4101.85643502476;4118.608732170439;4525.7510836904285;4666.113438446684;4722.126406614787;4722.338872557844;4750.833720819824;5589.692566908859;5623.971880140573;5633.57748168889;5635.718214089279;5651.6043876928225;1420.7852286295276;1423.366601862182;1434.1180174192796;1437.62621718354;1438.26648409312;920.6455514626917;951.8572214167792;965.3628605120728;983.6508039645965;987.693814917378;4928.7289199093675;4958.42978057528;4966.751662416865;4991.50084991498;5008.273800298936;5854.443827836349;5868.559858010666;5882.3529411764675;5890.67601281925;5890.8821823563285;4851.151048566487;4941.579965702956;4994.925076123861;5008.17365134756;5018.573421259161;3060.540918862144;3097.1018404662846;3114.377124575094;3116.735077518391;3129.3271946531604;5433.864153396196;5447.5641948644015;5493.450654934554;5497.147942068906;5503.064479038493;5731.799387021434;5819.497616025065;5974.940250597525;6006.978813601698;6021.3677563856045;5285.286486324374;5396.62386091552;5427.3758517770175;5430.402655707869;5445.50990410865;5808.651480911159;5825.271841019872;5850.23946886902;5850.23946886902;5880.411958804086;5612.971935140298;5750.223719797774;5751;5773.884522309446;5776.393478684846;5418.864528386822;5448.754806033818;5459.590530710292;5463.890722185613;5485.9725701371235;3974.2250261198787;3975.3639417694185;3976.5029371328583;3980.1840622671702;3987.7009224307712;5620.437956204511;5766.452187042224;5791.594588378773;5851.561132914963;5854.765809367577;5596.300462442195;5598.300212473441;5599.524040456444;5611.130274807411;5633.295838020247;5403.540699040625;5623.8594035149445;5637.43625637433;5639.210510528447;5653.095504719226;5488.792465657549;5496.587755918242;5524.116141417354;5530.281063461885;5539.58453116026;5613.635113717595;5644.911382788395;5649.7740090397565;5656.547476201977;5658.801941932177;5356.839294821161;5479.506844384025;5496.450354964471;5531.197976293495;5583.55331573465 22:20:27 INFO - PID 27117 | |5;yui.html;649.3344322069878;675.1661697803212;679.0968012543318;683.402023229674;694.3091623834285;13390.464381424743;13672.794908076386;14179.574612761608;14185.574432767033;14212.786808197872;13226.669333266673;13567.592972210825;13588.796168057463;13642.386092625831;13649;896.2023798819056;902.5622573052065;907.3331101640289;911.2345629671075;935.0649350649351;960.1982344742148;962.41292811385;962.9422234665907;963.2486660404895;963.3786207895903;991.0485933503845;1000.1398797034544;1001.0690058245829;1002.0230275481421;1002.098111699469;990.6334656177261;990.8216521026212;991.6430085169334;991.6578780320777;992.3202606214766;728.3626826526789;729.3982464466783;729.6534146280527;729.6971756720955;730.218666027351;13521.864781352158;13563.321833908265;13616.727665446635;14375.568732938029;14678.119312841263;13669.384877680528;14412.63968400788;14456.855431445761;14532.927335363362;14557.563273101823;11965.820512692317;11980.161388702794;12105.213161144497;12135.757284854342;12174;2806.0739955814533;2839.8580070996572;2840.3609187932757;2840.7727381809405;2842.2894276430893;64957.3504264956;66725.99911001339;67122.32877671259;67663.66168169127;67822;10067;10079.848802267972;10259.28185027056;10298.382097074049;10613.893861061291;22017.66973495399;22085.779142208372;22099.668504972436;22128.33614991553;22360.776392236196;6474.902876456857;6585.3085426029575;6724.596524208563;6755.392014718699;6846.520743547904;3295.1432627516538;3393.1856354475244;3420.81185534793;3448.6896179343476;3480.408330583756;3660.871869484555;3703.185299234164;3706.369917114097;3734.421164719473;3735.6077611850906;668.6957434367351;674.0327629851179;676.8341756269746;677.1501765284536;678.4606238040769;550.4907960136858;552.5165480204821;566.8752874367633;570.3298624116646;582.6591444005304;7827.45207835446;8124;8345.791355216046;8433.156684331641;8586.527740974181;542.6716836313973;544.0793997189926;552.4530714592524;570.1077813222294;573.4036601933942;3648.7263455240964;3706.6664000240107;3818.6372294631965;3933.704972127102;3958.940615890764;64240.35759642437;64496;66214.66892665505;69824.65087674631;69935;55402.44597554053;57604.42395576074;58739;59110.704446477495;59117.704411477665;49464.752676237105;49650.75174624176;49937.75031124821;50849.389579355186;50912.745436272584;7529.698812047457;7568.167501574932;7612.543247405173;7887.408444366581;7976.993256644235;26640.467190656465;27428;27574.724252757216;27635;28130.71869281281;33433.16417089592;33589.96150577433;33740.65037398575;33858.98423047313;34761.13097172591;9558.56986435626;9665.14878110973;9683.757906052406;9942.453165075991;10281.897181028095;10275.84586231222;10604.310719803188;10876;10885.619003334845;11243.10055195566;9601.279904007088;9890.258230632588;9930.553125109533;10009.74975625586;10065.647702330383;9623.615055397706;9629.711108666752;9907.504624768877;9924.206063515046;10227.181825453798;9450.149486546245;9751.219902407649;9766.609335626496;9769.462679552693;9958.701238962843;7079.433645308466;7099.688084840924;7357.484976051625;7567.508111972704;7589.203133670885;7525.397968162643;7707.383409327353;7813.570253636105;7904.20957904228;8084 22:20:27 INFO - PID 27117 | __end_tp_report 22:20:27 INFO - PID 27117 | __start_cc_report 22:20:27 INFO - PID 27117 | _x_x_mozilla_cycle_collect,1700 22:20:27 INFO - PID 27117 | __end_cc_report 22:20:27 INFO - PID 27117 | __startTimestamp1491456027118__endTimestamp 22:20:27 INFO - PID 27117 | 22:20:27 INFO - PID 27117 | ------- Summary: start ------- 22:20:27 INFO - PID 27117 | Number of tests: 6 22:20:27 INFO - PID 27117 | 22:20:27 INFO - PID 27117 | [#0] dojo.html Cycles:165 Average:5203.60 Median:5359.81 stddev:622.53 (11.6%) stddev-sans-first:592.09 22:20:27 INFO - PID 27117 | Values: 2678.9 2709.8 2734.1 2743.1 2743.2 5127.7 5189.2 5219.5 5241.1 5276.8 5194.7 5234.9 5261.2 5306.5 5316.7 4571.8 4599.2 4636.2 4746.6 4750.3 4677.8 4688.6 4703.7 4732.4 4804.7 4575.5 4628.7 4645.9 4655.8 4657.8 4618.5 4658.4 4663.0 4663.7 4710.9 4600.9 4624.9 4637.6 4679.2 4689.9 5239.8 5246.3 5265.6 5266.7 5267.8 5566.2 5655.8 5677.0 5696.7 5746.6 5682.7 5699.5 5745.1 5748.5 5759.0 5283.7 5327.8 5328.5 5330.4 5331.5 5749.5 5835.9 5843.6 5860.6 5937.0 5569.1 5597.5 5632.0 5652.1 5670.0 5696.8 5711.5 5713.9 5718.1 5720.8 5607.0 5669.4 5671.0 5684.5 5685.0 5543.7 5619.2 5625.7 5648.4 5750.9 4740.6 4758.4 4771.2 4787.8 4788.7 3989.7 4038.6 4039.3 4066.8 4093.2 4731.4 4889.2 4892.5 4894.6 4915.3 5615.3 5663.4 5683.3 5687.4 5735.7 4876.4 4886.0 4892.4 4900.0 4930.2 5083.5 5087.3 5089.4 5101.2 5102.5 5244.7 5330.2 5351.3 5353.4 5396.1 5637.2 5692.7 5759.3 5775.5 5826.8 5320.2 5337.8 5386.5 5414.9 5415.7 5626.6 5639.4 5646.3 5652.4 5653.5 5616.6 5700.9 5761.1 5778.0 5782.3 5514.0 5547.9 5606.5 5619.2 5620.9 5540.0 5552.2 5552.2 5554.9 5557.9 5462.4 5491.3 5500.4 5503.5 5553.7 5464.4 5504.9 5550.2 5551.4 5571.7 5326.1 5359.8 5411.1 5436.8 5532.1 22:20:27 INFO - PID 27117 | 22:20:27 INFO - PID 27117 | [#1] ext.html Cycles:180 Average:30439.07 Median:29684.43 stddev:43390.62 (146.2%) stddev-sans-first:43454.66 22:20:27 INFO - PID 27117 | Values: 642.3 714.6 741.3 1048.7 1080.5 25367.4 31812.5 32182.8 32206.7 32286.7 33611.2 33734.8 34009.7 34061.1 34129.5 5614.5 5741.1 7267.3 7436.9 7447.0 7157.9 7320.8 7324.6 7327.6 7328.3 7337.9 7425.3 7426.1 7430.8 7434.9 7335.5 7355.8 7367.0 7378.2 7393.1 7258.2 7305.3 7332.6 7345.9 7346.9 31444.4 31570.2 31684.5 31693.0 31743.0 2981.1 2998.6 3004.4 3011.9 3021.0 24162.8 24203.5 24263.9 24313.5 24362.4 2900.5 2941.4 2947.1 2951.6 2960.0 134622.0 134646.0 134889.3 134943.0 135026.0 40970.0 41084.0 41096.0 41164.6 41247.0 41842.8 42019.0 42343.8 42405.0 42420.4 11633.9 11636.7 11669.8 11705.9 11748.9 7687.5 7979.2 9288.1 9316.1 9318.8 11410.2 11467.4 11646.8 11711.8 11735.4 4692.6 4741.5 4754.0 4759.9 4782.3 867.8 877.0 887.5 888.2 908.7 19764.5 20384.7 20579.5 20652.0 21037.6 943.7 960.1 973.4 982.6 992.6 10444.4 11027.8 11034.3 11052.3 11230.1 182731.0 183853.0 184142.0 184198.1 184984.0 40208.8 40342.6 40371.6 40386.2 40443.2 1175.4 1222.1 1225.2 1225.5 1232.2 18936.2 19152.0 19977.8 20115.4 20724.0 29583.6 29601.3 29612.1 29682.0 29686.9 179380.0 179487.0 179607.0 179733.0 179916.1 22498.6 28269.7 28377.9 28397.6 28458.3 29368.9 31739.4 32682.7 32737.8 32931.8 24809.9 25320.6 26401.5 26980.2 27344.5 26505.9 26618.7 26730.6 27758.2 27808.4 29288.0 29489.0 29636.0 30061.0 30117.4 25537.7 25858.9 26344.7 26476.5 26989.3 20760.5 21299.8 21374.1 21396.5 21604.5 22:20:27 INFO - PID 27117 | 22:20:27 INFO - PID 27117 | [#2] jquery.html Cycles:180 Average:29588.18 Median:22923.92 stddev:84906.19 (370.4%) stddev-sans-first:85116.10 22:20:27 INFO - PID 27117 | Values: 402.9 424.9 426.0 435.7 441.1 17583.4 17984.9 18650.7 18664.2 18721.3 18140.1 18316.6 18358.8 18495.1 18497.6 5463.3 5487.8 5592.2 5646.5 5649.4 5554.3 5641.6 5652.7 5656.7 5658.8 5420.5 5554.8 5624.1 5640.9 5647.4 5431.6 5617.3 5657.6 5667.0 5675.3 5019.5 5085.2 5085.5 5088.2 5089.3 21565.6 21639.5 21672.8 21675.5 21789.6 1582.2 1647.9 1656.1 1657.5 1669.6 14421.1 14423.5 14529.9 14662.9 14825.2 2023.7 2101.2 2124.6 2161.3 2171.3 67036.7 74128.6 91383.0 92125.0 93167.3 10528.3 10611.2 10710.4 10943.1 11025.2 15148.5 15149.2 15178.9 15182.4 15194.5 7136.3 7357.6 7423.4 7500.2 7557.0 6638.6 6655.7 6698.5 6830.0 6899.7 6797.4 6804.2 6828.6 6894.9 6896.7 1944.4 2001.7 2005.2 2009.5 2015.0 801.6 846.7 877.6 884.9 887.1 16325.0 16526.9 16624.6 16844.7 17328.6 851.6 854.7 857.6 861.5 879.9 8750.6 9129.9 9343.3 9369.6 9512.2 493375.0 509017.0 510050.0 530039.0 532052.0 88260.0 93353.0 93876.5 94120.5 94293.0 1046.5 1067.3 1073.2 1077.1 1077.5 14266.6 16435.0 18436.3 18444.0 18448.7 43526.6 45406.8 45858.5 46013.3 46042.3 54071.8 54125.0 54837.7 55215.0 55764.0 7977.8 8137.0 8164.3 8331.3 8586.4 11545.9 12225.4 12898.2 13346.1 13617.2 11194.6 11428.3 11430.8 11545.3 11789.2 10761.5 10928.6 10998.9 11053.0 11077.6 11579.7 11611.3 11716.2 11895.0 12204.0 7924.7 8036.9 8236.9 8267.3 8335.4 10700.3 10800.9 10827.0 11186.1 11227.6 22:20:27 INFO - PID 27117 | 22:20:27 INFO - PID 27117 | [#3] mootools.html Cycles:180 Average:6411.39 Median:4030.80 stddev:4036.27 (100.1%) stddev-sans-first:4029.24 22:20:27 INFO - PID 27117 | Values: 1290.3 1360.8 1362.0 1371.2 1373.1 9774.3 10143.2 10162.4 10165.4 10171.5 9879.8 9987.6 10080.9 10195.7 10202.4 2240.3 2307.0 2308.9 2310.5 2315.8 1956.2 2195.4 2271.1 2315.2 2317.4 2000.1 2233.3 2325.4 2337.5 2342.3 2179.1 2243.5 2250.8 2252.0 2256.2 2152.5 2159.9 2160.9 2161.8 2161.9 9628.7 9711.5 9714.3 9733.2 9740.4 5612.2 5833.6 5835.9 5842.6 5844.4 3237.9 3463.5 3616.4 3663.8 3672.8 1062.8 1070.8 1079.4 1097.6 1099.8 14634.0 15044.6 15047.0 15061.5 15071.8 5013.4 5047.5 5338.5 5355.8 5373.8 12439.1 12447.9 12455.6 12457.2 12462.5 5869.1 5882.2 5888.4 5891.2 5897.2 5106.5 5143.5 5233.8 5289.7 5309.1 3889.8 3902.3 3933.3 4003.2 4038.2 1097.2 1142.2 1156.9 1168.8 1178.2 619.2 710.9 719.6 731.7 746.2 6000.5 6156.4 6238.8 6251.3 6360.2 804.0 811.8 823.2 823.3 827.3 3752.7 3780.4 3797.8 3869.8 4023.5 12279.3 12811.3 12855.2 12868.2 12887.1 12607.2 12613.8 12625.2 12652.7 12662.6 9152.8 9598.0 9607.5 9608.4 9612.6 6015.5 6181.3 6193.1 6370.5 6496.4 11884.6 11996.8 12058.8 12140.1 12291.6 11938.2 12388.9 12413.3 12437.7 12469.1 8429.9 8437.8 8608.4 8618.2 8622.6 9248.7 9367.3 9371.1 9391.1 9402.0 8130.6 8202.6 8269.6 8324.7 8512.3 7928.7 7970.0 8047.9 8092.2 8129.5 7124.1 7152.7 7152.9 7210.4 7255.0 5009.1 5029.7 5076.5 5204.2 5222.5 5446.2 5467.0 5493.9 5698.6 5727.6 22:20:27 INFO - PID 27117 | 22:20:27 INFO - PID 27117 | [#4] prototype.html Cycles:180 Average:4639.95 Median:5279.95 stddev:1365.20 (25.9%) stddev-sans-first:1330.87 22:20:27 INFO - PID 27117 | Values: 369.9 387.6 396.9 396.9 399.1 5274.6 5317.5 5332.1 5340.1 5351.4 4976.0 5221.8 5234.0 5236.7 5254.1 4031.2 4042.9 4045.8 4055.0 4073.4 4017.4 4034.4 4041.7 4050.5 4063.7 3989.9 4000.3 4008.9 4014.6 4033.7 3808.5 3983.3 3991.7 3998.3 4007.5 3513.9 3529.5 3532.6 3533.2 3538.9 5146.4 5151.0 5152.6 5154.3 5168.3 4564.8 4686.4 4718.2 4766.6 4782.3 5580.4 5596.3 5621.8 5627.2 5628.7 3990.1 4001.1 4002.8 4015.5 4019.9 5785.2 5892.6 5895.2 5952.6 5965.6 4038.5 4041.5 4050.8 4058.9 4066.1 4081.9 4091.7 4091.7 4101.9 4118.6 4525.8 4666.1 4722.1 4722.3 4750.8 5589.7 5624.0 5633.6 5635.7 5651.6 1420.8 1423.4 1434.1 1437.6 1438.3 920.6 951.9 965.4 983.7 987.7 4928.7 4958.4 4966.8 4991.5 5008.3 5854.4 5868.6 5882.4 5890.7 5890.9 4851.2 4941.6 4994.9 5008.2 5018.6 3060.5 3097.1 3114.4 3116.7 3129.3 5433.9 5447.6 5493.5 5497.1 5503.1 5731.8 5819.5 5974.9 6007.0 6021.4 5285.3 5396.6 5427.4 5430.4 5445.5 5808.7 5825.3 5850.2 5850.2 5880.4 5613.0 5750.2 5751.0 5773.9 5776.4 5418.9 5448.8 5459.6 5463.9 5486.0 3974.2 3975.4 3976.5 3980.2 3987.7 5620.4 5766.5 5791.6 5851.6 5854.8 5596.3 5598.3 5599.5 5611.1 5633.3 5403.5 5623.9 5637.4 5639.2 5653.1 5488.8 5496.6 5524.1 5530.3 5539.6 5613.6 5644.9 5649.8 5656.5 5658.8 5356.8 5479.5 5496.5 5531.2 5583.6 22:20:27 INFO - PID 27117 | 22:20:27 INFO - PID 27117 | [#5] yui.html Cycles:180 Average:14229.60 Median:570.22 stddev:18168.73 (3186.3%) stddev-sans-first:18191.08 22:20:27 INFO - PID 27117 | Values: 649.3 675.2 679.1 683.4 694.3 13390.5 13672.8 14179.6 14185.6 14212.8 13226.7 13567.6 13588.8 13642.4 13649.0 896.2 902.6 907.3 911.2 935.1 960.2 962.4 962.9 963.2 963.4 991.0 1000.1 1001.1 1002.0 1002.1 990.6 990.8 991.6 991.7 992.3 728.4 729.4 729.7 729.7 730.2 13521.9 13563.3 13616.7 14375.6 14678.1 13669.4 14412.6 14456.9 14532.9 14557.6 11965.8 11980.2 12105.2 12135.8 12174.0 2806.1 2839.9 2840.4 2840.8 2842.3 64957.4 66726.0 67122.3 67663.7 67822.0 10067.0 10079.8 10259.3 10298.4 10613.9 22017.7 22085.8 22099.7 22128.3 22360.8 6474.9 6585.3 6724.6 6755.4 6846.5 3295.1 3393.2 3420.8 3448.7 3480.4 3660.9 3703.2 3706.4 3734.4 3735.6 668.7 674.0 676.8 677.2 678.5 550.5 552.5 566.9 570.3 582.7 7827.5 8124.0 8345.8 8433.2 8586.5 542.7 544.1 552.5 570.1 573.4 3648.7 3706.7 3818.6 3933.7 3958.9 64240.4 64496.0 66214.7 69824.7 69935.0 55402.4 57604.4 58739.0 59110.7 59117.7 49464.8 49650.8 49937.8 50849.4 50912.7 7529.7 7568.2 7612.5 7887.4 7977.0 26640.5 27428.0 27574.7 27635.0 28130.7 33433.2 33590.0 33740.7 33859.0 34761.1 9558.6 9665.1 9683.8 9942.5 10281.9 10275.8 10604.3 10876.0 10885.6 11243.1 9601.3 9890.3 9930.6 10009.7 10065.6 9623.6 9629.7 9907.5 9924.2 10227.2 9450.1 9751.2 9766.6 9769.5 9958.7 7079.4 7099.7 7357.5 7567.5 7589.2 7525.4 7707.4 7813.6 7904.2 8084.0 22:20:27 INFO - PID 27117 | -------- Summary: end -------- 22:20:27 INFO - PID 27117 | 22:20:27 INFO - TEST-INFO | 27117: exit 0 22:20:27 INFO - TEST-OK | dromaeo_css | took 1123471ms 22:20:27 INFO - TEST-START | kraken 22:20:27 INFO - operating with platform_type : linux_ 22:20:27 INFO - Initialising browser for kraken test... 22:20:27 INFO - TEST-INFO | started process 27440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplEodY2/profile http://localhost:37817/getInfo.html) 22:20:32 INFO - PID 27440 | __metrics Screen width/height:1600/1200 22:20:32 INFO - PID 27440 | colorDepth:24 22:20:32 INFO - PID 27440 | Browser inner width/height: 1024/697 22:20:32 INFO - PID 27440 | __metrics 22:20:33 INFO - PID 27440 | 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" 22:20:33 INFO - PID 27440 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:20:34 INFO - TEST-INFO | 27440: exit 0 22:20:34 INFO - Browser initialized. 22:20:34 INFO - Running cycle 1/1 for kraken test... 22:20:34 INFO - TEST-INFO | started process 27534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplEodY2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:46 INFO - PID 27534 | RSS: Main: 154267648 22:20:46 INFO - PID 27534 | 22:20:49 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37817/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:50 INFO - PID 27534 | RSS: Main: 209354752 22:20:50 INFO - PID 27534 | 22:20:53 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37817/tests/kraken/driver.html?testName=audio-dft) 22:20:53 INFO - PID 27534 | RSS: Main: 188932096 22:20:53 INFO - PID 27534 | 22:20:57 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37817/tests/kraken/driver.html?testName=audio-fft) 22:20:57 INFO - PID 27534 | RSS: Main: 271122432 22:20:57 INFO - PID 27534 | 22:20:59 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37817/tests/kraken/driver.html?testName=audio-oscillator) 22:21:00 INFO - PID 27534 | RSS: Main: 180740096 22:21:00 INFO - PID 27534 | 22:21:02 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37817/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:21:03 INFO - PID 27534 | RSS: Main: 185102336 22:21:03 INFO - PID 27534 | 22:21:06 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37817/tests/kraken/driver.html?testName=imaging-darkroom) 22:21:07 INFO - PID 27534 | RSS: Main: 224522240 22:21:07 INFO - PID 27534 | 22:21:10 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37817/tests/kraken/driver.html?testName=imaging-desaturate) 22:21:11 INFO - PID 27534 | RSS: Main: 219185152 22:21:11 INFO - PID 27534 | 22:21:14 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37817/tests/kraken/driver.html?testName=json-parse-financial) 22:21:14 INFO - PID 27534 | RSS: Main: 221093888 22:21:14 INFO - PID 27534 | 22:21:16 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37817/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:17 INFO - PID 27534 | RSS: Main: 184668160 22:21:17 INFO - PID 27534 | 22:21:18 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37817/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:19 INFO - PID 27534 | RSS: Main: 191545344 22:21:19 INFO - PID 27534 | 22:21:21 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37817/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:22 INFO - PID 27534 | RSS: Main: 201363456 22:21:22 INFO - PID 27534 | 22:21:25 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:26 INFO - PID 27534 | RSS: Main: 210079744 22:21:26 INFO - PID 27534 | 22:21:29 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:29 INFO - PID 27534 | RSS: Main: 206757888 22:21:29 INFO - PID 27534 | 22:21:31 INFO - PID 27534 | Cycle 1(1): loaded http://localhost:37817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37817/tests/kraken/driver.html?testName=ai-astar) 22:21:32 INFO - PID 27534 | RSS: Main: 275570688 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | __start_tp_report 22:21:32 INFO - PID 27534 | _x_x_mozilla_page_load 22:21:32 INFO - PID 27534 | _x_x_mozilla_page_load_details 22:21:32 INFO - PID 27534 | |i|pagename|runs| 22:21:32 INFO - PID 27534 | |0;ai-astar;105;115;112;113;113;114;115;114;113;112 22:21:32 INFO - PID 27534 | |1;audio-beat-detection;150;124;129;183;126;125;129;123;148;125 22:21:32 INFO - PID 27534 | |2;audio-dft;164;164;167;167;165;166;165;166;164;164 22:21:32 INFO - PID 27534 | |3;audio-fft;74;75;76;110;76;77;77;77;95;76 22:21:32 INFO - PID 27534 | |4;audio-oscillator;84;86;104;85;85;86;100;84;85;109 22:21:32 INFO - PID 27534 | |5;imaging-gaussian-blur;114;114;114;114;114;114;113;114;114;114 22:21:32 INFO - PID 27534 | |6;imaging-darkroom;151;151;151;150;150;150;151;151;150;150 22:21:32 INFO - PID 27534 | |7;imaging-desaturate;95;94;96;94;98;95;94;94;94;94 22:21:32 INFO - PID 27534 | |8;json-parse-financial;54;55;55;54;65;55;58;56;54;54 22:21:32 INFO - PID 27534 | |9;json-stringify-tinderbox;56;56;57;59;57;57;57;57;56;56 22:21:32 INFO - PID 27534 | |10;stanford-crypto-aes;84;84;93;91;88;83;83;84;84;83 22:21:32 INFO - PID 27534 | |11;stanford-crypto-ccm;145;136;137;144;145;134;145;144;197;144 22:21:32 INFO - PID 27534 | |12;stanford-crypto-pbkdf2;197;201;199;201;189;205;209;203;203;203 22:21:32 INFO - PID 27534 | |13;stanford-crypto-sha256-iterative;78;72;72;74;72;70;76;72;74;74 22:21:32 INFO - PID 27534 | __end_tp_report 22:21:32 INFO - PID 27534 | __start_cc_report 22:21:32 INFO - PID 27534 | _x_x_mozilla_cycle_collect,1980 22:21:32 INFO - PID 27534 | __end_cc_report 22:21:32 INFO - PID 27534 | __startTimestamp1491456092020__endTimestamp 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | ------- Summary: start ------- 22:21:32 INFO - PID 27534 | Number of tests: 14 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:2.88 (2.5%) stddev-sans-first:1.13 22:21:32 INFO - PID 27534 | Values: 105.0 115.0 112.0 113.0 113.0 114.0 115.0 114.0 113.0 112.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:129.00 stddev:19.15 (14.8%) stddev-sans-first:19.65 22:21:32 INFO - PID 27534 | Values: 150.0 124.0 129.0 183.0 126.0 125.0 129.0 123.0 148.0 125.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:1.23 (0.7%) stddev-sans-first:1.22 22:21:32 INFO - PID 27534 | Values: 164.0 164.0 167.0 167.0 165.0 166.0 165.0 166.0 164.0 164.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.50 stddev:11.76 (15.4%) stddev-sans-first:12.17 22:21:32 INFO - PID 27534 | Values: 74.0 75.0 76.0 110.0 76.0 77.0 77.0 77.0 95.0 76.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:85.00 stddev:9.60 (11.3%) stddev-sans-first:9.86 22:21:32 INFO - PID 27534 | Values: 84.0 86.0 104.0 85.0 85.0 86.0 100.0 84.0 85.0 109.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:21:32 INFO - PID 27534 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 22:21:32 INFO - PID 27534 | Values: 151.0 151.0 151.0 150.0 150.0 150.0 151.0 151.0 150.0 150.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.32 (1.4%) stddev-sans-first:1.39 22:21:32 INFO - PID 27534 | Values: 95.0 94.0 96.0 94.0 98.0 95.0 94.0 94.0 94.0 94.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.00 stddev:3.40 (6.2%) stddev-sans-first:3.53 22:21:32 INFO - PID 27534 | Values: 54.0 55.0 55.0 54.0 65.0 55.0 58.0 56.0 54.0 54.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 22:21:32 INFO - PID 27534 | Values: 56.0 56.0 57.0 59.0 57.0 57.0 57.0 57.0 56.0 56.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.00 stddev:3.65 (4.3%) stddev-sans-first:3.82 22:21:32 INFO - PID 27534 | Values: 84.0 84.0 93.0 91.0 88.0 83.0 83.0 84.0 84.0 83.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:144.50 stddev:18.04 (12.5%) stddev-sans-first:19.12 22:21:32 INFO - PID 27534 | Values: 145.0 136.0 137.0 144.0 145.0 134.0 145.0 144.0 197.0 144.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.00 Median:203.00 stddev:5.33 (2.6%) stddev-sans-first:5.46 22:21:32 INFO - PID 27534 | Values: 197.0 201.0 199.0 201.0 189.0 205.0 209.0 203.0 203.0 203.0 22:21:32 INFO - PID 27534 | 22:21:32 INFO - PID 27534 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:74.00 stddev:2.32 (3.1%) stddev-sans-first:1.76 22:21:32 INFO - PID 27534 | Values: 78.0 72.0 72.0 74.0 72.0 70.0 76.0 72.0 74.0 74.0 22:21:32 INFO - PID 27534 | -------- Summary: end -------- 22:21:32 INFO - PID 27534 | 22:21:33 INFO - TEST-INFO | 27534: exit 0 22:21:33 INFO - TEST-OK | kraken | took 65443ms 22:21:33 INFO - SUITE-END | took 1188s 22:21:33 INFO - Completed test suite (00:19:49) 22:21:33 INFO - javascript benchmark 22:21:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6619.708356139096, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2678.9196324110276, 2709.7696695780855, 2734.097747743245, 2743.149623616679, 2743.2181828178973, 5127.743612819353, 5189.247559103927, 5219.451957544456, 5241.056609810242, 5276.8153114640945, 5194.740262986855, 5234.895302093965, 5261.184516399954, 5306.469353064692, 5316.6544174628625, 4571.771411429432, 4599.218132917412, 4636.2118439865135, 4746.620270378361, 4750.287456881478, 4677.83627573035, 4688.648351373644, 4703.694259873115, 4732.361131247289, 4804.735739534324, 4575.473820510617, 4628.703962890396, 4645.86062418128, 4655.767211639404, 4657.836975705834, 4618.491965883783, 4658.417697787777, 4662.976685116552, 4663.743494107823, 4710.858674239778, 4600.907981840344, 4624.930626040612, 4637.582617564435, 4679.181143299909, 4689.859304220879, 5239.842804715827, 5246.317978662788, 5265.552428043621, 5266.7366631668265, 5267.789288428458, 5566.2207290979295, 5655.773769049233, 5676.971615141898, 5696.743646535874, 5746.569007324468, 5682.7442765075675, 5699.544036477072, 5745.1382292656435, 5748.540116790688, 5759.020966435716, 5283.656562323436, 5327.786888524415, 5328.520433160957, 5330.360356757136, 5331.466853314638, 5749.54003679713, 5835.883282334415, 5843.620164689281, 5860.648361098348, 5937.0, 5569.10894256917, 5597.524210442077, 5632.04255276604, 5652.067408877571, 5670.036093863971, 5696.829095127153, 5711.485966263056, 5713.914291285634, 5718.085106382959, 5720.8283751487525, 5607.0, 5669.40471250521, 5671.0, 5684.54523638108, 5684.971575142098, 5543.667379957215, 5619.185218143346, 5625.746841392147, 5648.378678345379, 5750.913736293875, 4740.597049250783, 4758.42898852133, 4771.165046116916, 4787.784549695272, 4788.7366194859615, 3989.7007724420782, 4038.63652271297, 4039.3335099708806, 4066.79666016698, 4093.2427500912427, 4731.408573928259, 4889.168841296988, 4892.486288939681, 4894.559489645949, 4915.26271059344, 5615.326160860641, 5663.405342439067, 5683.2895888014, 5687.40282270364, 5735.713214339266, 4876.439209490883, 4886.0, 4892.3884514435695, 4900.0, 4930.235813448921, 5083.517065878736, 5087.3386459759995, 5089.3638295213095, 5101.234814777813, 5102.540771330598, 5244.659097158673, 5330.227117067926, 5351.277577527139, 5353.384360798403, 5396.0556902542685, 5637.154426835843, 5692.658440493584, 5759.308882934075, 5775.5090817281, 5826.796062137974, 5320.228566857862, 5337.839864804062, 5386.48828361305, 5414.891702166014, 5415.702136382537, 5626.5780066496, 5639.379668236573, 5646.265985421869, 5652.378238393691, 5653.491185793134, 5616.634918730269, 5700.857478563069, 5761.078227483583, 5778.046622307273, 5782.2942232040805, 5514.0, 5547.916781248204, 5606.467385598362, 5619.157126431068, 5620.85947851307, 5540.0, 5552.194931734956, 5552.222688823487, 5554.888902222014, 5557.861053473695, 5462.371827239918, 5491.28613280271, 5500.3949565548555, 5503.504684578247, 5553.666779993213, 5464.371597266365, 5504.9174262385295, 5550.167474878801, 5551.389347171888, 5571.7492712828835, 5326.067938110893, 5359.812406565751, 5411.134218525017, 5436.809711660073, 5532.1425179097305], "value": 5157.401408108728, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.2966851297828, 714.556974675701, 741.3253938915586, 1048.737815546114, 1080.5461706083445, 25367.365815854613, 31812.522812157807, 32182.839085804597, 32206.67793322069, 32286.67713322866, 33611.15972100699, 33734.8313258434, 34009.659903400956, 34061.14847128823, 34129.48805767909, 5614.522765564931, 5741.081426971686, 7267.309605587474, 7436.888446673304, 7447.0, 7157.89263161053, 7320.780376588684, 7324.597147156905, 7327.560346379208, 7328.303811137934, 7337.926620733804, 7425.2574742525585, 7426.145993210769, 7430.814229644248, 7434.925650743505, 7335.523190992569, 7355.77932662021, 7367.0, 7378.151512576069, 7393.112826460805, 7258.201597824235, 7305.342519173247, 7332.596707181103, 7345.926540734577, 7346.926530734678, 31444.37111257785, 31570.210744731336, 31684.524732129037, 31693.04920852355, 31743.0, 2981.135470713512, 2998.5502174673757, 3004.4141392428487, 3011.909642710722, 3020.9879690303774, 24162.758372416225, 24203.515929681485, 24263.87868060666, 24313.513729725484, 24362.390940226458, 2900.5069138246336, 2941.4264218477406, 2947.1158652404406, 2951.557266410034, 2960.0231923465203, 134622.0, 134646.0, 134889.3255533716, 134943.0, 135026.0, 40970.0, 41084.0, 41096.0, 41164.58835411607, 41247.0, 41842.79078604587, 42019.0, 42343.788281059016, 42405.0, 42420.363694544605, 11633.88366116328, 11636.650900473, 11669.766604667859, 11705.88294117065, 11748.941255293668, 7687.5387476751575, 7979.241972012649, 9288.11762882525, 9316.114969077928, 9318.767030824149, 11410.201285909907, 11467.426628668532, 11646.76706465866, 11711.824322635168, 11735.4132293385, 4692.554207350297, 4741.454732705714, 4754.0491901619125, 4759.857204283877, 4782.282657601388, 867.8307729992591, 876.9561521923878, 887.5074333744705, 888.1739981816972, 908.7228395339353, 19764.523840225393, 20384.694229586567, 20579.4855128623, 20652.0, 21037.579248414946, 943.7401069572198, 960.0969032655187, 973.4256788494822, 982.611868312027, 992.5781542844262, 10444.425556594308, 11027.779444411068, 11034.337939723642, 11052.281601695864, 11230.10159187263, 182731.0, 183853.0, 184142.0, 184198.0790096041, 184984.0, 40208.798956005034, 40342.59657403447, 40371.59628403679, 40386.1922761549, 40443.19113617711, 1175.4451742960218, 1222.1139673736648, 1225.2036176485178, 1225.4546726706708, 1232.2483285196024, 18936.242550297833, 19152.0, 19977.800221997593, 20115.39653810388, 20724.0, 29583.556246656746, 29601.25996850096, 29612.111636650934, 29682.0, 29686.851565742898, 179380.0, 179487.0, 179607.0, 179733.0, 179916.1004195023, 22498.550028999, 28269.71730282671, 28377.858110709316, 28397.574036389884, 28458.288542786595, 29368.853155734083, 31739.365212696077, 32682.673173267962, 32737.836310818293, 32931.83534082314, 24809.88355524042, 25320.620190697522, 26401.471970560866, 26980.19059428142, 27344.453110938066, 26505.867470662524, 26618.7338126624, 26730.59904101401, 27758.16725498238, 27808.44383112367, 29288.0, 29489.0, 29636.0, 30061.0, 30117.3976520464, 25537.74462255428, 25858.870705647103, 26344.736552634997, 26476.470470590095, 26989.325266868484, 20760.48098797542, 21299.78700212978, 21374.14503419908, 21396.465088372293, 21604.45988850291], "value": 14178.542994560677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.92143032108714, 424.9213895429345, 425.973976690021, 435.6950134905566, 441.07154439904, 17583.38458153965, 17984.91007544962, 18650.720239196387, 18664.16011279492, 18721.251149954, 18140.092995350213, 18316.633667326645, 18358.816411835876, 18495.07524623767, 18497.630047399045, 5463.31708536433, 5487.780488780454, 5592.189132575774, 5646.54827613792, 5649.406812284713, 5554.305711786027, 5641.633293835887, 5652.717364131798, 5656.717164141797, 5658.8019419320335, 5420.457954204568, 5554.750036248358, 5624.100143976964, 5640.887182256352, 5647.407022262665, 5431.565474762009, 5617.269754931853, 5657.57568182388, 5666.9716651416475, 5675.318961724599, 5019.548240658321, 5085.186370180753, 5085.466026067246, 5088.211327244283, 5089.338386009795, 21565.568688626296, 21639.45901352463, 21672.783272167235, 21675.458113547287, 21789.564208715736, 1582.1535478519052, 1647.8764092693095, 1656.1222552047313, 1657.5027491752546, 1669.6410271791501, 14421.134731916118, 14423.495177668836, 14529.927350363287, 14662.853371466255, 14825.18461484618, 2023.7369142011592, 2101.159536185523, 2124.5538436928264, 2161.3299877038166, 2171.29432934297, 67036.66481667609, 74128.62935685342, 91383.0, 92125.0, 93167.28576213754, 10528.263021588415, 10611.151107911348, 10710.357378557312, 10943.124550035978, 11025.188576912837, 15148.469803556822, 15149.242537873282, 15178.924105379403, 15182.392704291704, 15194.544163675107, 7136.286371362926, 7357.632118394166, 7423.4061275097865, 7500.249975002565, 7557.0, 6638.5684930479365, 6655.667216639149, 6698.497612678971, 6830.0, 6899.655017249117, 6797.388235058868, 6804.183497980175, 6828.556143850634, 6894.931050689529, 6896.724131034703, 1944.3583617406223, 2001.699745038256, 2005.2327787652946, 2009.5378063045582, 2014.9597008059757, 801.5831767480877, 846.699421705298, 877.5787621941377, 884.8806260081003, 887.1261807119981, 16325.0, 16526.917365413337, 16624.58438539022, 16844.663106737797, 17328.566785830455, 851.5529347092826, 854.7222152800365, 857.6355049104105, 861.5390765940192, 879.8856148700628, 8750.649974001097, 9129.908700913038, 9343.34596578233, 9369.62521499146, 9512.239020878313, 493375.0, 509017.0, 510050.0, 530039.0, 532052.0, 88260.0, 93353.0, 93876.53061734785, 94120.52939735257, 94293.0, 1046.4767616191905, 1067.2689207892618, 1073.238001019285, 1077.1275267033727, 1077.488193108283, 14266.643333916734, 16435.0, 18436.26254949787, 18443.985580793185, 18448.723269150705, 43526.56473435225, 45406.77296613496, 45858.54141458676, 46013.309800353694, 46042.30936535887, 54071.837126514496, 54125.0, 54837.725811370685, 55215.0, 55764.0, 7977.8404431912195, 8136.959315203386, 8164.306033987177, 8331.333493320399, 8586.356023298153, 11545.942270288595, 12225.449854756735, 12898.226106433644, 13346.13250138738, 13617.22976013112, 11194.608188713355, 11428.314301141958, 11430.82814265287, 11545.268209768601, 11789.174757767218, 10761.461926903467, 10928.562857485611, 10998.945005274922, 11053.0, 11077.612283570037, 11579.652610421701, 11611.303321800719, 11716.238444501421, 11895.0, 12204.0, 7924.722634707758, 8036.87944680842, 8236.876446853183, 8267.338612910833, 8335.367524347876, 10700.250982431155, 10800.891991079989, 10827.0, 11186.105111591216, 11227.55089796399], "value": 9030.083716371382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.2903403128278, 1360.8026836108766, 1361.9591412257623, 1371.1635902099724, 1373.1006190944931, 9774.31579789415, 10143.188544916407, 10162.441065741381, 10165.440900750456, 10171.542280597381, 9879.802403951917, 9987.550560224789, 10080.949595252014, 10195.694129176118, 10202.438865862374, 2240.271911628723, 2306.9538609227807, 2308.8730119843403, 2310.514791893696, 2315.80315673168, 1956.1979588368772, 2195.4182141732454, 2271.136967952176, 2315.2012555668266, 2317.44381348476, 2000.0899590686276, 2233.2630232023394, 2325.360525855386, 2337.5208082343165, 2342.273895092518, 2179.0738935952318, 2243.517643706603, 2250.8424410291286, 2252.0203711385434, 2256.17649557911, 2152.5156839711094, 2159.946001349963, 2160.91356345746, 2161.848670593059, 2161.945951351213, 9628.71113866585, 9711.465869377182, 9714.31999760017, 9733.2213422926, 9740.415575065448, 5612.158176273591, 5833.591648584601, 5835.912461313083, 5842.5618078644275, 5844.386339434341, 3237.902862914116, 3463.5324231228715, 3616.385214513539, 3663.816809159558, 3672.797996110213, 1062.8352605346183, 1070.8072546941548, 1079.4309543286927, 1097.6158344579412, 1099.8405231241504, 14634.0, 15044.623884402868, 15047.021943573633, 15061.548153555521, 15071.773923391158, 5013.39839219296, 5047.470015648378, 5338.54622357104, 5355.758990845344, 5373.811916582901, 12439.129260951828, 12447.875521244852, 12455.564055258023, 12457.1902826316, 12462.501499940083, 5869.090291004901, 5882.176495290662, 5888.440598143256, 5891.175235467038, 5897.2038774765715, 5106.540411362921, 5143.537081662668, 5233.764480598306, 5289.70906600133, 5309.070912590281, 3889.844406223776, 3902.297586434469, 3933.292007438631, 4003.159336539359, 4038.1519880825354, 1097.2319376436526, 1142.194752699345, 1156.8553930758655, 1168.8480497535265, 1178.2341478039343, 619.2414292491752, 710.9431245500348, 719.5898337947319, 731.7036600176937, 746.1680226547361, 6000.489958353589, 6156.384361563897, 6238.844028899223, 6251.281102673251, 6360.236771587439, 803.9678412863537, 811.7645882693953, 823.2014945502852, 823.3495538524618, 827.2875148442786, 3752.7373083884413, 3780.4140358244517, 3797.8101094945696, 3869.845206191777, 4023.456833327522, 12279.324637145042, 12811.295378754072, 12855.16441431304, 12868.227906325463, 12887.09790314669, 12607.243565385923, 12613.810792838114, 12625.179363341353, 12652.683682907817, 12662.556810511587, 9152.771180720536, 9598.0, 9607.51962401877, 9608.375455595364, 9612.567434465465, 6015.4586087252355, 6181.289151747606, 6193.102000210034, 6370.490360771035, 6496.447801936888, 11884.58403955892, 11996.820047699117, 12058.758824823279, 12140.089493288215, 12291.631251062483, 11938.22401543897, 12388.938055309665, 12413.317267550372, 12437.689057773629, 12469.127161098637, 8429.873551896604, 8437.789055273668, 8608.397412181088, 8618.224359807647, 8622.568871556272, 9248.722538323862, 9367.250619950524, 9371.062893710574, 9391.107844754737, 9401.952990235006, 8130.593470326342, 8202.589870506332, 8269.586520674062, 8324.6670133194, 8512.276456501018, 7928.682852686059, 7970.003749531309, 8047.87928181066, 8092.150324215872, 8129.4715843469985, 7124.073870396815, 7152.713891444284, 7152.9284707152265, 7210.351068403869, 7255.0, 5009.123403404316, 5029.748512574283, 5076.543111120017, 5204.193350030751, 5222.477752224747, 5446.1558458439, 5466.972665136808, 5493.890122197614, 5698.601097923106, 5727.570432217517], "value": 4846.046281905376, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.94820725098475, 387.64336810134677, 396.85514787102716, 396.85911501416984, 399.084101985942, 5274.604404669651, 5317.494837990394, 5332.093544097503, 5340.092184328664, 5351.4380989996025, 4975.950240497594, 5221.817236396727, 5234.0, 5236.711980841062, 5254.106801843686, 4031.173609410064, 4042.8989275268204, 4045.757254564721, 4054.97972510137, 4073.388991651246, 4017.3572228443454, 4034.374671925856, 4041.737287076345, 4050.534188568323, 4063.7358571692744, 3989.9002524936964, 4000.299947509174, 4008.939865902014, 4014.6386825185728, 4033.6974726895455, 3808.504894363729, 3983.3029219886403, 3991.720579559432, 3998.280309544281, 4007.5391329997133, 3513.9297214055578, 3529.4882242074755, 3532.6290739472242, 3533.169705119295, 3538.8938331850086, 5146.356705411824, 5150.995555866608, 5152.613553983429, 5154.304168937183, 5168.302279192299, 4564.794584243717, 4686.390769199982, 4718.221493453576, 4766.618670506351, 4782.282657601353, 5580.441955804427, 5596.3284405871145, 5621.831345059614, 5627.240322556484, 5628.746706398222, 3990.102226998902, 4001.099752555681, 4002.8198731057173, 4015.4980627421573, 4019.8995025124314, 5785.247917770705, 5892.587518873637, 5895.204147440084, 5952.553558483131, 5965.5525835562075, 4038.5355684096116, 4041.5150181977765, 4050.8125612169097, 4058.8782336529953, 4066.1054567995584, 4081.8775436736946, 4091.6931230157857, 4091.734037287567, 4101.85643502476, 4118.608732170439, 4525.7510836904285, 4666.113438446684, 4722.126406614787, 4722.338872557844, 4750.833720819824, 5589.692566908859, 5623.971880140573, 5633.57748168889, 5635.718214089279, 5651.6043876928225, 1420.7852286295276, 1423.366601862182, 1434.1180174192796, 1437.62621718354, 1438.26648409312, 920.6455514626917, 951.8572214167792, 965.3628605120728, 983.6508039645965, 987.693814917378, 4928.7289199093675, 4958.42978057528, 4966.751662416865, 4991.50084991498, 5008.273800298936, 5854.443827836349, 5868.559858010666, 5882.3529411764675, 5890.67601281925, 5890.8821823563285, 4851.151048566487, 4941.579965702956, 4994.925076123861, 5008.17365134756, 5018.573421259161, 3060.540918862144, 3097.1018404662846, 3114.377124575094, 3116.735077518391, 3129.3271946531604, 5433.864153396196, 5447.5641948644015, 5493.450654934554, 5497.147942068906, 5503.064479038493, 5731.799387021434, 5819.497616025065, 5974.940250597525, 6006.978813601698, 6021.3677563856045, 5285.286486324374, 5396.62386091552, 5427.3758517770175, 5430.402655707869, 5445.50990410865, 5808.651480911159, 5825.271841019872, 5850.23946886902, 5850.23946886902, 5880.411958804086, 5612.971935140298, 5750.223719797774, 5751.0, 5773.884522309446, 5776.393478684846, 5418.864528386822, 5448.754806033818, 5459.590530710292, 5463.890722185613, 5485.9725701371235, 3974.2250261198787, 3975.3639417694185, 3976.5029371328583, 3980.1840622671702, 3987.7009224307712, 5620.437956204511, 5766.452187042224, 5791.594588378773, 5851.561132914963, 5854.765809367577, 5596.300462442195, 5598.300212473441, 5599.524040456444, 5611.130274807411, 5633.295838020247, 5403.540699040625, 5623.8594035149445, 5637.43625637433, 5639.210510528447, 5653.095504719226, 5488.792465657549, 5496.587755918242, 5524.116141417354, 5530.281063461885, 5539.58453116026, 5613.635113717595, 5644.911382788395, 5649.7740090397565, 5656.547476201977, 5658.801941932177, 5356.839294821161, 5479.506844384025, 5496.450354964471, 5531.197976293495, 5583.55331573465], "value": 4224.876039016315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.3344322069878, 675.1661697803212, 679.0968012543318, 683.402023229674, 694.3091623834285, 13390.464381424743, 13672.794908076386, 14179.574612761608, 14185.574432767033, 14212.786808197872, 13226.669333266673, 13567.592972210825, 13588.796168057463, 13642.386092625831, 13649.0, 896.2023798819056, 902.5622573052065, 907.3331101640289, 911.2345629671075, 935.0649350649351, 960.1982344742148, 962.41292811385, 962.9422234665907, 963.2486660404895, 963.3786207895903, 991.0485933503845, 1000.1398797034544, 1001.0690058245829, 1002.0230275481421, 1002.098111699469, 990.6334656177261, 990.8216521026212, 991.6430085169334, 991.6578780320777, 992.3202606214766, 728.3626826526789, 729.3982464466783, 729.6534146280527, 729.6971756720955, 730.218666027351, 13521.864781352158, 13563.321833908265, 13616.727665446635, 14375.568732938029, 14678.119312841263, 13669.384877680528, 14412.63968400788, 14456.855431445761, 14532.927335363362, 14557.563273101823, 11965.820512692317, 11980.161388702794, 12105.213161144497, 12135.757284854342, 12174.0, 2806.0739955814533, 2839.8580070996572, 2840.3609187932757, 2840.7727381809405, 2842.2894276430893, 64957.3504264956, 66725.99911001339, 67122.32877671259, 67663.66168169127, 67822.0, 10067.0, 10079.848802267972, 10259.28185027056, 10298.382097074049, 10613.893861061291, 22017.66973495399, 22085.779142208372, 22099.668504972436, 22128.33614991553, 22360.776392236196, 6474.902876456857, 6585.3085426029575, 6724.596524208563, 6755.392014718699, 6846.520743547904, 3295.1432627516538, 3393.1856354475244, 3420.81185534793, 3448.6896179343476, 3480.408330583756, 3660.871869484555, 3703.185299234164, 3706.369917114097, 3734.421164719473, 3735.6077611850906, 668.6957434367351, 674.0327629851179, 676.8341756269746, 677.1501765284536, 678.4606238040769, 550.4907960136858, 552.5165480204821, 566.8752874367633, 570.3298624116646, 582.6591444005304, 7827.45207835446, 8124.0, 8345.791355216046, 8433.156684331641, 8586.527740974181, 542.6716836313973, 544.0793997189926, 552.4530714592524, 570.1077813222294, 573.4036601933942, 3648.7263455240964, 3706.6664000240107, 3818.6372294631965, 3933.704972127102, 3958.940615890764, 64240.35759642437, 64496.0, 66214.66892665505, 69824.65087674631, 69935.0, 55402.44597554053, 57604.42395576074, 58739.0, 59110.704446477495, 59117.704411477665, 49464.752676237105, 49650.75174624176, 49937.75031124821, 50849.389579355186, 50912.745436272584, 7529.698812047457, 7568.167501574932, 7612.543247405173, 7887.408444366581, 7976.993256644235, 26640.467190656465, 27428.0, 27574.724252757216, 27635.0, 28130.71869281281, 33433.16417089592, 33589.96150577433, 33740.65037398575, 33858.98423047313, 34761.13097172591, 9558.56986435626, 9665.14878110973, 9683.757906052406, 9942.453165075991, 10281.897181028095, 10275.84586231222, 10604.310719803188, 10876.0, 10885.619003334845, 11243.10055195566, 9601.279904007088, 9890.258230632588, 9930.553125109533, 10009.74975625586, 10065.647702330383, 9623.615055397706, 9629.711108666752, 9907.504624768877, 9924.206063515046, 10227.181825453798, 9450.149486546245, 9751.219902407649, 9766.609335626496, 9769.462679552693, 9958.701238962843, 7079.433645308466, 7099.688084840924, 7357.484976051625, 7567.508111972704, 7589.203133670885, 7525.397968162643, 7707.383409327353, 7813.570253636105, 7904.20957904228, 8084.0], "value": 6223.659344462188, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 112.0, 113.0, 113.0, 114.0, 115.0, 114.0, 113.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 129.0, 183.0, 126.0, 125.0, 129.0, 123.0, 148.0, 125.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 167.0, 167.0, 165.0, 166.0, 165.0, 166.0, 164.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 110.0, 76.0, 77.0, 77.0, 77.0, 95.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 104.0, 85.0, 85.0, 86.0, 100.0, 84.0, 85.0, 109.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 150.0, 150.0, 150.0, 151.0, 151.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 98.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 65.0, 55.0, 58.0, 56.0, 54.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 59.0, 57.0, 57.0, 57.0, 57.0, 56.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 93.0, 91.0, 88.0, 83.0, 83.0, 84.0, 84.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 136.0, 137.0, 144.0, 145.0, 134.0, 145.0, 144.0, 197.0, 144.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 201.0, 199.0, 201.0, 189.0, 205.0, 209.0, 203.0, 203.0, 203.0], "value": 201.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 72.0, 74.0, 72.0, 70.0, 76.0, 72.0, 74.0, 74.0], "value": 73.4, "unit": "score"}]}]} 22:21:33 INFO - Return code: 0 22:21:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:21:33 ERROR - # TBPL SUCCESS # 22:21:33 INFO - Running post-action listener: _resource_record_post_action 22:21:33 INFO - [mozharness: 2017-04-06 05:21:33.805732Z] Finished run-tests step (success) 22:21:33 INFO - Running post-run listener: _resource_record_post_run 22:21:33 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 356454400; Read time: 8; Write time: 286200 22:21:33 INFO - TinderboxPrint: CPU usage
13.0% 22:21:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:21:33 INFO - TinderboxPrint: I/O write bytes / time
356,454,400 / 286,200 22:21:33 INFO - TinderboxPrint: CPU idle
8,358.3 (87.0%) 22:21:33 INFO - TinderboxPrint: CPU user
1,204.7 (12.5%) 22:21:33 INFO - TinderboxPrint: Swap in / out
0 / 0 22:21:33 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 101449728; Read time: 0; Write time: 116220 22:21:33 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255004672; Read time: 8; Write time: 169980 22:21:34 INFO - Running post-run listener: _upload_blobber_files 22:21:34 INFO - Blob upload gear active. 22:21:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:21:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:21:34 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:21:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:21:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:35 INFO - (blobuploader) - INFO - Done attempting. 22:21:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:21:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:36 INFO - (blobuploader) - INFO - Done attempting. 22:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:40 INFO - (blobuploader) - INFO - Done attempting. 22:21:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:21:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:41 INFO - (blobuploader) - INFO - Done attempting. 22:21:41 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:41 INFO - Return code: 0 22:21:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:21:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/304c05eac61c91454639dc3ba1bbf4ea3e15ed73ce338baa30acd526d3bdc81afe4c5fe5dcc4d9bb7721e6357cba68a0fadb95dacd51f35f128f08d93fa1610d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c8d0b71a96faf2746156bab30b806ea5b6d41cd6db2a852ce8ce17569da36b37600043bb887017592f23a23268dd48fdf727f0e2c831da569bf5aa6f6d3244", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89a2838d8dd3c973265f5567d7a996e19e278f9c533e897732f2138e6d83fc5f6d6a5a0e032ab031f6eb0ad072d81f76797318a9baa84367a6fa26d775c385e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/589c41d40060a5a374141ad33f77b49e30522eeaaf342fc7b168a8a948ec02d80e6e185a59bbbd90b0ba94f88eac27a4d57cf029db5c003a6aea90447e0f26f9"} 22:21:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:21:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:21:41 INFO - Contents: 22:21:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/304c05eac61c91454639dc3ba1bbf4ea3e15ed73ce338baa30acd526d3bdc81afe4c5fe5dcc4d9bb7721e6357cba68a0fadb95dacd51f35f128f08d93fa1610d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c8d0b71a96faf2746156bab30b806ea5b6d41cd6db2a852ce8ce17569da36b37600043bb887017592f23a23268dd48fdf727f0e2c831da569bf5aa6f6d3244", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89a2838d8dd3c973265f5567d7a996e19e278f9c533e897732f2138e6d83fc5f6d6a5a0e032ab031f6eb0ad072d81f76797318a9baa84367a6fa26d775c385e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/589c41d40060a5a374141ad33f77b49e30522eeaaf342fc7b168a8a948ec02d80e6e185a59bbbd90b0ba94f88eac27a4d57cf029db5c003a6aea90447e0f26f9"} 22:21:41 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:41 INFO - Copying logs to upload dir... 22:21:41 INFO - mkdir: /builds/slave/test/build/upload/logs 22:21:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.408453 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-05 22:21:41.006155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 22:21:41.009990) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831 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-Non-PGO/sha512/304c05eac61c91454639dc3ba1bbf4ea3e15ed73ce338baa30acd526d3bdc81afe4c5fe5dcc4d9bb7721e6357cba68a0fadb95dacd51f35f128f08d93fa1610d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c8d0b71a96faf2746156bab30b806ea5b6d41cd6db2a852ce8ce17569da36b37600043bb887017592f23a23268dd48fdf727f0e2c831da569bf5aa6f6d3244", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89a2838d8dd3c973265f5567d7a996e19e278f9c533e897732f2138e6d83fc5f6d6a5a0e032ab031f6eb0ad072d81f76797318a9baa84367a6fa26d775c385e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/589c41d40060a5a374141ad33f77b49e30522eeaaf342fc7b168a8a948ec02d80e6e185a59bbbd90b0ba94f88eac27a4d57cf029db5c003a6aea90447e0f26f9"} build_url:https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/304c05eac61c91454639dc3ba1bbf4ea3e15ed73ce338baa30acd526d3bdc81afe4c5fe5dcc4d9bb7721e6357cba68a0fadb95dacd51f35f128f08d93fa1610d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62c8d0b71a96faf2746156bab30b806ea5b6d41cd6db2a852ce8ce17569da36b37600043bb887017592f23a23268dd48fdf727f0e2c831da569bf5aa6f6d3244", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89a2838d8dd3c973265f5567d7a996e19e278f9c533e897732f2138e6d83fc5f6d6a5a0e032ab031f6eb0ad072d81f76797318a9baa84367a6fa26d775c385e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/589c41d40060a5a374141ad33f77b49e30522eeaaf342fc7b168a8a948ec02d80e6e185a59bbbd90b0ba94f88eac27a4d57cf029db5c003a6aea90447e0f26f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 22:21:41.036309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:21:41.036648) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1491454834.721607-1955875831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:21:41.120816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 22:21:41.121162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 22:21:41.121486) ========= ========= Total master_lag: 0.18 =========