builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1491938773.93 results: success (0) revision: 5a2d561c1ea6039374dfe14247d39ff6acb7e3be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:13.925502) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:13.925976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:13.926246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:13.940999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:13.941308) ========= 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=32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-11 12:26:14-- 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% 15.0M=0.001s 2017-04-11 12:26:14 (15.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:14.053480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:14.053806) ========= 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=32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023574 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:14.105384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:14.105749) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5a2d561c1ea6039374dfe14247d39ff6acb7e3be --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5a2d561c1ea6039374dfe14247d39ff6acb7e3be --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=32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-11 12:26:14,291 truncating revision to first 12 chars 2017-04-11 12:26:14,291 Setting DEBUG logging. 2017-04-11 12:26:14,291 attempt 1/10 2017-04-11 12:26:14,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5a2d561c1ea6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-11 12:26:14,824 unpacking tar archive at: mozilla-beta-5a2d561c1ea6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.876014 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:14.995175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:14.995487) ========= script_repo_revision: 5a2d561c1ea6039374dfe14247d39ff6acb7e3be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:14.995861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:14.996121) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 12:26:15.007068) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-04-11 12:26:15.007530) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:26:15 INFO - MultiFileLogger online at 20170411 12:26:15 in /builds/slave/test 12:26:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 12:26:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:26:15 INFO - {'append_to_log': False, 12:26:15 INFO - 'base_work_dir': '/builds/slave/test', 12:26:15 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 12:26:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:26:15 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 12:26:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:26:15 INFO - 'config_files': ('talos/linux_config.py',), 12:26:15 INFO - 'default_actions': ('clobber', 12:26:15 INFO - 'read-buildbot-config', 12:26:15 INFO - 'download-and-extract', 12:26:15 INFO - 'populate-webroot', 12:26:15 INFO - 'create-virtualenv', 12:26:15 INFO - 'install', 12:26:15 INFO - 'run-tests'), 12:26:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:26:15 INFO - 'download_minidump_stackwalk': True, 12:26:15 INFO - 'download_symbols': 'ondemand', 12:26:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:26:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:26:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:26:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:26:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:26:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:26:15 INFO - 'installer_path': 'installer.exe', 12:26:15 INFO - 'log_level': 'info', 12:26:15 INFO - 'log_name': 'talos', 12:26:15 INFO - 'log_to_console': True, 12:26:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:26:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:26:15 INFO - 'opt_config_files': (), 12:26:15 INFO - 'pip_index': False, 12:26:15 INFO - 'sps_profile': False, 12:26:15 INFO - 'sps_profile_interval': 0, 12:26:15 INFO - 'suite': 'dromaeojs', 12:26:15 INFO - 'system_bits': '32', 12:26:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:26:15 INFO - 'title': 'talos-linux64-ix-008', 12:26:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:26:15 INFO - 'use_talos_json': True, 12:26:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:26:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:26:15 INFO - 'work_dir': 'build'} 12:26:15 INFO - [mozharness: 2017-04-11 19:26:15.285886Z] Running clobber step. 12:26:15 INFO - Running pre-action listener: _resource_record_pre_action 12:26:15 INFO - Running main action method: clobber 12:26:15 INFO - rmtree: /builds/slave/test/build 12:26:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:26:16 INFO - Running post-action listener: _resource_record_post_action 12:26:16 INFO - [mozharness: 2017-04-11 19:26:16.878066Z] Finished clobber step (success) 12:26:16 INFO - [mozharness: 2017-04-11 19:26:16.878164Z] Running read-buildbot-config step. 12:26:16 INFO - Running pre-action listener: _resource_record_pre_action 12:26:16 INFO - Running main action method: read_buildbot_config 12:26:16 INFO - Using buildbot properties: 12:26:16 INFO - { 12:26:16 INFO - "project": "", 12:26:16 INFO - "product": "firefox", 12:26:16 INFO - "who": "asasaki@mozilla.com", 12:26:16 INFO - "installer_path": "public/build/target.tar.bz2", 12:26:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:26:16 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 12:26:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 12:26:16 INFO - "stage_platform": "linux64", 12:26:16 INFO - "basedir": "/builds/slave/test", 12:26:16 INFO - "buildnumber": 9, 12:26:16 INFO - "platform": "ubuntu64_hw", 12:26:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:26:16 INFO - "slavebuilddir": "test", 12:26:16 INFO - "taskId": "CfwbXzdqSr-g8dbCddRFcw", 12:26:16 INFO - "branch": "mozilla-beta", 12:26:16 INFO - "script_repo_revision": "production", 12:26:16 INFO - "revision": "5a2d561c1ea6039374dfe14247d39ff6acb7e3be", 12:26:16 INFO - "slavename": "talos-linux64-ix-008", 12:26:16 INFO - "repo_path": "releases/mozilla-beta" 12:26:16 INFO - } 12:26:16 INFO - Finding installer, test and symbols from parent task. 12:26:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfwbXzdqSr-g8dbCddRFcw'}, attempt #1 12:26:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfwbXzdqSr-g8dbCddRFcw'}, attempt #1 12:26:17 INFO - Task dependencies: aUONY0SmRYyiISdb6PLtmQ 12:26:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ'}, attempt #1 12:26:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.tar.bz2 12:26:18 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/test_packages.json 12:26:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.crashreporter-symbols.zip 12:26:18 INFO - Running post-action listener: _resource_record_post_action 12:26:18 INFO - [mozharness: 2017-04-11 19:26:18.234374Z] Finished read-buildbot-config step (success) 12:26:18 INFO - [mozharness: 2017-04-11 19:26:18.234590Z] Running download-and-extract step. 12:26:18 INFO - Running pre-action listener: _resource_record_pre_action 12:26:18 INFO - Running main action method: download_and_extract 12:26:18 INFO - mkdir: /builds/slave/test/build/tests 12:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:18 INFO - trying https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.test_packages.json 12:26:18 INFO - Downloading https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:26:18 INFO - Downloaded 896 bytes. 12:26:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:26:18 INFO - Using the following test package requirements: 12:26:18 INFO - {u'common': [u'target.common.tests.zip'], 12:26:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:26:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:26:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:26:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:26:18 INFO - u'mozbase': [u'target.common.tests.zip'], 12:26:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:26:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:26:18 INFO - u'web-platform': [u'target.common.tests.zip', 12:26:18 INFO - u'target.web-platform.tests.zip'], 12:26:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:26:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:26:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.common.tests.zip 12:26:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:26:18 INFO - Fetch https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.common.tests.zip into memory 12:26:19 INFO - Expected file size: 21876734 12:26:19 INFO - Obtained file size: 21876734 12:26:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:26:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.common.tests.zip 12:26:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:26:23 INFO - Fetch https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.common.tests.zip into memory 12:26:24 INFO - Expected file size: 21876734 12:26:24 INFO - Obtained file size: 21876734 12:26:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.talos.tests.zip 12:26:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:26:28 INFO - Fetch https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.talos.tests.zip into memory 12:26:29 INFO - Expected file size: 14403650 12:26:29 INFO - Obtained file size: 14403650 12:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:29 INFO - trying https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.tar.bz2 12:26:29 INFO - Downloading https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:26:30 INFO - Downloaded 58789273 bytes. 12:26:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.tar.bz2 12:26:30 INFO - mkdir: /builds/slave/test/properties 12:26:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:26:30 INFO - Writing to file /builds/slave/test/properties/build_url 12:26:30 INFO - Contents: 12:26:30 INFO - build_url:https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.tar.bz2 12:26:30 INFO - Running post-action listener: _resource_record_post_action 12:26:30 INFO - Running post-action listener: set_extra_try_arguments 12:26:30 INFO - [mozharness: 2017-04-11 19:26:30.975227Z] Finished download-and-extract step (success) 12:26:30 INFO - [mozharness: 2017-04-11 19:26:30.975323Z] Running populate-webroot step. 12:26:30 INFO - Running pre-action listener: _resource_record_pre_action 12:26:30 INFO - Running main action method: populate_webroot 12:26:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:26:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:26:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:26:30 INFO - '--tppagecycles', 12:26:30 INFO - '7'], 12:26:30 INFO - 'tests': ['tsvgm']}}, 12:26:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:26:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:26:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:26:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:26:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:26:30 INFO - 'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:26:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:26:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:26:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:26:30 INFO - 'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['damp', 'tps']}, 12:26:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:26:30 INFO - 'tests': ['damp', 'tps']}, 12:26:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['dromaeo_dom']}, 12:26:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:26:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['basic_compositor_video']}, 12:26:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:26:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['a11yr', 12:26:30 INFO - 'ts_paint', 12:26:30 INFO - 'tpaint', 12:26:30 INFO - 'sessionrestore', 12:26:30 INFO - 'sessionrestore_no_auto_restore', 12:26:30 INFO - 'tabpaint']}, 12:26:30 INFO - 'other-e10s': {'tests': ['a11yr', 12:26:30 INFO - 'ts_paint', 12:26:30 INFO - 'tpaint', 12:26:30 INFO - 'sessionrestore', 12:26:30 INFO - 'sessionrestore_no_auto_restore', 12:26:30 INFO - 'tabpaint']}, 12:26:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:26:30 INFO - 'ts_paint', 12:26:30 INFO - 'tpaint', 12:26:30 INFO - 'sessionrestore', 12:26:30 INFO - 'sessionrestore_no_auto_restore', 12:26:30 INFO - 'tabpaint']}, 12:26:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:26:30 INFO - 'ts_paint', 12:26:30 INFO - 'tpaint', 12:26:30 INFO - 'sessionrestore', 12:26:30 INFO - 'sessionrestore_no_auto_restore', 12:26:30 INFO - 'tabpaint']}, 12:26:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['a11yr', 12:26:30 INFO - 'ts_paint', 12:26:30 INFO - 'tpaint', 12:26:30 INFO - 'sessionrestore', 12:26:30 INFO - 'sessionrestore_no_auto_restore', 12:26:30 INFO - 'tabpaint']}, 12:26:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['a11yr', 12:26:30 INFO - 'ts_paint', 12:26:30 INFO - 'tpaint', 12:26:30 INFO - 'sessionrestore', 12:26:30 INFO - 'sessionrestore_no_auto_restore', 12:26:30 INFO - 'tabpaint']}, 12:26:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['tsvgx', 12:26:30 INFO - 'tsvgr_opacity', 12:26:30 INFO - 'tart', 12:26:30 INFO - 'tscrollx', 12:26:30 INFO - 'cart', 12:26:30 INFO - 'tsvg_static']}, 12:26:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:26:30 INFO - 'tsvgr_opacity', 12:26:30 INFO - 'tart', 12:26:30 INFO - 'tscrollx', 12:26:30 INFO - 'cart', 12:26:30 INFO - 'tsvg_static']}, 12:26:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:26:30 INFO - 'talos_options': ['--disable-e10s'], 12:26:30 INFO - 'tests': ['tp5o']}, 12:26:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:26:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:26:30 INFO - 'talos_options': ['--disable-e10s', 12:26:30 INFO - '--xperf_path', 12:26:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:26:30 INFO - 'tests': ['tp5n']}, 12:26:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:26:30 INFO - 'talos_options': ['--xperf_path', 12:26:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:26:30 INFO - 'tests': ['tp5n']}}, 12:26:30 INFO - 'talos.zip': {'path': '', 12:26:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:26:30 INFO - Running post-action listener: _resource_record_post_action 12:26:30 INFO - [mozharness: 2017-04-11 19:26:30.988378Z] Finished populate-webroot step (success) 12:26:30 INFO - [mozharness: 2017-04-11 19:26:30.988468Z] Running create-virtualenv step. 12:26:30 INFO - Running pre-action listener: _resource_record_pre_action 12:26:30 INFO - Running main action method: create_virtualenv 12:26:30 INFO - Creating virtualenv /builds/slave/test/build/venv 12:26:30 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 12:26:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:26:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:26:31 INFO - Using real prefix '/usr' 12:26:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:26:31 INFO - Installing distribute.............................................................................................................................................................................................done. 12:26:33 INFO - Installing pip.................done. 12:26:33 INFO - Return code: 0 12:26:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:26:33 INFO - Reading from file tmpfile_stdout 12:26:33 INFO - Output received: 12:26:33 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) 12:26:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:26:33 INFO - Using env: {'DISPLAY': ':0', 12:26:33 INFO - 'HOME': '/home/cltbld', 12:26:33 INFO - 'LANG': 'en_US.UTF-8', 12:26:33 INFO - 'LANGUAGE': 'en_US:en', 12:26:33 INFO - 'LOGNAME': 'cltbld', 12:26:33 INFO - 'MAIL': '/var/mail/cltbld', 12:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:33 INFO - 'MOZ_NO_REMOTE': '1', 12:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:33 INFO - 'NO_EM_RESTART': '1', 12:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:33 INFO - 'PWD': '/builds/slave/test', 12:26:33 INFO - 'SHELL': '/bin/bash', 12:26:33 INFO - 'SHLVL': '1', 12:26:33 INFO - 'TERM': 'linux', 12:26:33 INFO - 'TMOUT': '86400', 12:26:33 INFO - 'USER': 'cltbld', 12:26:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:33 INFO - '_': '/tools/buildbot/bin/python'} 12:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:34 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 12:26:34 INFO - Cleaning up... 12:26:34 INFO - Return code: 0 12:26:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:26:34 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')]} 12:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:34 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')]} 12:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:34 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 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:34 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 12:26:34 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 12:26:34 INFO - Using env: {'DISPLAY': ':0', 12:26:34 INFO - 'HOME': '/home/cltbld', 12:26:34 INFO - 'LANG': 'en_US.UTF-8', 12:26:34 INFO - 'LANGUAGE': 'en_US:en', 12:26:34 INFO - 'LOGNAME': 'cltbld', 12:26:34 INFO - 'MAIL': '/var/mail/cltbld', 12:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:34 INFO - 'MOZ_NO_REMOTE': '1', 12:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:34 INFO - 'NO_EM_RESTART': '1', 12:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:34 INFO - 'PWD': '/builds/slave/test', 12:26:34 INFO - 'SHELL': '/bin/bash', 12:26:34 INFO - 'SHLVL': '1', 12:26:34 INFO - 'TERM': 'linux', 12:26:34 INFO - 'TMOUT': '86400', 12:26:34 INFO - 'USER': 'cltbld', 12:26:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:34 INFO - '_': '/tools/buildbot/bin/python'} 12:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:34 INFO - Downloading/unpacking psutil>=3.1.1 12:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:26:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:26:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:26:36 INFO - Installing collected packages: psutil 12:26:36 INFO - Running setup.py install for psutil 12:26:36 INFO - building 'psutil._psutil_linux' extension 12:26:36 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 12:26:36 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 12:26:36 INFO - building 'psutil._psutil_posix' extension 12:26:36 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 12:26:37 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 12:26:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:26:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:26:37 INFO - Successfully installed psutil 12:26:37 INFO - Cleaning up... 12:26:37 INFO - Return code: 0 12:26:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:26:37 INFO - Using env: {'DISPLAY': ':0', 12:26:37 INFO - 'HOME': '/home/cltbld', 12:26:37 INFO - 'LANG': 'en_US.UTF-8', 12:26:37 INFO - 'LANGUAGE': 'en_US:en', 12:26:37 INFO - 'LOGNAME': 'cltbld', 12:26:37 INFO - 'MAIL': '/var/mail/cltbld', 12:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:37 INFO - 'MOZ_NO_REMOTE': '1', 12:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:37 INFO - 'NO_EM_RESTART': '1', 12:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:37 INFO - 'PWD': '/builds/slave/test', 12:26:37 INFO - 'SHELL': '/bin/bash', 12:26:37 INFO - 'SHLVL': '1', 12:26:37 INFO - 'TERM': 'linux', 12:26:37 INFO - 'TMOUT': '86400', 12:26:37 INFO - 'USER': 'cltbld', 12:26:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:37 INFO - '_': '/tools/buildbot/bin/python'} 12:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:26:37 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 12:26:37 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 12:26:37 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 12:26:37 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 12:26:37 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 12:26:37 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 12:26:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:26:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:26:39 INFO - Installing collected packages: mozsystemmonitor 12:26:39 INFO - Running setup.py install for mozsystemmonitor 12:26:39 INFO - Successfully installed mozsystemmonitor 12:26:39 INFO - Cleaning up... 12:26:39 INFO - Return code: 0 12:26:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:26:39 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')]} 12:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:39 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')]} 12:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:39 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 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:39 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 12:26:39 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 12:26:39 INFO - Using env: {'DISPLAY': ':0', 12:26:39 INFO - 'HOME': '/home/cltbld', 12:26:39 INFO - 'LANG': 'en_US.UTF-8', 12:26:39 INFO - 'LANGUAGE': 'en_US:en', 12:26:39 INFO - 'LOGNAME': 'cltbld', 12:26:39 INFO - 'MAIL': '/var/mail/cltbld', 12:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:39 INFO - 'MOZ_NO_REMOTE': '1', 12:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:39 INFO - 'NO_EM_RESTART': '1', 12:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:39 INFO - 'PWD': '/builds/slave/test', 12:26:39 INFO - 'SHELL': '/bin/bash', 12:26:39 INFO - 'SHLVL': '1', 12:26:39 INFO - 'TERM': 'linux', 12:26:39 INFO - 'TMOUT': '86400', 12:26:39 INFO - 'USER': 'cltbld', 12:26:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:39 INFO - '_': '/tools/buildbot/bin/python'} 12:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:39 INFO - Downloading/unpacking jsonschema==2.5.1 12:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:26:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:26:41 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 12:26:41 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 12:26:41 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 12:26:41 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 12:26:41 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 12:26:41 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 12:26:42 INFO - Downloading functools32-3.2.3-2.tar.gz 12:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:26:42 INFO - warning: no files found matching '*.txt' 12:26:42 INFO - no previously-included directories found matching 'build' 12:26:42 INFO - no previously-included directories found matching 'dist' 12:26:42 INFO - no previously-included directories found matching '.git*' 12:26:42 INFO - Installing collected packages: jsonschema, functools32 12:26:42 INFO - Running setup.py install for functools32 12:26:42 INFO - warning: no files found matching '*.txt' 12:26:42 INFO - no previously-included directories found matching 'build' 12:26:42 INFO - no previously-included directories found matching 'dist' 12:26:42 INFO - no previously-included directories found matching '.git*' 12:26:42 INFO - Successfully installed jsonschema functools32 12:26:42 INFO - Cleaning up... 12:26:42 INFO - Return code: 0 12:26:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:26:42 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')]} 12:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:42 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')]} 12:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:42 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 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:42 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 12:26:42 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 12:26:42 INFO - Using env: {'DISPLAY': ':0', 12:26:42 INFO - 'HOME': '/home/cltbld', 12:26:42 INFO - 'LANG': 'en_US.UTF-8', 12:26:42 INFO - 'LANGUAGE': 'en_US:en', 12:26:42 INFO - 'LOGNAME': 'cltbld', 12:26:42 INFO - 'MAIL': '/var/mail/cltbld', 12:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:42 INFO - 'MOZ_NO_REMOTE': '1', 12:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:42 INFO - 'NO_EM_RESTART': '1', 12:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:42 INFO - 'PWD': '/builds/slave/test', 12:26:42 INFO - 'SHELL': '/bin/bash', 12:26:42 INFO - 'SHLVL': '1', 12:26:42 INFO - 'TERM': 'linux', 12:26:42 INFO - 'TMOUT': '86400', 12:26:42 INFO - 'USER': 'cltbld', 12:26:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:42 INFO - '_': '/tools/buildbot/bin/python'} 12:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:26:42 INFO - Cleaning up... 12:26:42 INFO - Return code: 0 12:26:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:26:42 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')]} 12:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:42 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')]} 12:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:42 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 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:42 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 12:26:42 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 12:26:42 INFO - Using env: {'DISPLAY': ':0', 12:26:42 INFO - 'HOME': '/home/cltbld', 12:26:42 INFO - 'LANG': 'en_US.UTF-8', 12:26:42 INFO - 'LANGUAGE': 'en_US:en', 12:26:42 INFO - 'LOGNAME': 'cltbld', 12:26:42 INFO - 'MAIL': '/var/mail/cltbld', 12:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:42 INFO - 'MOZ_NO_REMOTE': '1', 12:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:42 INFO - 'NO_EM_RESTART': '1', 12:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:42 INFO - 'PWD': '/builds/slave/test', 12:26:42 INFO - 'SHELL': '/bin/bash', 12:26:42 INFO - 'SHLVL': '1', 12:26:42 INFO - 'TERM': 'linux', 12:26:42 INFO - 'TMOUT': '86400', 12:26:42 INFO - 'USER': 'cltbld', 12:26:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:42 INFO - '_': '/tools/buildbot/bin/python'} 12:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:26:42 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 12:26:42 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 12:26:42 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 12:26:42 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 12:26:42 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 12:26:42 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 12:26:44 INFO - Downloading blobuploader-1.2.4.tar.gz 12:26:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:26:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:26:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:26:45 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 12:26:45 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 12:26:45 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 12:26:45 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 12:26:45 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 12:26:45 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 12:26:45 INFO - Downloading docopt-0.6.1.tar.gz 12:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:26:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:26:45 INFO - Running setup.py install for blobuploader 12:26:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:26:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:26:45 INFO - Running setup.py install for requests 12:26:46 INFO - Running setup.py install for docopt 12:26:46 INFO - Successfully installed blobuploader requests docopt 12:26:46 INFO - Cleaning up... 12:26:46 INFO - Return code: 0 12:26:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26:46 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')]} 12:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:46 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')]} 12:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:46 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 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:46 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 12:26:46 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 12:26:46 INFO - Using env: {'DISPLAY': ':0', 12:26:46 INFO - 'HOME': '/home/cltbld', 12:26:46 INFO - 'LANG': 'en_US.UTF-8', 12:26:46 INFO - 'LANGUAGE': 'en_US:en', 12:26:46 INFO - 'LOGNAME': 'cltbld', 12:26:46 INFO - 'MAIL': '/var/mail/cltbld', 12:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:46 INFO - 'MOZ_NO_REMOTE': '1', 12:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:46 INFO - 'NO_EM_RESTART': '1', 12:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:46 INFO - 'PWD': '/builds/slave/test', 12:26:46 INFO - 'SHELL': '/bin/bash', 12:26:46 INFO - 'SHLVL': '1', 12:26:46 INFO - 'TERM': 'linux', 12:26:46 INFO - 'TMOUT': '86400', 12:26:46 INFO - 'USER': 'cltbld', 12:26:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:46 INFO - '_': '/tools/buildbot/bin/python'} 12:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:26:46 INFO - Running setup.py (path:/tmp/pip-9J10Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:26:46 INFO - Running setup.py (path:/tmp/pip-H69Ryk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:26:46 INFO - Running setup.py (path:/tmp/pip-bN7vYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:26:46 INFO - Running setup.py (path:/tmp/pip-WeburL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:26:46 INFO - Running setup.py (path:/tmp/pip-3S55UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:26:46 INFO - Running setup.py (path:/tmp/pip-mKGEup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:26:46 INFO - Running setup.py (path:/tmp/pip-RKvi_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:26:47 INFO - Running setup.py (path:/tmp/pip-NFCuZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:26:47 INFO - Running setup.py (path:/tmp/pip-C_Y1CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:26:47 INFO - Running setup.py (path:/tmp/pip-T_6YhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:26:47 INFO - Running setup.py (path:/tmp/pip-CCgr43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:26:47 INFO - Running setup.py (path:/tmp/pip-0rhaBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:26:47 INFO - Running setup.py (path:/tmp/pip-TXJmzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:26:47 INFO - Running setup.py (path:/tmp/pip-NpxnIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:47 INFO - Running setup.py (path:/tmp/pip-_RYFUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:47 INFO - Running setup.py (path:/tmp/pip-QsO7_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:47 INFO - Running setup.py (path:/tmp/pip-kRKjyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:26:47 INFO - Running setup.py install for manifestparser 12:26:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:26:47 INFO - Running setup.py install for mozcrash 12:26:47 INFO - Running setup.py install for mozdebug 12:26:48 INFO - Running setup.py install for mozdevice 12:26:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Running setup.py install for mozfile 12:26:48 INFO - Running setup.py install for mozhttpd 12:26:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Running setup.py install for mozinfo 12:26:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Running setup.py install for mozInstall 12:26:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Running setup.py install for mozleak 12:26:48 INFO - Running setup.py install for mozlog 12:26:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Running setup.py install for moznetwork 12:26:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:26:48 INFO - Running setup.py install for mozprocess 12:26:48 INFO - Running setup.py install for mozprofile 12:26:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:26:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:26:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:26:49 INFO - Running setup.py install for mozrunner 12:26:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:26:49 INFO - Running setup.py install for mozscreenshot 12:26:49 INFO - Running setup.py install for moztest 12:26:49 INFO - Running setup.py install for mozversion 12:26:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:26:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:26:49 INFO - Cleaning up... 12:26:49 INFO - Return code: 0 12:26:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:49 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 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:49 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 12:26:49 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 12:26:49 INFO - Using env: {'DISPLAY': ':0', 12:26:49 INFO - 'HOME': '/home/cltbld', 12:26:49 INFO - 'LANG': 'en_US.UTF-8', 12:26:49 INFO - 'LANGUAGE': 'en_US:en', 12:26:49 INFO - 'LOGNAME': 'cltbld', 12:26:49 INFO - 'MAIL': '/var/mail/cltbld', 12:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:49 INFO - 'MOZ_NO_REMOTE': '1', 12:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:49 INFO - 'NO_EM_RESTART': '1', 12:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:49 INFO - 'PWD': '/builds/slave/test', 12:26:49 INFO - 'SHELL': '/bin/bash', 12:26:49 INFO - 'SHLVL': '1', 12:26:49 INFO - 'TERM': 'linux', 12:26:49 INFO - 'TMOUT': '86400', 12:26:49 INFO - 'USER': 'cltbld', 12:26:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:49 INFO - '_': '/tools/buildbot/bin/python'} 12:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:26:49 INFO - Running setup.py (path:/tmp/pip-EfvWH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:26:49 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)) 12:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:26:49 INFO - Running setup.py (path:/tmp/pip-vaVXzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:26:49 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)) 12:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:26:49 INFO - Running setup.py (path:/tmp/pip-Mnn7Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:26:49 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)) 12:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:26:49 INFO - Running setup.py (path:/tmp/pip-IrSnsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:26:50 INFO - Running setup.py (path:/tmp/pip-8tteQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:26:50 INFO - Running setup.py (path:/tmp/pip-qITSSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:26:50 INFO - Running setup.py (path:/tmp/pip-__WaSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:26:50 INFO - Running setup.py (path:/tmp/pip-NVCbwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:26:50 INFO - Running setup.py (path:/tmp/pip-Qz8ogm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:26:50 INFO - Running setup.py (path:/tmp/pip-HnI9Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:26:50 INFO - Running setup.py (path:/tmp/pip-r2hFvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:26:50 INFO - Running setup.py (path:/tmp/pip-zSqaGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:26:50 INFO - Running setup.py (path:/tmp/pip-k10x7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:26:50 INFO - Running setup.py (path:/tmp/pip-bhPIbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:50 INFO - Running setup.py (path:/tmp/pip-2P5smW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:50 INFO - Running setup.py (path:/tmp/pip-2P4jnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:50 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)) 12:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:50 INFO - Running setup.py (path:/tmp/pip-4HV6Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:50 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)) 12:26:50 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)) 12:26:50 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)) 12:26:50 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)) 12:26:50 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)) 12:26:50 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)) 12:26:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:26:50 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 12:26:51 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 12:26:51 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 12:26:51 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 12:26:51 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 12:26:51 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 12:26:53 INFO - Downloading blessings-1.6.tar.gz 12:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:26:53 INFO - Installing collected packages: blessings 12:26:53 INFO - Running setup.py install for blessings 12:26:53 INFO - Successfully installed blessings 12:26:53 INFO - Cleaning up... 12:26:53 INFO - Return code: 0 12:26:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:26:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:53 INFO - Reading from file tmpfile_stdout 12:26:53 INFO - Current package versions: 12:26:53 INFO - argparse == 1.2.1 12:26:53 INFO - blessings == 1.6 12:26:53 INFO - blobuploader == 1.2.4 12:26:53 INFO - docopt == 0.6.1 12:26:53 INFO - functools32 == 3.2.3-2 12:26:53 INFO - jsonschema == 2.5.1 12:26:53 INFO - manifestparser == 1.1 12:26:53 INFO - mozInstall == 1.12 12:26:53 INFO - mozcrash == 1.0 12:26:53 INFO - mozdebug == 0.1 12:26:53 INFO - mozdevice == 0.49 12:26:53 INFO - mozfile == 1.2 12:26:53 INFO - mozhttpd == 0.7 12:26:53 INFO - mozinfo == 0.9 12:26:53 INFO - mozleak == 0.1 12:26:53 INFO - mozlog == 3.4 12:26:53 INFO - moznetwork == 0.27 12:26:53 INFO - mozprocess == 0.24 12:26:53 INFO - mozprofile == 0.28 12:26:53 INFO - mozrunner == 6.13 12:26:53 INFO - mozscreenshot == 0.1 12:26:53 INFO - mozsystemmonitor == 0.3 12:26:53 INFO - moztest == 0.8 12:26:53 INFO - mozversion == 1.4 12:26:53 INFO - psutil == 3.1.1 12:26:53 INFO - requests == 1.2.3 12:26:53 INFO - wsgiref == 0.1.2 12:26:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26:53 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')]} 12:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:53 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')]} 12:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:53 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 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:53 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 12:26:53 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 12:26:53 INFO - Using env: {'DISPLAY': ':0', 12:26:53 INFO - 'HOME': '/home/cltbld', 12:26:53 INFO - 'LANG': 'en_US.UTF-8', 12:26:53 INFO - 'LANGUAGE': 'en_US:en', 12:26:53 INFO - 'LOGNAME': 'cltbld', 12:26:53 INFO - 'MAIL': '/var/mail/cltbld', 12:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:53 INFO - 'MOZ_NO_REMOTE': '1', 12:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:53 INFO - 'NO_EM_RESTART': '1', 12:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:53 INFO - 'PWD': '/builds/slave/test', 12:26:53 INFO - 'SHELL': '/bin/bash', 12:26:53 INFO - 'SHLVL': '1', 12:26:53 INFO - 'TERM': 'linux', 12:26:53 INFO - 'TMOUT': '86400', 12:26:53 INFO - 'USER': 'cltbld', 12:26:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:53 INFO - '_': '/tools/buildbot/bin/python'} 12:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:53 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)) 12:26:53 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)) 12:26:53 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)) 12:26:53 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)) 12:26:53 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)) 12:26:53 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)) 12:26:53 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)) 12:26:53 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)) 12:26:53 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)) 12:26:53 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)) 12:26:53 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)) 12:26:53 INFO - Cleaning up... 12:26:53 INFO - Return code: 0 12:26:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:26:53 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')]} 12:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:53 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')]} 12:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:53 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 0x115c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1329a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ce980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, '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': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', '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 12:26:53 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 12:26:53 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 12:26:53 INFO - Using env: {'DISPLAY': ':0', 12:26:53 INFO - 'HOME': '/home/cltbld', 12:26:53 INFO - 'LANG': 'en_US.UTF-8', 12:26:53 INFO - 'LANGUAGE': 'en_US:en', 12:26:53 INFO - 'LOGNAME': 'cltbld', 12:26:53 INFO - 'MAIL': '/var/mail/cltbld', 12:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:53 INFO - 'MOZ_NO_REMOTE': '1', 12:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:53 INFO - 'NO_EM_RESTART': '1', 12:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:53 INFO - 'PWD': '/builds/slave/test', 12:26:53 INFO - 'SHELL': '/bin/bash', 12:26:53 INFO - 'SHLVL': '1', 12:26:53 INFO - 'TERM': 'linux', 12:26:53 INFO - 'TMOUT': '86400', 12:26:53 INFO - 'USER': 'cltbld', 12:26:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:53 INFO - '_': '/tools/buildbot/bin/python'} 12:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:26:54 INFO - Cleaning up... 12:26:54 INFO - Return code: 0 12:26:54 INFO - Running post-action listener: _resource_record_post_action 12:26:54 INFO - Running post-action listener: _start_resource_monitoring 12:26:54 INFO - Starting resource monitoring. 12:26:54 INFO - [mozharness: 2017-04-11 19:26:54.058195Z] Finished create-virtualenv step (success) 12:26:54 INFO - [mozharness: 2017-04-11 19:26:54.058698Z] Running install step. 12:26:54 INFO - Running pre-action listener: _resource_record_pre_action 12:26:54 INFO - Running main action method: install 12:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:54 INFO - Reading from file tmpfile_stdout 12:26:54 INFO - Detecting whether we're running mozinstall >=1.0... 12:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:26:54 INFO - Reading from file tmpfile_stdout 12:26:54 INFO - Output received: 12:26:54 INFO - Usage: mozinstall [options] installer 12:26:54 INFO - Options: 12:26:54 INFO - -h, --help show this help message and exit 12:26:54 INFO - -d DEST, --destination=DEST 12:26:54 INFO - Directory to install application into. [default: 12:26:54 INFO - "/builds/slave/test"] 12:26:54 INFO - --app=APP Application being installed. [default: firefox] 12:26:54 INFO - mkdir: /builds/slave/test/build/application 12:26:54 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'] 12:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:27:08 INFO - Reading from file tmpfile_stdout 12:27:08 INFO - Output received: 12:27:08 INFO - /builds/slave/test/build/application/firefox/firefox 12:27:08 INFO - Running post-action listener: _resource_record_post_action 12:27:08 INFO - [mozharness: 2017-04-11 19:27:08.490052Z] Finished install step (success) 12:27:08 INFO - [mozharness: 2017-04-11 19:27:08.490328Z] Running run-tests step. 12:27:08 INFO - Running pre-action listener: _resource_record_pre_action 12:27:08 INFO - Running main action method: run_tests 12:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:27:08 INFO - Python 2.7.3 12:27:08 INFO - Return code: 0 12:27:08 INFO - grabbing minidump binary from tooltool 12:27:08 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')]} 12:27:08 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 0x14cbd00>, '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 0x14cca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cceb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:27:08 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 12:27:08 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 12:27:08 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 12:27:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:27:08 INFO - Return code: 0 12:27:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:27:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:27:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:27:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:27:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 12:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 12:27:08 INFO - Using env: {'DISPLAY': ':0', 12:27:08 INFO - 'HOME': '/home/cltbld', 12:27:08 INFO - 'LANG': 'en_US.UTF-8', 12:27:08 INFO - 'LANGUAGE': 'en_US:en', 12:27:08 INFO - 'LOGNAME': 'cltbld', 12:27:08 INFO - 'MAIL': '/var/mail/cltbld', 12:27:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:27:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:27:08 INFO - 'MOZ_NO_REMOTE': '1', 12:27:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:27:08 INFO - 'NO_EM_RESTART': '1', 12:27:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:27:08 INFO - 'PWD': '/builds/slave/test', 12:27:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:27:08 INFO - 'SHELL': '/bin/bash', 12:27:08 INFO - 'SHLVL': '1', 12:27:08 INFO - 'TERM': 'linux', 12:27:08 INFO - 'TMOUT': '86400', 12:27:08 INFO - 'USER': 'cltbld', 12:27:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077', 12:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:27:08 INFO - '_': '/tools/buildbot/bin/python'} 12:27:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 12:27:08 INFO - mozversion application_buildid: 20170411182805 12:27:08 INFO - mozversion application_changeset: 5a2d561c1ea6039374dfe14247d39ff6acb7e3be 12:27:08 INFO - mozversion application_display_name: Firefox 12:27:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:27:08 INFO - mozversion application_name: Firefox 12:27:08 INFO - mozversion application_remotingname: firefox 12:27:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:27:08 INFO - mozversion application_vendor: Mozilla 12:27:08 INFO - mozversion application_version: 53.0 12:27:08 INFO - mozversion platform_buildid: 20170411182805 12:27:08 INFO - mozversion platform_changeset: 5a2d561c1ea6039374dfe14247d39ff6acb7e3be 12:27:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:27:08 INFO - mozversion platform_version: 53.0 12:27:08 INFO - using testdate: 1491938828 12:27:08 INFO - actual date: 1491938828 12:27:08 INFO - starting webserver on 'localhost:48178' 12:27:08 INFO - SUITE-START | Running 2 tests 12:27:08 INFO - TEST-START | dromaeo_css 12:27:08 INFO - operating with platform_type : linux_ 12:27:08 INFO - Initialising browser for dromaeo_css test... 12:27:08 INFO - TEST-INFO | started process 31463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIPa1xK/profile http://localhost:48178/getInfo.html) 12:27:12 INFO - PROCESS | 31463 | __metrics Screen width/height:1600/1200 12:27:12 INFO - PROCESS | 31463 | colorDepth:24 12:27:12 INFO - PROCESS | 31463 | Browser inner width/height: 1024/697 12:27:12 INFO - PROCESS | 31463 | __metrics 12:27:13 INFO - PROCESS | 31463 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:27:13 INFO - PROCESS | 31463 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:27:14 INFO - TEST-INFO | 31463: exit 0 12:27:14 INFO - Browser initialized. 12:27:14 INFO - Running cycle 1/1 for dromaeo_css test... 12:27:14 INFO - TEST-INFO | started process 31555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIPa1xK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:27:25 INFO - PROCESS | 31555 | RSS: Main: 140513280 12:27:25 INFO - PROCESS | 31555 | 12:30:26 INFO - PROCESS | 31555 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48178/tests/dromaeo/cssquery-ext.html) 12:30:27 INFO - PROCESS | 31555 | RSS: Main: 228446208 12:30:27 INFO - PROCESS | 31555 | 12:33:29 INFO - PROCESS | 31555 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-ext.html (next: http://localhost:48178/tests/dromaeo/cssquery-jquery.html) 12:33:30 INFO - PROCESS | 31555 | RSS: Main: 227409920 12:33:30 INFO - PROCESS | 31555 | 12:36:31 INFO - PROCESS | 31555 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48178/tests/dromaeo/cssquery-mootools.html) 12:36:32 INFO - PROCESS | 31555 | RSS: Main: 174731264 12:36:32 INFO - PROCESS | 31555 | 12:39:34 INFO - PROCESS | 31555 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48178/tests/dromaeo/cssquery-prototype.html) 12:39:34 INFO - PROCESS | 31555 | RSS: Main: 225759232 12:39:34 INFO - PROCESS | 31555 | 12:42:37 INFO - PROCESS | 31555 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48178/tests/dromaeo/cssquery-yui.html) 12:42:37 INFO - PROCESS | 31555 | RSS: Main: 177946624 12:42:37 INFO - PROCESS | 31555 | 12:45:40 INFO - PROCESS | 31555 | Cycle 1(1): loaded http://localhost:48178/tests/dromaeo/cssquery-yui.html (next: http://localhost:48178/tests/dromaeo/cssquery-dojo.html) 12:45:40 INFO - PROCESS | 31555 | RSS: Main: 264630272 12:45:40 INFO - PROCESS | 31555 | 12:45:40 INFO - PROCESS | 31555 | __start_tp_report 12:45:40 INFO - PROCESS | 31555 | _x_x_mozilla_page_load 12:45:40 INFO - PROCESS | 31555 | _x_x_mozilla_page_load_details 12:45:40 INFO - PROCESS | 31555 | |i|pagename|runs| 12:45:40 INFO - PROCESS | 31555 | |0;dojo.html;3289.98355008225;3333.79997200168;3337.6662333766626;3362.2603027334007;3383.746219033573;5453.781848726051;5532.225488431618;5540.501354878055;5540.833774986747;5542.1132618781;5563.332400111982;5623.578231632634;5625.578081643873;5626.634268772527;5668.68822214778;4979.452260251379;4991.650584459089;5025.422076461199;5049.949500505003;5066.392032956051;4831.275308703687;5040.5967522598285;5083.135866902636;5084.822031228908;5085.771140298695;4825.806967721287;4939.43196532398;4996.900061998776;4998.875028124289;5065.6200784941275;5026.597872170236;5054.620903432239;5059.418166910816;5067.847964561069;5081.161608334657;4925.975370123162;4981.9750901245625;5034.295198672189;5041.647084704072;5049.722265275408;5356.035913535562;5403.567714582824;5417.133258678593;5489.505944464978;5504.91742623861;5919.822405327804;5960.225170727821;5963;5966.612170208922;5971.522278217775;6010.098485227207;6013.1581578579035;6021.36775638556;6030.6080104793045;6033.155358249848;5355.169948657965;5385.919211211835;5501.449855014466;5553.389127196006;5587.636803607753;6114.206128133723;6120.121705268071;6126.884121540821;6133.601315914451;6135.969320153371;5832;5863.648181109147;5864.882702345929;5880.088586269135;5887.35239123696;5701.0308247598;5716.428357164334;5881.705914704247;5961.791337303173;5978.073398623221;5916.467517923407;5925.822225333247;5983.341832398432;6008.399160083956;6019.759209631653;5998.460138587461;6003.099535069775;6005.429484198994;6006.369331220247;6036.728347224385;4455.754933478625;4494.348319493721;4620.768961551909;4621.907561848744;4623.352730617717;4015.7992100394863;4050.5139383274195;4063;4070.61329173728;4112.157007813391;5716.771329146871;5721.313442386857;5732.742026608813;5734.512566431817;5741.971290143606;5827.271591051119;5899.970500147558;5940.79207227745;5973.104034394875;5974.163617093611;5587.525060369914;5632.633878797865;5639.041362968305;5683.232763576947;5715.114157305624;5030.119729047402;5056.620753443506;5057.165567681365;5058.620603454756;5060.721660308718;6128;6191.380861913773;6194.34959329273;6202.782902598387;6203.472704820141;5706.629069110494;5770.769169233184;5871.6770577618645;5932.377100404396;5933.554983376178;6205.441510264098;6212;6218.626882387071;6221.844453888689;6224.439800417984;5834.649921004753;5880.323762767165;5892.5285977122585;5893.852653683693;5933.584649074523;5745.540356771365;5787.508061814793;5870.677112758839;6000.8499787503915;6004.789832355847;5727.7422515986045;5768.134779783066;5798.536117110537;5802.4197580241635;5832.183494310885;5766.538676905921;5798.739056742373;5801.738921748447;5803.332616749128;5810.883782324415;5423.29497165366;5537.9169312459535;5708.80019199326;5712.11462223356;5712.514436272963;5605.04714198579;5690.77236910519;5703.372629010889;5749.1663708762835;5783.537317014545;5569.275994120739;5605.159226115952;5617.045102332531;5618.438156184349;5622.8313150605545 12:45:40 INFO - PROCESS | 31555 | |1;ext.html;590.0942053947191;596.2278848890686;596.3559355895633;625.346512894026;639.2648454277581;36475.63524364756;41112.58887411125;47842.28236576454;49440.25839612409;49456.75271623637;52303.73848130754;52858.20712689303;52860.20709689358;52885.2067218992;52958.205626915624;8630.827383452328;9443.102905223992;9677.322587418883;9680.225581953428;9684.322097453181;8593;11353.943230283838;11560.768784624302;11628.6511404658;12046.096542759284;11701.882981170165;11752.647420577396;11766.117541184445;11779.705507362341;11783.351915644636;11702.239354441977;11749.060075193964;11765.529378824836;11771.823422648667;11781.941090294536;11312.095032397388;11347.886521134766;11352.318860868374;11360.318380897173;11398.202125851194;48268.27597586039;48496;48580.27129593024;48645.51354486445;48666.270005949584;4316.935245971313;4395.516493185747;4434.157510073076;4538.909221815546;4562.019165879318;35047.29905401903;35068.82465587656;35629.28741425157;36045;36768.080797979994;4322.351647252937;4333.414988976479;4340.934885976713;4373.7813109344725;4466.59800617946;349703;351959.99999999744;352227;354567;354777;67482.32517674859;67652.3234767646;67966.32033679698;68034.65982670154;68104.31895681079;73276.63361683158;73302.26697733061;73349.6332518334;73586;73647.26352736511;19944.70082948757;20591.176352945713;20694.586108277752;20695;20701.171953121706;14759.926200369144;15114.09315441077;16334.346626134822;16451.095189764677;16452.424165154163;19163.425097247105;19519.532981675147;20317.187312507333;20327.186912523335;20454.284100056426;6831.897521537181;6866.313368663094;6882.9125777211575;7047;7088.468364872655;956.2746173405877;967.3035414501547;968.4916712702382;980.5097451274363;989.366805244644;34051.829740851135;34431.13922151966;34501.654983449844;34610.826945865614;35120.82439587837;1094.8905109488987;1154.8383226348317;1158.3281696615943;1158.5944919278354;1161.710501343508;18028.18309014607;18218.08909554517;18305.7254141188;18338.541536461697;18548.25806967706;474377;474856;476131;476384;476535;70644.2935570648;70779;70852.29147708457;70882.29117708757;71016.28983710097;1448.6595650022448;1501.7672260799593;1507.155992644101;1539.1227000609545;1544.1507171055875;31120.688793111778;34892.47661285134;35150.418231179145;35291.47062794112;35387;57046.144307834584;57811.710941445024;57930.420695792505;57983;58107.12839307329;297079;297679;298333;298436;552685;40059.59940400675;43931;43973.12053758843;44134.77932610316;48811;51913.22130168126;52595.73702131465;53416.198757019454;53600.46399535955;54220;39173.2165356697;39279.80360098181;39375.40936885892;39411.60588394079;41088.79455602703;38773.612263877;39057.218855623294;39097.41353879637;39591.604083958795;40361.192776143725;43004;43957.78021109874;44213.11573768571;44351.33472997843;44564.331535027646;31784.523232151998;33025;33437;35141.64858351384;36195.27609447849;26443.735562644128;27638.447231054863;27712;27723.168304950883;27723.445531088862 12:45:40 INFO - PROCESS | 31555 | |2;jquery.html;428.52005753556;430.33083555071863;449.59761013892586;449.8380582990123;455.41479199228996;20389.694154587676;20986.160553577858;22239.110435582556;22328.441788955242;22549.66175507369;21362.145514179414;21421.67867481989;21560.568788624256;21717.239896603623;22016.669749953722;6021.9397806021925;6229.875402491947;6231.345708700589;6231.750729970819;6237.3450787667325;5854.941450585482;6091.42131497507;6123.540734444912;6230.470410015154;6253;6049.637021778685;6159.10692949522;6221.0979407985815;6234;6234.158388617547;6321.5890967087225;6324.84187895304;6359.046143078529;6360.459360954302;6364.745410183587;6052.303985041688;6185.969070154665;6222.533310001768;6224.408681175281;6238.064290356483;14696.632584185374;14718.558443246613;14758.483453079198;14799.334029968677;15027.549173524812;2568.9486210275877;2634.1702363755358;2645.8147929644933;2655.4556315955183;2670.2923725212836;10631.468426578718;10740.355578665305;10781.676549703521;10891.346519208873;15538.145402002885;1945.085809669453;1960.8431325493925;1976.7825539190678;1979.8416126709828;1984.335247692025;90438;91964;92159.53920230424;92301;93276.53361733216;11702.76594468106;11791.88208117908;11901.404929753478;12239.755204895851;12390.132690711744;17736.822631773775;17744.29022839072;17777.46667599974;17792.199351029234;17799.555011124565;8740.912590874137;8795.956020219857;8909.866352004725;8980.8652870207;9084.22857542786;8272.131426200283;8326.625301861432;8333.2916702081;8487.36344774132;8567.74296771098;5314.096603577324;5344.412114667383;5395.920815836848;5441.075017247077;5442.156465747816;2175.2930297653324;2184.8361372897098;2224.2659922225625;2240.4846885216166;2291.8510296830655;953.7901661634429;954.8997355277735;957.8706874571983;961.251417995102;973.6494861849728;17619.647607047787;18931.242750289835;19097.80902190988;19367.12847921847;19410;986.3785814936545;992.0179022767409;992.93545919515;999.4253304350028;1018.7809620931536;10522.579096836194;10771.246012779031;10794.838077428845;10813;10921.399323037309;649444;665131;666022;668275;694439;76935;81559.5922020398;83876;107516.46241768898;111597.44201279104;1081.859358283434;1092.4646923007829;1119.8768135505088;1139.3619573039125;1140.6463996161217;17677;18076.909615452365;18126.81873181304;18296.542586434913;18569;37492.43761343636;38842.805785970886;43154.842257887605;43864.34203486887;44490.3326450097;60917.390826092946;61071.38928610657;61837.38162618316;62253;62332;8614.707793830976;8735.039145693841;8881.822363552821;8934.195922367018;9099.954500227721;9482.004389539276;12615.36923153857;13008.47966081384;13253.271070091238;13345;11106.444677765918;11214.831777523506;11221.495032723384;11348.489317980546;11866.584669536525;10747.623833165802;10800.729981750519;10835.837462437912;10988.945055274673;11070;11531.769364612494;11641.243319184226;11696.239744416585;11888;12129.636110916686;8837.425567338103;8850.468971861708;8917.509536975529;8980.101989800967;8997.55012249398;10066.597336106473;11581.82627260575;11587.420628968686;11726.589569365031;11804.114691398008 12:45:40 INFO - PROCESS | 31555 | |3;mootools.html;1501.3694248415663;1516.1888389711507;1521.7565189569668;1528.8471152884708;1532.9156896370703;8484.533350665712;9025;9050.683226087089;9052.773680657987;9054.094590540952;7904.407169462299;8080.838383232332;8095.271425571697;8433.15668433158;8877.86683199751;2382.892769825358;2428.9271321860374;2438.9512209755794;2441.633754936765;2447.6328550717444;2383.7616238376195;2406.7713567211085;2411.4815314707334;2421.32202983165;2424.539337525873;2312.387217387394;2383.8212134089927;2393.461471168982;2407.2898494944034;2410.216679579135;2346.202291220993;2352.1297120065515;2370.265217782493;2370.632551954441;2372.6796882420826;2397.0531640002278;2416.5408572371193;2420.0319872051145;2421.5278020785954;2422.769836865495;8616.65533378664;8750.168733970262;8750.3874728769;8786.692465763668;8789.824203515958;5215.322008138955;5328.094223981893;5334.279872217278;5339.385970613391;5346.465353464661;3110.16025673067;3288.408086544421;3396.8811091611924;3401.676840700154;3401.7448691348;1477;1490.2474250503426;1490.7167638148717;1514.4249980020766;1583.6753465539537;11637;11658.475368608433;11661.766764664659;11663.591774287945;11692.824607630891;4603.332516785114;4766.642501812308;4773.11697335994;4823.975880120577;4836.661433699607;10337.22470814692;10337.9483102584;10343.224258180666;10348.689539313833;10355.896441035493;5495.477929596682;5506.64206826555;5513.3108361454815;5519.448055194448;5519.9448005520235;4906;4929.433115191727;4932.876678083005;4949.430815456197;5023.399852106976;4096.815643296059;4187.685923555685;4217.599328063829;4248.277792775236;4285.271503844354;1333.4799428223;1350.8176396186389;1351.067763243359;1351.8107464954717;1360.8298962629672;995.5520015992832;1000.7348052766023;1004.1765752083368;1010.4442556593991;1013.8175128476945;5909.704514774244;5952.672603006876;6009.098635204667;6118.3269840317525;6179.3820617937845;615.3846153846154;620.8080485467913;631.5263552335748;644.9516286278548;647.870425914819;4025.5370632377067;4125.195586860534;4148.23257697321;4178.582141785858;4192.329227323614;9872.457014864107;10635.361878287327;10735.83896241557;10742.677719668422;10744.570217191382;9710.17463515609;10033.949830250802;10621.893781062245;10676.252662313564;10682.305650132717;7971.44199906001;8129.959350203329;8140.796480088045;8146.470479418819;8146.674133034612;6187.81436556904;6273.780417685359;6313.905291420724;6367.363263673596;6430.967845160744;10064.597416103274;10073.647422340184;10076.899231007596;10088.596456141671;10102;8980;9024.503652299187;9948.403095814274;9997.91875204399;10072;7559.092908850753;7763.456558040883;7821.061472623322;7836.92163078362;7841.333486653698;8415.579221039046;8417.789555261168;8457.238848503664;8461.111583283666;8474.491530508189;7313.085864266966;7401.259874012556;7408.073990751156;7435.107787065371;7436.59098749574;7251.347378735939;7273.0908636420445;7304.269573042653;7459.477836551389;7551.358134558624;6658.533902626769;6770.052192693125;6771.62756048422;6780.694868731018;6783.86432271342;5264.263003179634;5292.126799078263;5311.362636483646;5477.698726570077;5546.001719690495;5229;5234.502722241381;5359.490848369399;5373.059714550016;5385.38068122171 12:45:40 INFO - PROCESS | 31555 | |4;prototype.html;380.4122630535822;398.1638559026047;401.9176068905875;404.64593480704383;408.41800434380997;5266;5314.867128321794;5320.707361095143;5326.414094449608;5339.89320213596;5201.375834899808;5235.842924712265;5243.947560524393;5246.560349437511;5247.711375874325;4123.381492776085;4165.916681666365;4174.519930208019;4193.958060419387;4220.53574106848;4199.706020578561;4204.411382406465;4207.074443622413;4218.810153543098;4223.239816832969;4155.31437312843;4176.498820141587;4187.497500299968;4188;4207.137536804963;4126.370083816905;4136.462259906223;4171.33258678613;4202;4231.724937879058;3781.8676346327748;3786.6213378662187;3788.583255841855;3790.279846829121;3801.2207497462955;5117.974410127963;5122.1036318644465;5174.327337446108;5183.740812959337;5186;4670.696404733681;4759.643026773006;4885.7312847793355;4891.608671306287;4895.510448955111;5503.2114562766865;5504.587155963279;5505.972470137664;5517.200005999148;5540.722963851832;4106.7535947842925;4137.668986481074;4139;4162.209180255742;4165.2294325549565;5143.434222235551;5490.929268792587;5590.273264475592;5763.452472015152;5813.88372232553;4197.433346498245;4214.17823524416;4219.725717828332;4226.344916537942;4227.598378154071;4267.594578515098;4276.679249056333;4282.5075116361395;4305.677074219383;4307.22469955411;4741.0754902794315;4779.617630589544;4803.910299019937;4810.6151507879285;4825.565699087099;5421.403645598981;5491.203775452537;5523.7790488380815;5531.723413829292;5536.363318218376;1414.5119933623089;1434.938145772121;1435.1532595768547;1449.724552335053;1467;1007.6725064354114;1030.6959446963165;1030.7682319628123;1033.8862725100232;1053.115383078218;5179.741012949337;5180.704823794052;5206.219067139959;5237.711925844039;5276.36683597963;5406.91889621656;5502.147167189092;5503.669779813144;5504.779808807683;5530.446955304437;4874.707517548958;5123.103456895103;5159.122949098587;5193.350831146106;5258.763355649005;2878.280429892527;2879.6832348441653;2882.827030378184;2904.0852131578486;2908.418316336741;5605.579581531401;5658.207850900877;5680.86382723457;5681.431856814368;5688.459596338341;5294.481218597999;5496.718861672442;5512.4211957744665;5596.440355964371;5608.270924779753;5642.322921249394;5770.6249093808765;5771.5571107223195;5796.275465566804;5810.477057064884;5583;5584.329880414376;5599.272094627672;5607.990561698934;5641.774329026793;5354.3574771027725;5477.698726569917;5488.368837583729;5573.27547418833;5581.302337207849;5809.680467574324;5828;5835.416458354131;5836.678982655994;5852.151438041546;4188.602082802129;4294.248506511411;4295.334223195285;4304.892377690458;4309.6983211176175;5583;5589.776408943597;5590.021746194318;5596.38439771633;5599.216109744721;5439.3200849893765;5458.0721277382145;5466.753996070107;5483.424240454695;5485.61600687948;5398.102676370247;5411.567074633941;5415.756290966837;5504.7522861470525;5510.201020852034;5401.3248343957;5423.945760542344;5433.587267310607;5442.183672449164;5443.673379597237;5470.370907345706;5471.604740791073;5506.669599824023;5510.862228444321;5534.972325138348;5182.170852663707;5362.892742145057;5381.73091345439;5424.267723857229;5430.972845135749 12:45:40 INFO - PROCESS | 31555 | |5;yui.html;777.9035499329307;793.452517762744;811.9391045671572;900.9231742955049;911.1253196930946;15072.773908391382;16473.752893706605;16765.077920714357;16891.23989420476;17275.568110797238;15903.204839758024;16328.101954392503;16461.423850165247;16563.751543726823;16598.419055333066;721.8375865430289;742.1279996004699;839.4459656626627;854.1245223645782;855.3713020929612;816.3306089007017;839.0686338164633;843.1189407069596;846.0820010288844;846.9026062002887;874.9125087491263;880.3309484791572;881.7046289493028;882.9867551986725;883.147762409275;875.2472873328932;875.8117004843957;875.8642410426394;876.3514998900831;876.7939534209455;643.8326035230826;644.8065580325883;646.6249575246346;646.7316063833504;647.6470323673609;15132.092074475457;15138.772918406232;15171.468998585107;16278.26747796352;16793.580160496087;15075.773863392058;15675.216239187996;15851.762223566655;15917.442889498927;16247.675046499122;12422.192557483824;12936.094473386867;12942.870571294261;13025.54410595634;13042.804357934638;4034.374671925856;4047.6761859051207;4117.938230926538;4143.585641435862;4148.709590328678;84379.5781021097;85360.71958920559;86155.99999999937;86936.56531717301;88000;12630.242185468902;12745.936270318774;12813.295268760121;12928.224306541637;13004.934975325252;24414.26757197287;24471.510569788505;24523.264302070966;24526.386840329134;24536;8879.822403551892;8898.73303800887;8909.242714369351;9057.139571740807;9223.308251881135;5055.216441451581;5102.540771330598;5103.489651034941;5251.579873610179;5266.315379000782;3837.0599203195397;3846.6345697158727;3871.7676939383164;3887.688984881203;3927.4697915781576;669.0332469581408;677.5392732941647;684.226823689228;688.4836372720459;692.7506097804786;831.1895901495993;840.878072679458;847.1401527449643;857.9914200857911;860.2043110123111;10336.948315258376;10459.267851250339;10637.574497020187;10942.945285273681;11021.118310535137;778.4745296924553;781.6951388958311;785.8860465232509;801.903771547418;818.6602559937678;5223.347081614798;5351.09031464652;5369.40936496985;5398.568114550826;5402.540784033401;78367;81073.18926810774;81935;83210.58394707988;83453.58273208716;75192;75530.24469755232;76501;78119.60940195377;78844.21155788483;63410.6829465859;64981.35018649847;65231.67384163049;65250.67374663191;65763.67118164475;10040.182693987688;10297.845532316871;10354.585816567555;10361.481925903825;10374.896251037393;37840.648325442926;42460.9384765371;43071.78464107659;44789.552104478535;45584.77207613941;56001;57047;57573.4242657568;58695.70652146883;59616.403835961086;13113.08208425401;13282.86717132855;13492.93253533726;13622.114562553403;13622.38699258516;15283.694326113193;15657.530274091796;15658.45195418155;16410.917945410198;16563;14410.42358305656;14610.926945365205;14643.487477938646;15132.697346053237;15436.536903892902;13828.723425531634;13886.236257005557;13926.094803837717;13960.2321872298;14082.718345633235;14225.715485690434;14296.142231466145;14727.92636036813;14761.55715328542;15200.695986079996;8982.236509896731;9195.724128276162;9345.579448924951;9369.859452108087;9542.52287385614;11112.777744445228;11340.432978350884;11406;11571.19001669875;11616.244944078608 12:45:40 INFO - PROCESS | 31555 | __end_tp_report 12:45:40 INFO - PROCESS | 31555 | __start_cc_report 12:45:40 INFO - PROCESS | 31555 | _x_x_mozilla_cycle_collect,865 12:45:40 INFO - PROCESS | 31555 | __end_cc_report 12:45:40 INFO - PROCESS | 31555 | __startTimestamp1491939940698__endTimestamp 12:45:40 INFO - PROCESS | 31555 | 12:45:40 INFO - PROCESS | 31555 | ------- Summary: start ------- 12:45:40 INFO - PROCESS | 31555 | Number of tests: 6 12:45:40 INFO - PROCESS | 31555 | 12:45:40 INFO - PROCESS | 31555 | [#0] dojo.html Cycles:165 Average:5508.50 Median:5712.11 stddev:619.75 (10.8%) stddev-sans-first:596.72 12:45:40 INFO - PROCESS | 31555 | Values: 3290.0 3333.8 3337.7 3362.3 3383.7 5453.8 5532.2 5540.5 5540.8 5542.1 5563.3 5623.6 5625.6 5626.6 5668.7 4979.5 4991.7 5025.4 5049.9 5066.4 4831.3 5040.6 5083.1 5084.8 5085.8 4825.8 4939.4 4996.9 4998.9 5065.6 5026.6 5054.6 5059.4 5067.8 5081.2 4926.0 4982.0 5034.3 5041.6 5049.7 5356.0 5403.6 5417.1 5489.5 5504.9 5919.8 5960.2 5963.0 5966.6 5971.5 6010.1 6013.2 6021.4 6030.6 6033.2 5355.2 5385.9 5501.4 5553.4 5587.6 6114.2 6120.1 6126.9 6133.6 6136.0 5832.0 5863.6 5864.9 5880.1 5887.4 5701.0 5716.4 5881.7 5961.8 5978.1 5916.5 5925.8 5983.3 6008.4 6019.8 5998.5 6003.1 6005.4 6006.4 6036.7 4455.8 4494.3 4620.8 4621.9 4623.4 4015.8 4050.5 4063.0 4070.6 4112.2 5716.8 5721.3 5732.7 5734.5 5742.0 5827.3 5900.0 5940.8 5973.1 5974.2 5587.5 5632.6 5639.0 5683.2 5715.1 5030.1 5056.6 5057.2 5058.6 5060.7 6128.0 6191.4 6194.3 6202.8 6203.5 5706.6 5770.8 5871.7 5932.4 5933.6 6205.4 6212.0 6218.6 6221.8 6224.4 5834.6 5880.3 5892.5 5893.9 5933.6 5745.5 5787.5 5870.7 6000.8 6004.8 5727.7 5768.1 5798.5 5802.4 5832.2 5766.5 5798.7 5801.7 5803.3 5810.9 5423.3 5537.9 5708.8 5712.1 5712.5 5605.0 5690.8 5703.4 5749.2 5783.5 5569.3 5605.2 5617.0 5618.4 5622.8 12:45:40 INFO - PROCESS | 31555 | 12:45:40 INFO - PROCESS | 31555 | [#1] ext.html Cycles:180 Average:59152.73 Median:39501.60 stddev:105674.31 (267.5%) stddev-sans-first:105879.27 12:45:40 INFO - PROCESS | 31555 | Values: 590.1 596.2 596.4 625.3 639.3 36475.6 41112.6 47842.3 49440.3 49456.8 52303.7 52858.2 52860.2 52885.2 52958.2 8630.8 9443.1 9677.3 9680.2 9684.3 8593.0 11353.9 11560.8 11628.7 12046.1 11701.9 11752.6 11766.1 11779.7 11783.4 11702.2 11749.1 11765.5 11771.8 11781.9 11312.1 11347.9 11352.3 11360.3 11398.2 48268.3 48496.0 48580.3 48645.5 48666.3 4316.9 4395.5 4434.2 4538.9 4562.0 35047.3 35068.8 35629.3 36045.0 36768.1 4322.4 4333.4 4340.9 4373.8 4466.6 349703.0 351960.0 352227.0 354567.0 354777.0 67482.3 67652.3 67966.3 68034.7 68104.3 73276.6 73302.3 73349.6 73586.0 73647.3 19944.7 20591.2 20694.6 20695.0 20701.2 14759.9 15114.1 16334.3 16451.1 16452.4 19163.4 19519.5 20317.2 20327.2 20454.3 6831.9 6866.3 6882.9 7047.0 7088.5 956.3 967.3 968.5 980.5 989.4 34051.8 34431.1 34501.7 34610.8 35120.8 1094.9 1154.8 1158.3 1158.6 1161.7 18028.2 18218.1 18305.7 18338.5 18548.3 474377.0 474856.0 476131.0 476384.0 476535.0 70644.3 70779.0 70852.3 70882.3 71016.3 1448.7 1501.8 1507.2 1539.1 1544.2 31120.7 34892.5 35150.4 35291.5 35387.0 57046.1 57811.7 57930.4 57983.0 58107.1 297079.0 297679.0 298333.0 298436.0 552685.0 40059.6 43931.0 43973.1 44134.8 48811.0 51913.2 52595.7 53416.2 53600.5 54220.0 39173.2 39279.8 39375.4 39411.6 41088.8 38773.6 39057.2 39097.4 39591.6 40361.2 43004.0 43957.8 44213.1 44351.3 44564.3 31784.5 33025.0 33437.0 35141.6 36195.3 26443.7 27638.4 27712.0 27723.2 27723.4 12:45:40 INFO - PROCESS | 31555 | 12:45:40 INFO - PROCESS | 31555 | [#2] jquery.html Cycles:180 Average:34532.42 Median:2662.87 stddev:109710.74 (4120.0%) stddev-sans-first:109988.62 12:45:40 INFO - PROCESS | 31555 | Values: 428.5 430.3 449.6 449.8 455.4 20389.7 20986.2 22239.1 22328.4 22549.7 21362.1 21421.7 21560.6 21717.2 22016.7 6021.9 6229.9 6231.3 6231.8 6237.3 5854.9 6091.4 6123.5 6230.5 6253.0 6049.6 6159.1 6221.1 6234.0 6234.2 6321.6 6324.8 6359.0 6360.5 6364.7 6052.3 6186.0 6222.5 6224.4 6238.1 14696.6 14718.6 14758.5 14799.3 15027.5 2568.9 2634.2 2645.8 2655.5 2670.3 10631.5 10740.4 10781.7 10891.3 15538.1 1945.1 1960.8 1976.8 1979.8 1984.3 90438.0 91964.0 92159.5 92301.0 93276.5 11702.8 11791.9 11901.4 12239.8 12390.1 17736.8 17744.3 17777.5 17792.2 17799.6 8740.9 8796.0 8909.9 8980.9 9084.2 8272.1 8326.6 8333.3 8487.4 8567.7 5314.1 5344.4 5395.9 5441.1 5442.2 2175.3 2184.8 2224.3 2240.5 2291.9 953.8 954.9 957.9 961.3 973.6 17619.6 18931.2 19097.8 19367.1 19410.0 986.4 992.0 992.9 999.4 1018.8 10522.6 10771.2 10794.8 10813.0 10921.4 649444.0 665131.0 666022.0 668275.0 694439.0 76935.0 81559.6 83876.0 107516.5 111597.4 1081.9 1092.5 1119.9 1139.4 1140.6 17677.0 18076.9 18126.8 18296.5 18569.0 37492.4 38842.8 43154.8 43864.3 44490.3 60917.4 61071.4 61837.4 62253.0 62332.0 8614.7 8735.0 8881.8 8934.2 9100.0 9482.0 12615.4 13008.5 13253.3 13345.0 11106.4 11214.8 11221.5 11348.5 11866.6 10747.6 10800.7 10835.8 10988.9 11070.0 11531.8 11641.2 11696.2 11888.0 12129.6 8837.4 8850.5 8917.5 8980.1 8997.6 10066.6 11581.8 11587.4 11726.6 11804.1 12:45:40 INFO - PROCESS | 31555 | 12:45:40 INFO - PROCESS | 31555 | [#3] mootools.html Cycles:180 Average:5767.30 Median:4941.15 stddev:3157.10 (63.9%) stddev-sans-first:3149.68 12:45:40 INFO - PROCESS | 31555 | Values: 1501.4 1516.2 1521.8 1528.8 1532.9 8484.5 9025.0 9050.7 9052.8 9054.1 7904.4 8080.8 8095.3 8433.2 8877.9 2382.9 2428.9 2439.0 2441.6 2447.6 2383.8 2406.8 2411.5 2421.3 2424.5 2312.4 2383.8 2393.5 2407.3 2410.2 2346.2 2352.1 2370.3 2370.6 2372.7 2397.1 2416.5 2420.0 2421.5 2422.8 8616.7 8750.2 8750.4 8786.7 8789.8 5215.3 5328.1 5334.3 5339.4 5346.5 3110.2 3288.4 3396.9 3401.7 3401.7 1477.0 1490.2 1490.7 1514.4 1583.7 11637.0 11658.5 11661.8 11663.6 11692.8 4603.3 4766.6 4773.1 4824.0 4836.7 10337.2 10337.9 10343.2 10348.7 10355.9 5495.5 5506.6 5513.3 5519.4 5519.9 4906.0 4929.4 4932.9 4949.4 5023.4 4096.8 4187.7 4217.6 4248.3 4285.3 1333.5 1350.8 1351.1 1351.8 1360.8 995.6 1000.7 1004.2 1010.4 1013.8 5909.7 5952.7 6009.1 6118.3 6179.4 615.4 620.8 631.5 645.0 647.9 4025.5 4125.2 4148.2 4178.6 4192.3 9872.5 10635.4 10735.8 10742.7 10744.6 9710.2 10033.9 10621.9 10676.3 10682.3 7971.4 8130.0 8140.8 8146.5 8146.7 6187.8 6273.8 6313.9 6367.4 6431.0 10064.6 10073.6 10076.9 10088.6 10102.0 8980.0 9024.5 9948.4 9997.9 10072.0 7559.1 7763.5 7821.1 7836.9 7841.3 8415.6 8417.8 8457.2 8461.1 8474.5 7313.1 7401.3 7408.1 7435.1 7436.6 7251.3 7273.1 7304.3 7459.5 7551.4 6658.5 6770.1 6771.6 6780.7 6783.9 5264.3 5292.1 5311.4 5477.7 5546.0 5229.0 5234.5 5359.5 5373.1 5385.4 12:45:40 INFO - PROCESS | 31555 | 12:45:40 INFO - PROCESS | 31555 | [#4] prototype.html Cycles:180 Average:4655.13 Median:5236.78 stddev:1312.50 (25.1%) stddev-sans-first:1276.36 12:45:40 INFO - PROCESS | 31555 | Values: 380.4 398.2 401.9 404.6 408.4 5266.0 5314.9 5320.7 5326.4 5339.9 5201.4 5235.8 5243.9 5246.6 5247.7 4123.4 4165.9 4174.5 4194.0 4220.5 4199.7 4204.4 4207.1 4218.8 4223.2 4155.3 4176.5 4187.5 4188.0 4207.1 4126.4 4136.5 4171.3 4202.0 4231.7 3781.9 3786.6 3788.6 3790.3 3801.2 5118.0 5122.1 5174.3 5183.7 5186.0 4670.7 4759.6 4885.7 4891.6 4895.5 5503.2 5504.6 5506.0 5517.2 5540.7 4106.8 4137.7 4139.0 4162.2 4165.2 5143.4 5490.9 5590.3 5763.5 5813.9 4197.4 4214.2 4219.7 4226.3 4227.6 4267.6 4276.7 4282.5 4305.7 4307.2 4741.1 4779.6 4803.9 4810.6 4825.6 5421.4 5491.2 5523.8 5531.7 5536.4 1414.5 1434.9 1435.2 1449.7 1467.0 1007.7 1030.7 1030.8 1033.9 1053.1 5179.7 5180.7 5206.2 5237.7 5276.4 5406.9 5502.1 5503.7 5504.8 5530.4 4874.7 5123.1 5159.1 5193.4 5258.8 2878.3 2879.7 2882.8 2904.1 2908.4 5605.6 5658.2 5680.9 5681.4 5688.5 5294.5 5496.7 5512.4 5596.4 5608.3 5642.3 5770.6 5771.6 5796.3 5810.5 5583.0 5584.3 5599.3 5608.0 5641.8 5354.4 5477.7 5488.4 5573.3 5581.3 5809.7 5828.0 5835.4 5836.7 5852.2 4188.6 4294.2 4295.3 4304.9 4309.7 5583.0 5589.8 5590.0 5596.4 5599.2 5439.3 5458.1 5466.8 5483.4 5485.6 5398.1 5411.6 5415.8 5504.8 5510.2 5401.3 5423.9 5433.6 5442.2 5443.7 5470.4 5471.6 5506.7 5510.9 5535.0 5182.2 5362.9 5381.7 5424.3 5431.0 12:45:40 INFO - PROCESS | 31555 | 12:45:40 INFO - PROCESS | 31555 | [#5] yui.html Cycles:180 Average:18713.82 Median:5078.88 stddev:23882.70 (470.2%) stddev-sans-first:23911.72 12:45:40 INFO - PROCESS | 31555 | Values: 777.9 793.5 811.9 900.9 911.1 15072.8 16473.8 16765.1 16891.2 17275.6 15903.2 16328.1 16461.4 16563.8 16598.4 721.8 742.1 839.4 854.1 855.4 816.3 839.1 843.1 846.1 846.9 874.9 880.3 881.7 883.0 883.1 875.2 875.8 875.9 876.4 876.8 643.8 644.8 646.6 646.7 647.6 15132.1 15138.8 15171.5 16278.3 16793.6 15075.8 15675.2 15851.8 15917.4 16247.7 12422.2 12936.1 12942.9 13025.5 13042.8 4034.4 4047.7 4117.9 4143.6 4148.7 84379.6 85360.7 86156.0 86936.6 88000.0 12630.2 12745.9 12813.3 12928.2 13004.9 24414.3 24471.5 24523.3 24526.4 24536.0 8879.8 8898.7 8909.2 9057.1 9223.3 5055.2 5102.5 5103.5 5251.6 5266.3 3837.1 3846.6 3871.8 3887.7 3927.5 669.0 677.5 684.2 688.5 692.8 831.2 840.9 847.1 858.0 860.2 10336.9 10459.3 10637.6 10942.9 11021.1 778.5 781.7 785.9 801.9 818.7 5223.3 5351.1 5369.4 5398.6 5402.5 78367.0 81073.2 81935.0 83210.6 83453.6 75192.0 75530.2 76501.0 78119.6 78844.2 63410.7 64981.4 65231.7 65250.7 65763.7 10040.2 10297.8 10354.6 10361.5 10374.9 37840.6 42460.9 43071.8 44789.6 45584.8 56001.0 57047.0 57573.4 58695.7 59616.4 13113.1 13282.9 13492.9 13622.1 13622.4 15283.7 15657.5 15658.5 16410.9 16563.0 14410.4 14610.9 14643.5 15132.7 15436.5 13828.7 13886.2 13926.1 13960.2 14082.7 14225.7 14296.1 14727.9 14761.6 15200.7 8982.2 9195.7 9345.6 9369.9 9542.5 11112.8 11340.4 11406.0 11571.2 11616.2 12:45:40 INFO - PROCESS | 31555 | -------- Summary: end -------- 12:45:40 INFO - PROCESS | 31555 | 12:45:41 INFO - TEST-INFO | 31555: exit 0 12:45:41 INFO - TEST-OK | dromaeo_css | took 1112634ms 12:45:41 INFO - TEST-START | kraken 12:45:41 INFO - operating with platform_type : linux_ 12:45:41 INFO - Initialising browser for kraken test... 12:45:41 INFO - TEST-INFO | started process 31858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpntBrAz/profile http://localhost:48178/getInfo.html) 12:45:45 INFO - PROCESS | 31858 | __metrics Screen width/height:1600/1200 12:45:45 INFO - PROCESS | 31858 | colorDepth:24 12:45:45 INFO - PROCESS | 31858 | Browser inner width/height: 1024/697 12:45:45 INFO - PROCESS | 31858 | __metrics 12:45:46 INFO - PROCESS | 31858 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:45:46 INFO - PROCESS | 31858 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:45:46 INFO - TEST-INFO | 31858: exit 0 12:45:46 INFO - Browser initialized. 12:45:46 INFO - Running cycle 1/1 for kraken test... 12:45:46 INFO - TEST-INFO | started process 31952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpntBrAz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:45:58 INFO - PROCESS | 31952 | RSS: Main: 140890112 12:45:58 INFO - PROCESS | 31952 | 12:46:01 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48178/tests/kraken/driver.html?testName=audio-beat-detection) 12:46:01 INFO - PROCESS | 31952 | RSS: Main: 181825536 12:46:01 INFO - PROCESS | 31952 | 12:46:04 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48178/tests/kraken/driver.html?testName=audio-dft) 12:46:04 INFO - PROCESS | 31952 | RSS: Main: 171753472 12:46:04 INFO - PROCESS | 31952 | 12:46:07 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48178/tests/kraken/driver.html?testName=audio-fft) 12:46:08 INFO - PROCESS | 31952 | RSS: Main: 263720960 12:46:08 INFO - PROCESS | 31952 | 12:46:10 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48178/tests/kraken/driver.html?testName=audio-oscillator) 12:46:10 INFO - PROCESS | 31952 | RSS: Main: 170024960 12:46:10 INFO - PROCESS | 31952 | 12:46:13 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48178/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:46:13 INFO - PROCESS | 31952 | RSS: Main: 172613632 12:46:13 INFO - PROCESS | 31952 | 12:46:16 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48178/tests/kraken/driver.html?testName=imaging-darkroom) 12:46:17 INFO - PROCESS | 31952 | RSS: Main: 207106048 12:46:17 INFO - PROCESS | 31952 | 12:46:20 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48178/tests/kraken/driver.html?testName=imaging-desaturate) 12:46:21 INFO - PROCESS | 31952 | RSS: Main: 209395712 12:46:21 INFO - PROCESS | 31952 | 12:46:23 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48178/tests/kraken/driver.html?testName=json-parse-financial) 12:46:24 INFO - PROCESS | 31952 | RSS: Main: 208556032 12:46:24 INFO - PROCESS | 31952 | 12:46:26 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48178/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:46:26 INFO - PROCESS | 31952 | RSS: Main: 171507712 12:46:26 INFO - PROCESS | 31952 | 12:46:28 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:46:28 INFO - PROCESS | 31952 | RSS: Main: 178913280 12:46:28 INFO - PROCESS | 31952 | 12:46:30 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:46:31 INFO - PROCESS | 31952 | RSS: Main: 187756544 12:46:31 INFO - PROCESS | 31952 | 12:46:34 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:46:34 INFO - PROCESS | 31952 | RSS: Main: 196317184 12:46:34 INFO - PROCESS | 31952 | 12:46:37 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:46:37 INFO - PROCESS | 31952 | RSS: Main: 193380352 12:46:37 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | Cycle 1(1): loaded http://localhost:48178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48178/tests/kraken/driver.html?testName=ai-astar) 12:46:39 INFO - PROCESS | 31952 | RSS: Main: 244703232 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | __start_tp_report 12:46:39 INFO - PROCESS | 31952 | _x_x_mozilla_page_load 12:46:39 INFO - PROCESS | 31952 | _x_x_mozilla_page_load_details 12:46:39 INFO - PROCESS | 31952 | |i|pagename|runs| 12:46:39 INFO - PROCESS | 31952 | |0;ai-astar;103;111;111;111;113;110;111;111;110;111 12:46:39 INFO - PROCESS | 31952 | |1;audio-beat-detection;141;116;118;164;115;117;116;115;133;115 12:46:39 INFO - PROCESS | 31952 | |2;audio-dft;167;161;163;159;160;159;161;161;160;160 12:46:39 INFO - PROCESS | 31952 | |3;audio-fft;75;74;76;118;75;75;75;75;90;75 12:46:39 INFO - PROCESS | 31952 | |4;audio-oscillator;82;81;106;82;81;82;92;82;82;98 12:46:39 INFO - PROCESS | 31952 | |5;imaging-gaussian-blur;116;116;117;116;118;117;116;117;117;117 12:46:39 INFO - PROCESS | 31952 | |6;imaging-darkroom;146;148;146;146;147;146;146;146;148;146 12:46:39 INFO - PROCESS | 31952 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;95;95 12:46:39 INFO - PROCESS | 31952 | |8;json-parse-financial;55;57;53;51;53;53;52;55;52;53 12:46:39 INFO - PROCESS | 31952 | |9;json-stringify-tinderbox;63;64;64;64;64;63;64;64;64;64 12:46:39 INFO - PROCESS | 31952 | |10;stanford-crypto-aes;75;79;80;78;74;79;79;75;73;80 12:46:39 INFO - PROCESS | 31952 | |11;stanford-crypto-ccm;126;120;121;120;120;122;124;117;158;120 12:46:39 INFO - PROCESS | 31952 | |12;stanford-crypto-pbkdf2;157;153;151;154;154;158;153;152;155;153 12:46:39 INFO - PROCESS | 31952 | |13;stanford-crypto-sha256-iterative;60;59;60;59;61;59;61;59;63;62 12:46:39 INFO - PROCESS | 31952 | __end_tp_report 12:46:39 INFO - PROCESS | 31952 | __start_cc_report 12:46:39 INFO - PROCESS | 31952 | _x_x_mozilla_cycle_collect,1514 12:46:39 INFO - PROCESS | 31952 | __end_cc_report 12:46:39 INFO - PROCESS | 31952 | __startTimestamp1491939999823__endTimestamp 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | ------- Summary: start ------- 12:46:39 INFO - PROCESS | 31952 | Number of tests: 14 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.66 (2.4%) stddev-sans-first:0.87 12:46:39 INFO - PROCESS | 31952 | Values: 103.0 111.0 111.0 111.0 113.0 110.0 111.0 111.0 110.0 111.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:117.50 stddev:16.38 (13.9%) stddev-sans-first:16.32 12:46:39 INFO - PROCESS | 31952 | Values: 141.0 116.0 118.0 164.0 115.0 117.0 116.0 115.0 133.0 115.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:2.38 (1.5%) stddev-sans-first:1.24 12:46:39 INFO - PROCESS | 31952 | Values: 167.0 161.0 163.0 159.0 160.0 159.0 161.0 161.0 160.0 160.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:13.90 (18.5%) stddev-sans-first:14.59 12:46:39 INFO - PROCESS | 31952 | Values: 75.0 74.0 76.0 118.0 75.0 75.0 75.0 75.0 90.0 75.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:82.00 stddev:8.84 (10.8%) stddev-sans-first:9.21 12:46:39 INFO - PROCESS | 31952 | Values: 82.0 81.0 106.0 82.0 81.0 82.0 92.0 82.0 82.0 98.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 12:46:39 INFO - PROCESS | 31952 | Values: 116.0 116.0 117.0 116.0 118.0 117.0 116.0 117.0 117.0 117.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 12:46:39 INFO - PROCESS | 31952 | Values: 146.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 148.0 146.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 12:46:39 INFO - PROCESS | 31952 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.78 (3.4%) stddev-sans-first:1.79 12:46:39 INFO - PROCESS | 31952 | Values: 55.0 57.0 53.0 51.0 53.0 53.0 52.0 55.0 52.0 53.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 12:46:39 INFO - PROCESS | 31952 | Values: 63.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 64.0 64.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:79.00 stddev:2.66 (3.4%) stddev-sans-first:2.70 12:46:39 INFO - PROCESS | 31952 | Values: 75.0 79.0 80.0 78.0 74.0 79.0 79.0 75.0 73.0 80.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:121.50 stddev:11.92 (9.8%) stddev-sans-first:12.64 12:46:39 INFO - PROCESS | 31952 | Values: 126.0 120.0 121.0 120.0 120.0 122.0 124.0 117.0 158.0 120.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.00 stddev:2.16 (1.4%) stddev-sans-first:2.00 12:46:39 INFO - PROCESS | 31952 | Values: 157.0 153.0 151.0 154.0 154.0 158.0 153.0 152.0 155.0 153.0 12:46:39 INFO - PROCESS | 31952 | 12:46:39 INFO - PROCESS | 31952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.50 stddev:1.42 (2.3%) stddev-sans-first:1.50 12:46:39 INFO - PROCESS | 31952 | Values: 60.0 59.0 60.0 59.0 61.0 59.0 61.0 59.0 63.0 62.0 12:46:39 INFO - PROCESS | 31952 | -------- Summary: end -------- 12:46:39 INFO - PROCESS | 31952 | 12:46:40 INFO - TEST-INFO | 31952: exit 0 12:46:40 INFO - TEST-OK | kraken | took 59422ms 12:46:40 INFO - SUITE-END | took 1172s 12:46:40 INFO - Completed test suite (00:19:32) 12:46:40 INFO - javascript benchmark 12:46:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3289.98355008225, 3333.79997200168, 3337.6662333766626, 3362.2603027334007, 3383.746219033573, 5453.781848726051, 5532.225488431618, 5540.501354878055, 5540.833774986747, 5542.1132618781, 5563.332400111982, 5623.578231632634, 5625.578081643873, 5626.634268772527, 5668.68822214778, 4979.452260251379, 4991.650584459089, 5025.422076461199, 5049.949500505003, 5066.392032956051, 4831.275308703687, 5040.5967522598285, 5083.135866902636, 5084.822031228908, 5085.771140298695, 4825.806967721287, 4939.43196532398, 4996.900061998776, 4998.875028124289, 5065.6200784941275, 5026.597872170236, 5054.620903432239, 5059.418166910816, 5067.847964561069, 5081.161608334657, 4925.975370123162, 4981.9750901245625, 5034.295198672189, 5041.647084704072, 5049.722265275408, 5356.035913535562, 5403.567714582824, 5417.133258678593, 5489.505944464978, 5504.91742623861, 5919.822405327804, 5960.225170727821, 5963.0, 5966.612170208922, 5971.522278217775, 6010.098485227207, 6013.1581578579035, 6021.36775638556, 6030.6080104793045, 6033.155358249848, 5355.169948657965, 5385.919211211835, 5501.449855014466, 5553.389127196006, 5587.636803607753, 6114.206128133723, 6120.121705268071, 6126.884121540821, 6133.601315914451, 6135.969320153371, 5832.0, 5863.648181109147, 5864.882702345929, 5880.088586269135, 5887.35239123696, 5701.0308247598, 5716.428357164334, 5881.705914704247, 5961.791337303173, 5978.073398623221, 5916.467517923407, 5925.822225333247, 5983.341832398432, 6008.399160083956, 6019.759209631653, 5998.460138587461, 6003.099535069775, 6005.429484198994, 6006.369331220247, 6036.728347224385, 4455.754933478625, 4494.348319493721, 4620.768961551909, 4621.907561848744, 4623.352730617717, 4015.7992100394863, 4050.5139383274195, 4063.0, 4070.61329173728, 4112.157007813391, 5716.771329146871, 5721.313442386857, 5732.742026608813, 5734.512566431817, 5741.971290143606, 5827.271591051119, 5899.970500147558, 5940.79207227745, 5973.104034394875, 5974.163617093611, 5587.525060369914, 5632.633878797865, 5639.041362968305, 5683.232763576947, 5715.114157305624, 5030.119729047402, 5056.620753443506, 5057.165567681365, 5058.620603454756, 5060.721660308718, 6128.0, 6191.380861913773, 6194.34959329273, 6202.782902598387, 6203.472704820141, 5706.629069110494, 5770.769169233184, 5871.6770577618645, 5932.377100404396, 5933.554983376178, 6205.441510264098, 6212.0, 6218.626882387071, 6221.844453888689, 6224.439800417984, 5834.649921004753, 5880.323762767165, 5892.5285977122585, 5893.852653683693, 5933.584649074523, 5745.540356771365, 5787.508061814793, 5870.677112758839, 6000.8499787503915, 6004.789832355847, 5727.7422515986045, 5768.134779783066, 5798.536117110537, 5802.4197580241635, 5832.183494310885, 5766.538676905921, 5798.739056742373, 5801.738921748447, 5803.332616749128, 5810.883782324415, 5423.29497165366, 5537.9169312459535, 5708.80019199326, 5712.11462223356, 5712.514436272963, 5605.04714198579, 5690.77236910519, 5703.372629010889, 5749.1663708762835, 5783.537317014545, 5569.275994120739, 5605.159226115952, 5617.045102332531, 5618.438156184349, 5622.8313150605545], "value": 5468.129293245345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.0942053947191, 596.2278848890686, 596.3559355895633, 625.346512894026, 639.2648454277581, 36475.63524364756, 41112.58887411125, 47842.28236576454, 49440.25839612409, 49456.75271623637, 52303.73848130754, 52858.20712689303, 52860.20709689358, 52885.2067218992, 52958.205626915624, 8630.827383452328, 9443.102905223992, 9677.322587418883, 9680.225581953428, 9684.322097453181, 8593.0, 11353.943230283838, 11560.768784624302, 11628.6511404658, 12046.096542759284, 11701.882981170165, 11752.647420577396, 11766.117541184445, 11779.705507362341, 11783.351915644636, 11702.239354441977, 11749.060075193964, 11765.529378824836, 11771.823422648667, 11781.941090294536, 11312.095032397388, 11347.886521134766, 11352.318860868374, 11360.318380897173, 11398.202125851194, 48268.27597586039, 48496.0, 48580.27129593024, 48645.51354486445, 48666.270005949584, 4316.935245971313, 4395.516493185747, 4434.157510073076, 4538.909221815546, 4562.019165879318, 35047.29905401903, 35068.82465587656, 35629.28741425157, 36045.0, 36768.080797979994, 4322.351647252937, 4333.414988976479, 4340.934885976713, 4373.7813109344725, 4466.59800617946, 349703.0, 351959.99999999744, 352227.0, 354567.0, 354777.0, 67482.32517674859, 67652.3234767646, 67966.32033679698, 68034.65982670154, 68104.31895681079, 73276.63361683158, 73302.26697733061, 73349.6332518334, 73586.0, 73647.26352736511, 19944.70082948757, 20591.176352945713, 20694.586108277752, 20695.0, 20701.171953121706, 14759.926200369144, 15114.09315441077, 16334.346626134822, 16451.095189764677, 16452.424165154163, 19163.425097247105, 19519.532981675147, 20317.187312507333, 20327.186912523335, 20454.284100056426, 6831.897521537181, 6866.313368663094, 6882.9125777211575, 7047.0, 7088.468364872655, 956.2746173405877, 967.3035414501547, 968.4916712702382, 980.5097451274363, 989.366805244644, 34051.829740851135, 34431.13922151966, 34501.654983449844, 34610.826945865614, 35120.82439587837, 1094.8905109488987, 1154.8383226348317, 1158.3281696615943, 1158.5944919278354, 1161.710501343508, 18028.18309014607, 18218.08909554517, 18305.7254141188, 18338.541536461697, 18548.25806967706, 474377.0, 474856.0, 476131.0, 476384.0, 476535.0, 70644.2935570648, 70779.0, 70852.29147708457, 70882.29117708757, 71016.28983710097, 1448.6595650022448, 1501.7672260799593, 1507.155992644101, 1539.1227000609545, 1544.1507171055875, 31120.688793111778, 34892.47661285134, 35150.418231179145, 35291.47062794112, 35387.0, 57046.144307834584, 57811.710941445024, 57930.420695792505, 57983.0, 58107.12839307329, 297079.0, 297679.0, 298333.0, 298436.0, 552685.0, 40059.59940400675, 43931.0, 43973.12053758843, 44134.77932610316, 48811.0, 51913.22130168126, 52595.73702131465, 53416.198757019454, 53600.46399535955, 54220.0, 39173.2165356697, 39279.80360098181, 39375.40936885892, 39411.60588394079, 41088.79455602703, 38773.612263877, 39057.218855623294, 39097.41353879637, 39591.604083958795, 40361.192776143725, 43004.0, 43957.78021109874, 44213.11573768571, 44351.33472997843, 44564.331535027646, 31784.523232151998, 33025.0, 33437.0, 35141.64858351384, 36195.27609447849, 26443.735562644128, 27638.447231054863, 27712.0, 27723.168304950883, 27723.445531088862], "value": 22060.296722117087, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.52005753556, 430.33083555071863, 449.59761013892586, 449.8380582990123, 455.41479199228996, 20389.694154587676, 20986.160553577858, 22239.110435582556, 22328.441788955242, 22549.66175507369, 21362.145514179414, 21421.67867481989, 21560.568788624256, 21717.239896603623, 22016.669749953722, 6021.9397806021925, 6229.875402491947, 6231.345708700589, 6231.750729970819, 6237.3450787667325, 5854.941450585482, 6091.42131497507, 6123.540734444912, 6230.470410015154, 6253.0, 6049.637021778685, 6159.10692949522, 6221.0979407985815, 6234.0, 6234.158388617547, 6321.5890967087225, 6324.84187895304, 6359.046143078529, 6360.459360954302, 6364.745410183587, 6052.303985041688, 6185.969070154665, 6222.533310001768, 6224.408681175281, 6238.064290356483, 14696.632584185374, 14718.558443246613, 14758.483453079198, 14799.334029968677, 15027.549173524812, 2568.9486210275877, 2634.1702363755358, 2645.8147929644933, 2655.4556315955183, 2670.2923725212836, 10631.468426578718, 10740.355578665305, 10781.676549703521, 10891.346519208873, 15538.145402002885, 1945.085809669453, 1960.8431325493925, 1976.7825539190678, 1979.8416126709828, 1984.335247692025, 90438.0, 91964.0, 92159.53920230424, 92301.0, 93276.53361733216, 11702.76594468106, 11791.88208117908, 11901.404929753478, 12239.755204895851, 12390.132690711744, 17736.822631773775, 17744.29022839072, 17777.46667599974, 17792.199351029234, 17799.555011124565, 8740.912590874137, 8795.956020219857, 8909.866352004725, 8980.8652870207, 9084.22857542786, 8272.131426200283, 8326.625301861432, 8333.2916702081, 8487.36344774132, 8567.74296771098, 5314.096603577324, 5344.412114667383, 5395.920815836848, 5441.075017247077, 5442.156465747816, 2175.2930297653324, 2184.8361372897098, 2224.2659922225625, 2240.4846885216166, 2291.8510296830655, 953.7901661634429, 954.8997355277735, 957.8706874571983, 961.251417995102, 973.6494861849728, 17619.647607047787, 18931.242750289835, 19097.80902190988, 19367.12847921847, 19410.0, 986.3785814936545, 992.0179022767409, 992.93545919515, 999.4253304350028, 1018.7809620931536, 10522.579096836194, 10771.246012779031, 10794.838077428845, 10813.0, 10921.399323037309, 649444.0, 665131.0, 666022.0, 668275.0, 694439.0, 76935.0, 81559.5922020398, 83876.0, 107516.46241768898, 111597.44201279104, 1081.859358283434, 1092.4646923007829, 1119.8768135505088, 1139.3619573039125, 1140.6463996161217, 17677.0, 18076.909615452365, 18126.81873181304, 18296.542586434913, 18569.0, 37492.43761343636, 38842.805785970886, 43154.842257887605, 43864.34203486887, 44490.3326450097, 60917.390826092946, 61071.38928610657, 61837.38162618316, 62253.0, 62332.0, 8614.707793830976, 8735.039145693841, 8881.822363552821, 8934.195922367018, 9099.954500227721, 9482.004389539276, 12615.36923153857, 13008.47966081384, 13253.271070091238, 13345.0, 11106.444677765918, 11214.831777523506, 11221.495032723384, 11348.489317980546, 11866.584669536525, 10747.623833165802, 10800.729981750519, 10835.837462437912, 10988.945055274673, 11070.0, 11531.769364612494, 11641.243319184226, 11696.239744416585, 11888.0, 12129.636110916686, 8837.425567338103, 8850.468971861708, 8917.509536975529, 8980.101989800967, 8997.55012249398, 10066.597336106473, 11581.82627260575, 11587.420628968686, 11726.589569365031, 11804.114691398008], "value": 9674.92135430928, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.3694248415663, 1516.1888389711507, 1521.7565189569668, 1528.8471152884708, 1532.9156896370703, 8484.533350665712, 9025.0, 9050.683226087089, 9052.773680657987, 9054.094590540952, 7904.407169462299, 8080.838383232332, 8095.271425571697, 8433.15668433158, 8877.86683199751, 2382.892769825358, 2428.9271321860374, 2438.9512209755794, 2441.633754936765, 2447.6328550717444, 2383.7616238376195, 2406.7713567211085, 2411.4815314707334, 2421.32202983165, 2424.539337525873, 2312.387217387394, 2383.8212134089927, 2393.461471168982, 2407.2898494944034, 2410.216679579135, 2346.202291220993, 2352.1297120065515, 2370.265217782493, 2370.632551954441, 2372.6796882420826, 2397.0531640002278, 2416.5408572371193, 2420.0319872051145, 2421.5278020785954, 2422.769836865495, 8616.65533378664, 8750.168733970262, 8750.3874728769, 8786.692465763668, 8789.824203515958, 5215.322008138955, 5328.094223981893, 5334.279872217278, 5339.385970613391, 5346.465353464661, 3110.16025673067, 3288.408086544421, 3396.8811091611924, 3401.676840700154, 3401.7448691348, 1477.0, 1490.2474250503426, 1490.7167638148717, 1514.4249980020766, 1583.6753465539537, 11637.0, 11658.475368608433, 11661.766764664659, 11663.591774287945, 11692.824607630891, 4603.332516785114, 4766.642501812308, 4773.11697335994, 4823.975880120577, 4836.661433699607, 10337.22470814692, 10337.9483102584, 10343.224258180666, 10348.689539313833, 10355.896441035493, 5495.477929596682, 5506.64206826555, 5513.3108361454815, 5519.448055194448, 5519.9448005520235, 4906.0, 4929.433115191727, 4932.876678083005, 4949.430815456197, 5023.399852106976, 4096.815643296059, 4187.685923555685, 4217.599328063829, 4248.277792775236, 4285.271503844354, 1333.4799428223, 1350.8176396186389, 1351.067763243359, 1351.8107464954717, 1360.8298962629672, 995.5520015992832, 1000.7348052766023, 1004.1765752083368, 1010.4442556593991, 1013.8175128476945, 5909.704514774244, 5952.672603006876, 6009.098635204667, 6118.3269840317525, 6179.3820617937845, 615.3846153846154, 620.8080485467913, 631.5263552335748, 644.9516286278548, 647.870425914819, 4025.5370632377067, 4125.195586860534, 4148.23257697321, 4178.582141785858, 4192.329227323614, 9872.457014864107, 10635.361878287327, 10735.83896241557, 10742.677719668422, 10744.570217191382, 9710.17463515609, 10033.949830250802, 10621.893781062245, 10676.252662313564, 10682.305650132717, 7971.44199906001, 8129.959350203329, 8140.796480088045, 8146.470479418819, 8146.674133034612, 6187.81436556904, 6273.780417685359, 6313.905291420724, 6367.363263673596, 6430.967845160744, 10064.597416103274, 10073.647422340184, 10076.899231007596, 10088.596456141671, 10102.0, 8980.0, 9024.503652299187, 9948.403095814274, 9997.91875204399, 10072.0, 7559.092908850753, 7763.456558040883, 7821.061472623322, 7836.92163078362, 7841.333486653698, 8415.579221039046, 8417.789555261168, 8457.238848503664, 8461.111583283666, 8474.491530508189, 7313.085864266966, 7401.259874012556, 7408.073990751156, 7435.107787065371, 7436.59098749574, 7251.347378735939, 7273.0908636420445, 7304.269573042653, 7459.477836551389, 7551.358134558624, 6658.533902626769, 6770.052192693125, 6771.62756048422, 6780.694868731018, 6783.86432271342, 5264.263003179634, 5292.126799078263, 5311.362636483646, 5477.698726570077, 5546.001719690495, 5229.0, 5234.502722241381, 5359.490848369399, 5373.059714550016, 5385.38068122171], "value": 4653.689275874029, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.4122630535822, 398.1638559026047, 401.9176068905875, 404.64593480704383, 408.41800434380997, 5266.0, 5314.867128321794, 5320.707361095143, 5326.414094449608, 5339.89320213596, 5201.375834899808, 5235.842924712265, 5243.947560524393, 5246.560349437511, 5247.711375874325, 4123.381492776085, 4165.916681666365, 4174.519930208019, 4193.958060419387, 4220.53574106848, 4199.706020578561, 4204.411382406465, 4207.074443622413, 4218.810153543098, 4223.239816832969, 4155.31437312843, 4176.498820141587, 4187.497500299968, 4188.0, 4207.137536804963, 4126.370083816905, 4136.462259906223, 4171.33258678613, 4202.0, 4231.724937879058, 3781.8676346327748, 3786.6213378662187, 3788.583255841855, 3790.279846829121, 3801.2207497462955, 5117.974410127963, 5122.1036318644465, 5174.327337446108, 5183.740812959337, 5186.0, 4670.696404733681, 4759.643026773006, 4885.7312847793355, 4891.608671306287, 4895.510448955111, 5503.2114562766865, 5504.587155963279, 5505.972470137664, 5517.200005999148, 5540.722963851832, 4106.7535947842925, 4137.668986481074, 4139.0, 4162.209180255742, 4165.2294325549565, 5143.434222235551, 5490.929268792587, 5590.273264475592, 5763.452472015152, 5813.88372232553, 4197.433346498245, 4214.17823524416, 4219.725717828332, 4226.344916537942, 4227.598378154071, 4267.594578515098, 4276.679249056333, 4282.5075116361395, 4305.677074219383, 4307.22469955411, 4741.0754902794315, 4779.617630589544, 4803.910299019937, 4810.6151507879285, 4825.565699087099, 5421.403645598981, 5491.203775452537, 5523.7790488380815, 5531.723413829292, 5536.363318218376, 1414.5119933623089, 1434.938145772121, 1435.1532595768547, 1449.724552335053, 1467.0, 1007.6725064354114, 1030.6959446963165, 1030.7682319628123, 1033.8862725100232, 1053.115383078218, 5179.741012949337, 5180.704823794052, 5206.219067139959, 5237.711925844039, 5276.36683597963, 5406.91889621656, 5502.147167189092, 5503.669779813144, 5504.779808807683, 5530.446955304437, 4874.707517548958, 5123.103456895103, 5159.122949098587, 5193.350831146106, 5258.763355649005, 2878.280429892527, 2879.6832348441653, 2882.827030378184, 2904.0852131578486, 2908.418316336741, 5605.579581531401, 5658.207850900877, 5680.86382723457, 5681.431856814368, 5688.459596338341, 5294.481218597999, 5496.718861672442, 5512.4211957744665, 5596.440355964371, 5608.270924779753, 5642.322921249394, 5770.6249093808765, 5771.5571107223195, 5796.275465566804, 5810.477057064884, 5583.0, 5584.329880414376, 5599.272094627672, 5607.990561698934, 5641.774329026793, 5354.3574771027725, 5477.698726569917, 5488.368837583729, 5573.27547418833, 5581.302337207849, 5809.680467574324, 5828.0, 5835.416458354131, 5836.678982655994, 5852.151438041546, 4188.602082802129, 4294.248506511411, 4295.334223195285, 4304.892377690458, 4309.6983211176175, 5583.0, 5589.776408943597, 5590.021746194318, 5596.38439771633, 5599.216109744721, 5439.3200849893765, 5458.0721277382145, 5466.753996070107, 5483.424240454695, 5485.61600687948, 5398.102676370247, 5411.567074633941, 5415.756290966837, 5504.7522861470525, 5510.201020852034, 5401.3248343957, 5423.945760542344, 5433.587267310607, 5442.183672449164, 5443.673379597237, 5470.370907345706, 5471.604740791073, 5506.669599824023, 5510.862228444321, 5534.972325138348, 5182.170852663707, 5362.892742145057, 5381.73091345439, 5424.267723857229, 5430.972845135749], "value": 4258.464167794638, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.9035499329307, 793.452517762744, 811.9391045671572, 900.9231742955049, 911.1253196930946, 15072.773908391382, 16473.752893706605, 16765.077920714357, 16891.23989420476, 17275.568110797238, 15903.204839758024, 16328.101954392503, 16461.423850165247, 16563.751543726823, 16598.419055333066, 721.8375865430289, 742.1279996004699, 839.4459656626627, 854.1245223645782, 855.3713020929612, 816.3306089007017, 839.0686338164633, 843.1189407069596, 846.0820010288844, 846.9026062002887, 874.9125087491263, 880.3309484791572, 881.7046289493028, 882.9867551986725, 883.147762409275, 875.2472873328932, 875.8117004843957, 875.8642410426394, 876.3514998900831, 876.7939534209455, 643.8326035230826, 644.8065580325883, 646.6249575246346, 646.7316063833504, 647.6470323673609, 15132.092074475457, 15138.772918406232, 15171.468998585107, 16278.26747796352, 16793.580160496087, 15075.773863392058, 15675.216239187996, 15851.762223566655, 15917.442889498927, 16247.675046499122, 12422.192557483824, 12936.094473386867, 12942.870571294261, 13025.54410595634, 13042.804357934638, 4034.374671925856, 4047.6761859051207, 4117.938230926538, 4143.585641435862, 4148.709590328678, 84379.5781021097, 85360.71958920559, 86155.99999999937, 86936.56531717301, 88000.0, 12630.242185468902, 12745.936270318774, 12813.295268760121, 12928.224306541637, 13004.934975325252, 24414.26757197287, 24471.510569788505, 24523.264302070966, 24526.386840329134, 24536.0, 8879.822403551892, 8898.73303800887, 8909.242714369351, 9057.139571740807, 9223.308251881135, 5055.216441451581, 5102.540771330598, 5103.489651034941, 5251.579873610179, 5266.315379000782, 3837.0599203195397, 3846.6345697158727, 3871.7676939383164, 3887.688984881203, 3927.4697915781576, 669.0332469581408, 677.5392732941647, 684.226823689228, 688.4836372720459, 692.7506097804786, 831.1895901495993, 840.878072679458, 847.1401527449643, 857.9914200857911, 860.2043110123111, 10336.948315258376, 10459.267851250339, 10637.574497020187, 10942.945285273681, 11021.118310535137, 778.4745296924553, 781.6951388958311, 785.8860465232509, 801.903771547418, 818.6602559937678, 5223.347081614798, 5351.09031464652, 5369.40936496985, 5398.568114550826, 5402.540784033401, 78367.0, 81073.18926810774, 81935.0, 83210.58394707988, 83453.58273208716, 75192.0, 75530.24469755232, 76501.0, 78119.60940195377, 78844.21155788483, 63410.6829465859, 64981.35018649847, 65231.67384163049, 65250.67374663191, 65763.67118164475, 10040.182693987688, 10297.845532316871, 10354.585816567555, 10361.481925903825, 10374.896251037393, 37840.648325442926, 42460.9384765371, 43071.78464107659, 44789.552104478535, 45584.77207613941, 56001.0, 57047.0, 57573.4242657568, 58695.70652146883, 59616.403835961086, 13113.08208425401, 13282.86717132855, 13492.93253533726, 13622.114562553403, 13622.38699258516, 15283.694326113193, 15657.530274091796, 15658.45195418155, 16410.917945410198, 16563.0, 14410.42358305656, 14610.926945365205, 14643.487477938646, 15132.697346053237, 15436.536903892902, 13828.723425531634, 13886.236257005557, 13926.094803837717, 13960.2321872298, 14082.718345633235, 14225.715485690434, 14296.142231466145, 14727.92636036813, 14761.55715328542, 15200.695986079996, 8982.236509896731, 9195.724128276162, 9345.579448924951, 9369.859452108087, 9542.52287385614, 11112.777744445228, 11340.432978350884, 11406.0, 11571.19001669875, 11616.244944078608], "value": 7721.1467944806045, "unit": "score"}], "name": "dromaeo_css", "value": 7504.348776456915, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 111.0, 113.0, 110.0, 111.0, 111.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 118.0, 164.0, 115.0, 117.0, 116.0, 115.0, 133.0, 115.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 163.0, 159.0, 160.0, 159.0, 161.0, 161.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 118.0, 75.0, 75.0, 75.0, 75.0, 90.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 106.0, 82.0, 81.0, 82.0, 92.0, 82.0, 82.0, 98.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 53.0, 51.0, 53.0, 53.0, 52.0, 55.0, 52.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 80.0, 78.0, 74.0, 79.0, 79.0, 75.0, 73.0, 80.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 120.0, 121.0, 120.0, 120.0, 122.0, 124.0, 117.0, 158.0, 120.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 151.0, 154.0, 154.0, 158.0, 153.0, 152.0, 155.0, 153.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 59.0, 61.0, 59.0, 61.0, 59.0, 63.0, 62.0], "value": 60.3, "unit": "score"}], "name": "kraken", "value": 1455.8999999999999, "alertThreshold": 2.0}]} 12:46:41 INFO - Return code: 0 12:46:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:46:41 INFO - # TBPL SUCCESS # 12:46:41 INFO - Running post-action listener: _resource_record_post_action 12:46:41 INFO - [mozharness: 2017-04-11 19:46:41.122085Z] Finished run-tests step (success) 12:46:41 INFO - Running post-run listener: _resource_record_post_run 12:46:41 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326647808; Read time: 12; Write time: 183940 12:46:41 INFO - TinderboxPrint: CPU usage
13.0% 12:46:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:46:41 INFO - TinderboxPrint: I/O write bytes / time
326,647,808 / 183,940 12:46:41 INFO - TinderboxPrint: CPU idle
8,245.1 (87.0%) 12:46:41 INFO - TinderboxPrint: CPU user
1,188.3 (12.5%) 12:46:41 INFO - TinderboxPrint: Swap in / out
0 / 0 12:46:41 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 102305792; Read time: 0; Write time: 97668 12:46:41 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 223776768; Read time: 0; Write time: 86272 12:46:41 INFO - Running post-run listener: _upload_blobber_files 12:46:41 INFO - Blob upload gear active. 12:46:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:46:41 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 12:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:46:42 INFO - (blobuploader) - INFO - Open directory for files ... 12:46:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:46:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:46:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:45 INFO - (blobuploader) - INFO - Done attempting. 12:46:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:46:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:46:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:45 INFO - (blobuploader) - INFO - Done attempting. 12:46:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:46:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:46:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:46 INFO - (blobuploader) - INFO - Done attempting. 12:46:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:46:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:46:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:47 INFO - (blobuploader) - INFO - Done attempting. 12:46:47 INFO - (blobuploader) - INFO - Iteration through files over. 12:46:47 INFO - Return code: 0 12:46:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:46:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:46:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4b93a3bed7b5c93e3b7d2346cd9e5525132b96862b7ec3da9c08fcf5e89cedfcab62bdff9ca96c7909b032656b1d27f83497d006d3cbe7c271ae19f84b8ca321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3f390e6e2f300446b63fec2580e5e4c373776af5e8d5b616d5c9680d2dff173360bc5f4bdf4679185ad1ee88bab12a5a4ae6d0794d9a8d9469b4fad4d283f992", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/05ad760959935eed19b33594e030309289d84f84e2d5ffdaa58c781131a4e854062fe765c14389385e995e4ad6a40a5e38fee76df1664ccb8d154c4a8ba9a38b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6a138551cadf20a82ac2f041954e0a7f231cdb683dc27f147be11b6e7d86478cda3a7fb000cb38206bfca254c9fa64d42aee99e2539c2e8553b12ec4fa240ac"} 12:46:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:46:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:46:47 INFO - Contents: 12:46:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4b93a3bed7b5c93e3b7d2346cd9e5525132b96862b7ec3da9c08fcf5e89cedfcab62bdff9ca96c7909b032656b1d27f83497d006d3cbe7c271ae19f84b8ca321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3f390e6e2f300446b63fec2580e5e4c373776af5e8d5b616d5c9680d2dff173360bc5f4bdf4679185ad1ee88bab12a5a4ae6d0794d9a8d9469b4fad4d283f992", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/05ad760959935eed19b33594e030309289d84f84e2d5ffdaa58c781131a4e854062fe765c14389385e995e4ad6a40a5e38fee76df1664ccb8d154c4a8ba9a38b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6a138551cadf20a82ac2f041954e0a7f231cdb683dc27f147be11b6e7d86478cda3a7fb000cb38206bfca254c9fa64d42aee99e2539c2e8553b12ec4fa240ac"} 12:46:47 INFO - Running post-run listener: copy_logs_to_upload_dir 12:46:47 INFO - Copying logs to upload dir... 12:46:47 INFO - mkdir: /builds/slave/test/build/upload/logs 12:46:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.247028 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-04-11 12:46:47.268834) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 12:46:47.272253) ========= 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=32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4b93a3bed7b5c93e3b7d2346cd9e5525132b96862b7ec3da9c08fcf5e89cedfcab62bdff9ca96c7909b032656b1d27f83497d006d3cbe7c271ae19f84b8ca321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3f390e6e2f300446b63fec2580e5e4c373776af5e8d5b616d5c9680d2dff173360bc5f4bdf4679185ad1ee88bab12a5a4ae6d0794d9a8d9469b4fad4d283f992", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/05ad760959935eed19b33594e030309289d84f84e2d5ffdaa58c781131a4e854062fe765c14389385e995e4ad6a40a5e38fee76df1664ccb8d154c4a8ba9a38b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6a138551cadf20a82ac2f041954e0a7f231cdb683dc27f147be11b6e7d86478cda3a7fb000cb38206bfca254c9fa64d42aee99e2539c2e8553b12ec4fa240ac"} build_url:https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/aUONY0SmRYyiISdb6PLtmQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4b93a3bed7b5c93e3b7d2346cd9e5525132b96862b7ec3da9c08fcf5e89cedfcab62bdff9ca96c7909b032656b1d27f83497d006d3cbe7c271ae19f84b8ca321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3f390e6e2f300446b63fec2580e5e4c373776af5e8d5b616d5c9680d2dff173360bc5f4bdf4679185ad1ee88bab12a5a4ae6d0794d9a8d9469b4fad4d283f992", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/05ad760959935eed19b33594e030309289d84f84e2d5ffdaa58c781131a4e854062fe765c14389385e995e4ad6a40a5e38fee76df1664ccb8d154c4a8ba9a38b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6a138551cadf20a82ac2f041954e0a7f231cdb683dc27f147be11b6e7d86478cda3a7fb000cb38206bfca254c9fa64d42aee99e2539c2e8553b12ec4fa240ac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 12:46:47.298301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 12:46:47.298683) ========= 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=32c5991c409366f7fec8a718000001d2-1491938773.384382-35694077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 12:46:47.386329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 12:46:47.386702) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 12:46:47.387084) ========= ========= Total master_lag: 0.17 =========