builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1487721826.13 results: success (0) revision: 2bbdf69d4cb3a3196cffecad7c86c73529deda2d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:46.129087) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:46.129587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:46.129867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:46.142794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:46.143070) ========= 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=ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-21 16:03:46-- 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% 223M=0s 2017-02-21 16:03:46 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124733 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:46.279088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:46.279418) ========= 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=ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017799 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:46.329032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:46.329380) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2bbdf69d4cb3a3196cffecad7c86c73529deda2d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2bbdf69d4cb3a3196cffecad7c86c73529deda2d --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=ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-21 16:03:46,904 truncating revision to first 12 chars 2017-02-21 16:03:46,904 Setting DEBUG logging. 2017-02-21 16:03:46,904 attempt 1/10 2017-02-21 16:03:46,904 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2bbdf69d4cb3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-21 16:03:47,335 unpacking tar archive at: mozilla-aurora-2bbdf69d4cb3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.734687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:47.076964) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:47.077316) ========= script_repo_revision: 2bbdf69d4cb3a3196cffecad7c86c73529deda2d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:47.077712) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:47.077970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 16:03:47.085955) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-21 16:03:47.086357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:03:47 INFO - MultiFileLogger online at 20170221 16:03:47 in /builds/slave/test 16:03:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:03:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:03:47 INFO - {'append_to_log': False, 16:03:47 INFO - 'base_work_dir': '/builds/slave/test', 16:03:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:03:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:03:47 INFO - 'branch': 'Mozilla-Aurora', 16:03:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:03:47 INFO - 'config_files': ('talos/linux_config.py',), 16:03:47 INFO - 'default_actions': ('clobber', 16:03:47 INFO - 'read-buildbot-config', 16:03:47 INFO - 'download-and-extract', 16:03:47 INFO - 'populate-webroot', 16:03:47 INFO - 'create-virtualenv', 16:03:47 INFO - 'install', 16:03:47 INFO - 'run-tests'), 16:03:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:03:47 INFO - 'download_minidump_stackwalk': True, 16:03:47 INFO - 'download_symbols': 'ondemand', 16:03:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:03:47 INFO - 'tooltool.py': '/tools/tooltool.py', 16:03:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:03:47 INFO - '/tools/misc-python/virtualenv.py')}, 16:03:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:03:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:03:47 INFO - 'installer_path': 'installer.exe', 16:03:47 INFO - 'log_level': 'info', 16:03:47 INFO - 'log_name': 'talos', 16:03:47 INFO - 'log_to_console': True, 16:03:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:03:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:03:47 INFO - 'opt_config_files': (), 16:03:47 INFO - 'pip_index': False, 16:03:47 INFO - 'sps_profile': False, 16:03:47 INFO - 'sps_profile_interval': 0, 16:03:47 INFO - 'suite': 'dromaeojs', 16:03:47 INFO - 'system_bits': '32', 16:03:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:03:47 INFO - 'title': 'talos-linux64-ix-029', 16:03:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:03:47 INFO - 'use_talos_json': True, 16:03:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:03:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:03:47 INFO - 'work_dir': 'build'} 16:03:47 INFO - [mozharness: 2017-02-22 00:03:47.759199Z] Running clobber step. 16:03:47 INFO - Running pre-action listener: _resource_record_pre_action 16:03:47 INFO - Running main action method: clobber 16:03:47 INFO - rmtree: /builds/slave/test/build 16:03:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:03:49 INFO - Running post-action listener: _resource_record_post_action 16:03:49 INFO - [mozharness: 2017-02-22 00:03:49.362312Z] Finished clobber step (success) 16:03:49 INFO - [mozharness: 2017-02-22 00:03:49.362410Z] Running read-buildbot-config step. 16:03:49 INFO - Running pre-action listener: _resource_record_pre_action 16:03:49 INFO - Running main action method: read_buildbot_config 16:03:49 INFO - Using buildbot properties: 16:03:49 INFO - { 16:03:49 INFO - "project": "", 16:03:49 INFO - "product": "firefox", 16:03:49 INFO - "who": "ryanvm@gmail.com", 16:03:49 INFO - "installer_path": "public/build/target.tar.bz2", 16:03:49 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:03:49 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 16:03:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:03:49 INFO - "stage_platform": "linux64-pgo", 16:03:49 INFO - "basedir": "/builds/slave/test", 16:03:49 INFO - "buildnumber": 1072, 16:03:49 INFO - "platform": "ubuntu64_hw", 16:03:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:03:49 INFO - "slavebuilddir": "test", 16:03:49 INFO - "taskId": "LrJKL4-ORImLqCWUUujCVQ", 16:03:49 INFO - "branch": "mozilla-aurora", 16:03:49 INFO - "script_repo_revision": "production", 16:03:49 INFO - "revision": "2bbdf69d4cb3a3196cffecad7c86c73529deda2d", 16:03:49 INFO - "slavename": "talos-linux64-ix-029", 16:03:49 INFO - "repo_path": "releases/mozilla-aurora" 16:03:49 INFO - } 16:03:49 INFO - Finding installer, test and symbols from parent task. 16:03:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LrJKL4-ORImLqCWUUujCVQ'}, attempt #1 16:03:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LrJKL4-ORImLqCWUUujCVQ'}, attempt #1 16:03:50 INFO - Task dependencies: Ys35NFhtTSSEKzfEjSp5-A 16:03:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A'}, attempt #1 16:03:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.tar.bz2 16:03:50 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/test_packages.json 16:03:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.crashreporter-symbols.zip 16:03:50 INFO - Running post-action listener: _resource_record_post_action 16:03:50 INFO - [mozharness: 2017-02-22 00:03:50.844712Z] Finished read-buildbot-config step (success) 16:03:50 INFO - [mozharness: 2017-02-22 00:03:50.844929Z] Running download-and-extract step. 16:03:50 INFO - Running pre-action listener: _resource_record_pre_action 16:03:50 INFO - Running main action method: download_and_extract 16:03:50 INFO - mkdir: /builds/slave/test/build/tests 16:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:50 INFO - trying https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.test_packages.json 16:03:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:03:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:03:51 INFO - Downloaded 896 bytes. 16:03:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:03:51 INFO - Using the following test package requirements: 16:03:51 INFO - {u'common': [u'target.common.tests.zip'], 16:03:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:03:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:03:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:03:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:03:51 INFO - u'mozbase': [u'target.common.tests.zip'], 16:03:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:03:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:03:51 INFO - u'web-platform': [u'target.common.tests.zip', 16:03:51 INFO - u'target.web-platform.tests.zip'], 16:03:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:03:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:03:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.common.tests.zip 16:03:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:03:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.common.tests.zip into memory 16:03:52 INFO - Expected file size: 21860879 16:03:52 INFO - Obtained file size: 21860879 16:03:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:03:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.common.tests.zip 16:03:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:03:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.common.tests.zip into memory 16:03:57 INFO - Expected file size: 21860879 16:03:57 INFO - Obtained file size: 21860879 16:04:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.talos.tests.zip 16:04:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:04:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.talos.tests.zip into memory 16:04:02 INFO - Expected file size: 14403485 16:04:02 INFO - Obtained file size: 14403485 16:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:02 INFO - trying https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.tar.bz2 16:04:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:04:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:04:04 INFO - Downloaded 66068786 bytes. 16:04:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.tar.bz2 16:04:04 INFO - mkdir: /builds/slave/test/properties 16:04:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:04:04 INFO - Writing to file /builds/slave/test/properties/build_url 16:04:04 INFO - Contents: 16:04:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.tar.bz2 16:04:04 INFO - Running post-action listener: _resource_record_post_action 16:04:04 INFO - Running post-action listener: set_extra_try_arguments 16:04:04 INFO - [mozharness: 2017-02-22 00:04:04.135655Z] Finished download-and-extract step (success) 16:04:04 INFO - [mozharness: 2017-02-22 00:04:04.135752Z] Running populate-webroot step. 16:04:04 INFO - Running pre-action listener: _resource_record_pre_action 16:04:04 INFO - Running main action method: populate_webroot 16:04:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:04:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:04:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:04:04 INFO - '--tppagecycles', 16:04:04 INFO - '7'], 16:04:04 INFO - 'tests': ['tsvgm']}}, 16:04:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:04:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:04:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:04:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:04:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:04:04 INFO - 'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:04:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:04:04 INFO - 'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['damp', 'tps']}, 16:04:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:04:04 INFO - 'tests': ['damp', 'tps']}, 16:04:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['dromaeo_dom']}, 16:04:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:04:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['basic_compositor_video']}, 16:04:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:04:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['a11yr', 16:04:04 INFO - 'ts_paint', 16:04:04 INFO - 'tpaint', 16:04:04 INFO - 'sessionrestore', 16:04:04 INFO - 'sessionrestore_no_auto_restore', 16:04:04 INFO - 'tabpaint']}, 16:04:04 INFO - 'other-e10s': {'tests': ['a11yr', 16:04:04 INFO - 'ts_paint', 16:04:04 INFO - 'tpaint', 16:04:04 INFO - 'sessionrestore', 16:04:04 INFO - 'sessionrestore_no_auto_restore', 16:04:04 INFO - 'tabpaint']}, 16:04:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:04:04 INFO - 'ts_paint', 16:04:04 INFO - 'tpaint', 16:04:04 INFO - 'sessionrestore', 16:04:04 INFO - 'sessionrestore_no_auto_restore', 16:04:04 INFO - 'tabpaint']}, 16:04:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:04:04 INFO - 'ts_paint', 16:04:04 INFO - 'tpaint', 16:04:04 INFO - 'sessionrestore', 16:04:04 INFO - 'sessionrestore_no_auto_restore', 16:04:04 INFO - 'tabpaint']}, 16:04:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['a11yr', 16:04:04 INFO - 'ts_paint', 16:04:04 INFO - 'tpaint', 16:04:04 INFO - 'sessionrestore', 16:04:04 INFO - 'sessionrestore_no_auto_restore', 16:04:04 INFO - 'tabpaint']}, 16:04:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['a11yr', 16:04:04 INFO - 'ts_paint', 16:04:04 INFO - 'tpaint', 16:04:04 INFO - 'sessionrestore', 16:04:04 INFO - 'sessionrestore_no_auto_restore', 16:04:04 INFO - 'tabpaint']}, 16:04:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['tsvgx', 16:04:04 INFO - 'tsvgr_opacity', 16:04:04 INFO - 'tart', 16:04:04 INFO - 'tscrollx', 16:04:04 INFO - 'cart', 16:04:04 INFO - 'tsvg_static']}, 16:04:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:04:04 INFO - 'tsvgr_opacity', 16:04:04 INFO - 'tart', 16:04:04 INFO - 'tscrollx', 16:04:04 INFO - 'cart', 16:04:04 INFO - 'tsvg_static']}, 16:04:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:04:04 INFO - 'talos_options': ['--disable-e10s'], 16:04:04 INFO - 'tests': ['tp5o']}, 16:04:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:04:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:04:04 INFO - 'talos_options': ['--disable-e10s', 16:04:04 INFO - '--xperf_path', 16:04:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:04 INFO - 'tests': ['tp5n']}, 16:04:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:04:04 INFO - 'talos_options': ['--xperf_path', 16:04:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:04 INFO - 'tests': ['tp5n']}}, 16:04:04 INFO - 'talos.zip': {'path': '', 16:04:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:04:04 INFO - Running post-action listener: _resource_record_post_action 16:04:04 INFO - [mozharness: 2017-02-22 00:04:04.148806Z] Finished populate-webroot step (success) 16:04:04 INFO - [mozharness: 2017-02-22 00:04:04.148896Z] Running create-virtualenv step. 16:04:04 INFO - Running pre-action listener: _resource_record_pre_action 16:04:04 INFO - Running main action method: create_virtualenv 16:04:04 INFO - Creating virtualenv /builds/slave/test/build/venv 16:04:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:04:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:04:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:04:04 INFO - Using real prefix '/usr' 16:04:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:04:04 INFO - Installing distribute.............................................................................................................................................................................................done. 16:04:06 INFO - Installing pip.................done. 16:04:06 INFO - Return code: 0 16:04:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:04:06 INFO - Reading from file tmpfile_stdout 16:04:06 INFO - Output received: 16:04:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:04:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:06 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 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:04:06 INFO - Using env: {'DISPLAY': ':0', 16:04:06 INFO - 'HOME': '/home/cltbld', 16:04:06 INFO - 'LANG': 'en_US.UTF-8', 16:04:06 INFO - 'LANGUAGE': 'en_US:en', 16:04:06 INFO - 'LOGNAME': 'cltbld', 16:04:06 INFO - 'MAIL': '/var/mail/cltbld', 16:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:06 INFO - 'MOZ_NO_REMOTE': '1', 16:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:06 INFO - 'NO_EM_RESTART': '1', 16:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:06 INFO - 'PWD': '/builds/slave/test', 16:04:06 INFO - 'SHELL': '/bin/bash', 16:04:06 INFO - 'SHLVL': '1', 16:04:06 INFO - 'TERM': 'linux', 16:04:06 INFO - 'TMOUT': '86400', 16:04:06 INFO - 'USER': 'cltbld', 16:04:06 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:06 INFO - '_': '/tools/buildbot/bin/python'} 16:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:04:07 INFO - Cleaning up... 16:04:07 INFO - Return code: 0 16:04:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:07 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 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:04:07 INFO - Using env: {'DISPLAY': ':0', 16:04:07 INFO - 'HOME': '/home/cltbld', 16:04:07 INFO - 'LANG': 'en_US.UTF-8', 16:04:07 INFO - 'LANGUAGE': 'en_US:en', 16:04:07 INFO - 'LOGNAME': 'cltbld', 16:04:07 INFO - 'MAIL': '/var/mail/cltbld', 16:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:07 INFO - 'MOZ_NO_REMOTE': '1', 16:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:07 INFO - 'NO_EM_RESTART': '1', 16:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:07 INFO - 'PWD': '/builds/slave/test', 16:04:07 INFO - 'SHELL': '/bin/bash', 16:04:07 INFO - 'SHLVL': '1', 16:04:07 INFO - 'TERM': 'linux', 16:04:07 INFO - 'TMOUT': '86400', 16:04:07 INFO - 'USER': 'cltbld', 16:04:07 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:07 INFO - '_': '/tools/buildbot/bin/python'} 16:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:07 INFO - Downloading/unpacking psutil>=3.1.1 16:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:04:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:09 INFO - Installing collected packages: psutil 16:04:09 INFO - Running setup.py install for psutil 16:04:09 INFO - building 'psutil._psutil_linux' extension 16:04:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:04:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:04:09 INFO - building 'psutil._psutil_posix' extension 16:04:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:04:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:04:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:09 INFO - Successfully installed psutil 16:04:09 INFO - Cleaning up... 16:04:10 INFO - Return code: 0 16:04:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:10 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 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:04:10 INFO - Using env: {'DISPLAY': ':0', 16:04:10 INFO - 'HOME': '/home/cltbld', 16:04:10 INFO - 'LANG': 'en_US.UTF-8', 16:04:10 INFO - 'LANGUAGE': 'en_US:en', 16:04:10 INFO - 'LOGNAME': 'cltbld', 16:04:10 INFO - 'MAIL': '/var/mail/cltbld', 16:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:10 INFO - 'MOZ_NO_REMOTE': '1', 16:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:10 INFO - 'NO_EM_RESTART': '1', 16:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:10 INFO - 'PWD': '/builds/slave/test', 16:04:10 INFO - 'SHELL': '/bin/bash', 16:04:10 INFO - 'SHLVL': '1', 16:04:10 INFO - 'TERM': 'linux', 16:04:10 INFO - 'TMOUT': '86400', 16:04:10 INFO - 'USER': 'cltbld', 16:04:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:10 INFO - '_': '/tools/buildbot/bin/python'} 16:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:04:12 INFO - Installing collected packages: mozsystemmonitor 16:04:12 INFO - Running setup.py install for mozsystemmonitor 16:04:12 INFO - Successfully installed mozsystemmonitor 16:04:12 INFO - Cleaning up... 16:04:12 INFO - Return code: 0 16:04:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:04:12 INFO - Using env: {'DISPLAY': ':0', 16:04:12 INFO - 'HOME': '/home/cltbld', 16:04:12 INFO - 'LANG': 'en_US.UTF-8', 16:04:12 INFO - 'LANGUAGE': 'en_US:en', 16:04:12 INFO - 'LOGNAME': 'cltbld', 16:04:12 INFO - 'MAIL': '/var/mail/cltbld', 16:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:12 INFO - 'MOZ_NO_REMOTE': '1', 16:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:12 INFO - 'NO_EM_RESTART': '1', 16:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:12 INFO - 'PWD': '/builds/slave/test', 16:04:12 INFO - 'SHELL': '/bin/bash', 16:04:12 INFO - 'SHLVL': '1', 16:04:12 INFO - 'TERM': 'linux', 16:04:12 INFO - 'TMOUT': '86400', 16:04:12 INFO - 'USER': 'cltbld', 16:04:12 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:12 INFO - '_': '/tools/buildbot/bin/python'} 16:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:12 INFO - Downloading/unpacking jsonschema==2.5.1 16:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:04:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:04:14 INFO - warning: no files found matching '*.txt' 16:04:14 INFO - no previously-included directories found matching 'build' 16:04:14 INFO - no previously-included directories found matching 'dist' 16:04:14 INFO - no previously-included directories found matching '.git*' 16:04:14 INFO - Installing collected packages: jsonschema, functools32 16:04:14 INFO - Running setup.py install for functools32 16:04:15 INFO - warning: no files found matching '*.txt' 16:04:15 INFO - no previously-included directories found matching 'build' 16:04:15 INFO - no previously-included directories found matching 'dist' 16:04:15 INFO - no previously-included directories found matching '.git*' 16:04:15 INFO - Successfully installed jsonschema functools32 16:04:15 INFO - Cleaning up... 16:04:15 INFO - Return code: 0 16:04:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:15 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 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:04:15 INFO - Using env: {'DISPLAY': ':0', 16:04:15 INFO - 'HOME': '/home/cltbld', 16:04:15 INFO - 'LANG': 'en_US.UTF-8', 16:04:15 INFO - 'LANGUAGE': 'en_US:en', 16:04:15 INFO - 'LOGNAME': 'cltbld', 16:04:15 INFO - 'MAIL': '/var/mail/cltbld', 16:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:15 INFO - 'MOZ_NO_REMOTE': '1', 16:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:15 INFO - 'NO_EM_RESTART': '1', 16:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:15 INFO - 'PWD': '/builds/slave/test', 16:04:15 INFO - 'SHELL': '/bin/bash', 16:04:15 INFO - 'SHLVL': '1', 16:04:15 INFO - 'TERM': 'linux', 16:04:15 INFO - 'TMOUT': '86400', 16:04:15 INFO - 'USER': 'cltbld', 16:04:15 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:15 INFO - '_': '/tools/buildbot/bin/python'} 16:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:04:15 INFO - Cleaning up... 16:04:15 INFO - Return code: 0 16:04:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:15 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 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:04:15 INFO - Using env: {'DISPLAY': ':0', 16:04:15 INFO - 'HOME': '/home/cltbld', 16:04:15 INFO - 'LANG': 'en_US.UTF-8', 16:04:15 INFO - 'LANGUAGE': 'en_US:en', 16:04:15 INFO - 'LOGNAME': 'cltbld', 16:04:15 INFO - 'MAIL': '/var/mail/cltbld', 16:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:15 INFO - 'MOZ_NO_REMOTE': '1', 16:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:15 INFO - 'NO_EM_RESTART': '1', 16:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:15 INFO - 'PWD': '/builds/slave/test', 16:04:15 INFO - 'SHELL': '/bin/bash', 16:04:15 INFO - 'SHLVL': '1', 16:04:15 INFO - 'TERM': 'linux', 16:04:15 INFO - 'TMOUT': '86400', 16:04:15 INFO - 'USER': 'cltbld', 16:04:15 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:15 INFO - '_': '/tools/buildbot/bin/python'} 16:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:15 INFO - Downloading/unpacking blobuploader==1.2.4 16:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:04:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:04:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:18 INFO - Downloading docopt-0.6.1.tar.gz 16:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:04:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:04:18 INFO - Running setup.py install for blobuploader 16:04:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:04:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:04:18 INFO - Running setup.py install for requests 16:04:18 INFO - Running setup.py install for docopt 16:04:18 INFO - Successfully installed blobuploader requests docopt 16:04:18 INFO - Cleaning up... 16:04:18 INFO - Return code: 0 16:04:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04: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')]} 16:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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')]} 16:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:18 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 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:04:18 INFO - Using env: {'DISPLAY': ':0', 16:04:18 INFO - 'HOME': '/home/cltbld', 16:04:18 INFO - 'LANG': 'en_US.UTF-8', 16:04:18 INFO - 'LANGUAGE': 'en_US:en', 16:04:18 INFO - 'LOGNAME': 'cltbld', 16:04:18 INFO - 'MAIL': '/var/mail/cltbld', 16:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:18 INFO - 'MOZ_NO_REMOTE': '1', 16:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:18 INFO - 'NO_EM_RESTART': '1', 16:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:18 INFO - 'PWD': '/builds/slave/test', 16:04:18 INFO - 'SHELL': '/bin/bash', 16:04:18 INFO - 'SHLVL': '1', 16:04:18 INFO - 'TERM': 'linux', 16:04:18 INFO - 'TMOUT': '86400', 16:04:18 INFO - 'USER': 'cltbld', 16:04:18 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:18 INFO - '_': '/tools/buildbot/bin/python'} 16:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:04:19 INFO - Running setup.py (path:/tmp/pip-M8fhXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:04:19 INFO - Running setup.py (path:/tmp/pip-9DSNnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:04:19 INFO - Running setup.py (path:/tmp/pip-tevT7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:04:19 INFO - Running setup.py (path:/tmp/pip-VHbXw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:04:19 INFO - Running setup.py (path:/tmp/pip-sSivTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:04:19 INFO - Running setup.py (path:/tmp/pip-oWy5wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:04:19 INFO - Running setup.py (path:/tmp/pip-LRP8Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:04:19 INFO - Running setup.py (path:/tmp/pip-to_oV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:04:19 INFO - Running setup.py (path:/tmp/pip-ZU7ij9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:04:19 INFO - Running setup.py (path:/tmp/pip-J4I9DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:04:19 INFO - Running setup.py (path:/tmp/pip-HYfzwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:04:19 INFO - Running setup.py (path:/tmp/pip-pgWVKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:04:20 INFO - Running setup.py (path:/tmp/pip-ZQiHkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:04:20 INFO - Running setup.py (path:/tmp/pip-WOk5ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:20 INFO - Running setup.py (path:/tmp/pip-ydtxH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:04:20 INFO - Running setup.py (path:/tmp/pip-DmMFTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:04:20 INFO - Running setup.py (path:/tmp/pip-gLpNBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:04:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:04:20 INFO - Running setup.py install for manifestparser 16:04:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:04:20 INFO - Running setup.py install for mozcrash 16:04:20 INFO - Running setup.py install for mozdebug 16:04:20 INFO - Running setup.py install for mozdevice 16:04:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:04:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:04:20 INFO - Running setup.py install for mozfile 16:04:20 INFO - Running setup.py install for mozhttpd 16:04:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Running setup.py install for mozinfo 16:04:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Running setup.py install for mozInstall 16:04:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Running setup.py install for mozleak 16:04:21 INFO - Running setup.py install for mozlog 16:04:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Running setup.py install for moznetwork 16:04:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Running setup.py install for mozprocess 16:04:21 INFO - Running setup.py install for mozprofile 16:04:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Running setup.py install for mozrunner 16:04:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:04:21 INFO - Running setup.py install for mozscreenshot 16:04:21 INFO - Running setup.py install for moztest 16:04:22 INFO - Running setup.py install for mozversion 16:04:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:04:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:04:22 INFO - Cleaning up... 16:04:22 INFO - Return code: 0 16:04:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:22 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 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:04:22 INFO - Using env: {'DISPLAY': ':0', 16:04:22 INFO - 'HOME': '/home/cltbld', 16:04:22 INFO - 'LANG': 'en_US.UTF-8', 16:04:22 INFO - 'LANGUAGE': 'en_US:en', 16:04:22 INFO - 'LOGNAME': 'cltbld', 16:04:22 INFO - 'MAIL': '/var/mail/cltbld', 16:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:22 INFO - 'MOZ_NO_REMOTE': '1', 16:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:22 INFO - 'NO_EM_RESTART': '1', 16:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:22 INFO - 'PWD': '/builds/slave/test', 16:04:22 INFO - 'SHELL': '/bin/bash', 16:04:22 INFO - 'SHLVL': '1', 16:04:22 INFO - 'TERM': 'linux', 16:04:22 INFO - 'TMOUT': '86400', 16:04:22 INFO - 'USER': 'cltbld', 16:04:22 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:22 INFO - '_': '/tools/buildbot/bin/python'} 16:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:04:22 INFO - Running setup.py (path:/tmp/pip-vIndiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:04:22 INFO - Running setup.py (path:/tmp/pip-7hidaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:04:22 INFO - Running setup.py (path:/tmp/pip-AzoD6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:04:22 INFO - Running setup.py (path:/tmp/pip-si_YOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:04:22 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)) 16:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:04:22 INFO - Running setup.py (path:/tmp/pip-YlR7Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:04:22 INFO - Running setup.py (path:/tmp/pip-8B5ZX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:04:22 INFO - Running setup.py (path:/tmp/pip-DbeE73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:04:22 INFO - Running setup.py (path:/tmp/pip-k2syBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:04:23 INFO - Running setup.py (path:/tmp/pip-mT03eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:04:23 INFO - Running setup.py (path:/tmp/pip-kEBGYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:04:23 INFO - Running setup.py (path:/tmp/pip-IDHB2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:04:23 INFO - Running setup.py (path:/tmp/pip-McA6BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:04:23 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)) 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:04:23 INFO - Running setup.py (path:/tmp/pip-shTXRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:04:23 INFO - Running setup.py (path:/tmp/pip-YXmwEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:23 INFO - Running setup.py (path:/tmp/pip-mp4g_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:04:23 INFO - Running setup.py (path:/tmp/pip-4XhtQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:04:23 INFO - Running setup.py (path:/tmp/pip-9pl9nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:04:23 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)) 16:04:23 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)) 16:04:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:25 INFO - Downloading blessings-1.6.tar.gz 16:04:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:04:25 INFO - Installing collected packages: blessings 16:04:25 INFO - Running setup.py install for blessings 16:04:25 INFO - Successfully installed blessings 16:04:25 INFO - Cleaning up... 16:04:25 INFO - Return code: 0 16:04:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:04:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:26 INFO - Reading from file tmpfile_stdout 16:04:26 INFO - Current package versions: 16:04:26 INFO - argparse == 1.2.1 16:04:26 INFO - blessings == 1.6 16:04:26 INFO - blobuploader == 1.2.4 16:04:26 INFO - docopt == 0.6.1 16:04:26 INFO - functools32 == 3.2.3-2 16:04:26 INFO - jsonschema == 2.5.1 16:04:26 INFO - manifestparser == 1.1 16:04:26 INFO - mozInstall == 1.12 16:04:26 INFO - mozcrash == 1.0 16:04:26 INFO - mozdebug == 0.1 16:04:26 INFO - mozdevice == 0.49 16:04:26 INFO - mozfile == 1.2 16:04:26 INFO - mozhttpd == 0.7 16:04:26 INFO - mozinfo == 0.9 16:04:26 INFO - mozleak == 0.1 16:04:26 INFO - mozlog == 3.4 16:04:26 INFO - moznetwork == 0.27 16:04:26 INFO - mozprocess == 0.24 16:04:26 INFO - mozprofile == 0.28 16:04:26 INFO - mozrunner == 6.13 16:04:26 INFO - mozscreenshot == 0.1 16:04:26 INFO - mozsystemmonitor == 0.3 16:04:26 INFO - moztest == 0.8 16:04:26 INFO - mozversion == 1.4 16:04:26 INFO - psutil == 3.1.1 16:04:26 INFO - requests == 1.2.3 16:04:26 INFO - wsgiref == 0.1.2 16:04:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:26 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 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:04:26 INFO - Using env: {'DISPLAY': ':0', 16:04:26 INFO - 'HOME': '/home/cltbld', 16:04:26 INFO - 'LANG': 'en_US.UTF-8', 16:04:26 INFO - 'LANGUAGE': 'en_US:en', 16:04:26 INFO - 'LOGNAME': 'cltbld', 16:04:26 INFO - 'MAIL': '/var/mail/cltbld', 16:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:26 INFO - 'MOZ_NO_REMOTE': '1', 16:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:26 INFO - 'NO_EM_RESTART': '1', 16:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:26 INFO - 'PWD': '/builds/slave/test', 16:04:26 INFO - 'SHELL': '/bin/bash', 16:04:26 INFO - 'SHLVL': '1', 16:04:26 INFO - 'TERM': 'linux', 16:04:26 INFO - 'TMOUT': '86400', 16:04:26 INFO - 'USER': 'cltbld', 16:04:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:26 INFO - '_': '/tools/buildbot/bin/python'} 16:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:04:26 INFO - Cleaning up... 16:04:26 INFO - Return code: 0 16:04:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, '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': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:04:26 INFO - Using env: {'DISPLAY': ':0', 16:04:26 INFO - 'HOME': '/home/cltbld', 16:04:26 INFO - 'LANG': 'en_US.UTF-8', 16:04:26 INFO - 'LANGUAGE': 'en_US:en', 16:04:26 INFO - 'LOGNAME': 'cltbld', 16:04:26 INFO - 'MAIL': '/var/mail/cltbld', 16:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:26 INFO - 'MOZ_NO_REMOTE': '1', 16:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:26 INFO - 'NO_EM_RESTART': '1', 16:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:26 INFO - 'PWD': '/builds/slave/test', 16:04:26 INFO - 'SHELL': '/bin/bash', 16:04:26 INFO - 'SHLVL': '1', 16:04:26 INFO - 'TERM': 'linux', 16:04:26 INFO - 'TMOUT': '86400', 16:04:26 INFO - 'USER': 'cltbld', 16:04:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:26 INFO - '_': '/tools/buildbot/bin/python'} 16:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:04:26 INFO - Cleaning up... 16:04:26 INFO - Return code: 0 16:04:26 INFO - Running post-action listener: _resource_record_post_action 16:04:26 INFO - Running post-action listener: _start_resource_monitoring 16:04:26 INFO - Starting resource monitoring. 16:04:26 INFO - [mozharness: 2017-02-22 00:04:26.669736Z] Finished create-virtualenv step (success) 16:04:26 INFO - [mozharness: 2017-02-22 00:04:26.670181Z] Running install step. 16:04:26 INFO - Running pre-action listener: _resource_record_pre_action 16:04:26 INFO - Running main action method: install 16:04:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:04:26 INFO - Reading from file tmpfile_stdout 16:04:26 INFO - Detecting whether we're running mozinstall >=1.0... 16:04:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:04:26 INFO - Reading from file tmpfile_stdout 16:04:26 INFO - Output received: 16:04:26 INFO - Usage: mozinstall [options] installer 16:04:26 INFO - Options: 16:04:26 INFO - -h, --help show this help message and exit 16:04:26 INFO - -d DEST, --destination=DEST 16:04:26 INFO - Directory to install application into. [default: 16:04:26 INFO - "/builds/slave/test"] 16:04:26 INFO - --app=APP Application being installed. [default: firefox] 16:04:26 INFO - mkdir: /builds/slave/test/build/application 16:04:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:04:43 INFO - Reading from file tmpfile_stdout 16:04:43 INFO - Output received: 16:04:43 INFO - /builds/slave/test/build/application/firefox/firefox 16:04:43 INFO - Running post-action listener: _resource_record_post_action 16:04:43 INFO - [mozharness: 2017-02-22 00:04:43.398401Z] Finished install step (success) 16:04:43 INFO - [mozharness: 2017-02-22 00:04:43.398548Z] Running run-tests step. 16:04:43 INFO - Running pre-action listener: _resource_record_pre_action 16:04:43 INFO - Running main action method: run_tests 16:04:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:04:43 INFO - Python 2.7.3 16:04:43 INFO - Return code: 0 16:04:43 INFO - grabbing minidump binary from tooltool 16:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:04:43 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 0x21de850>, '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 0x21536d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2153b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:04:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:04:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:04:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:04:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:04:43 INFO - Return code: 0 16:04:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:04:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:04:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:04:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:04:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:04:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:04:43 INFO - Using env: {'DISPLAY': ':0', 16:04:43 INFO - 'HOME': '/home/cltbld', 16:04:43 INFO - 'LANG': 'en_US.UTF-8', 16:04:43 INFO - 'LANGUAGE': 'en_US:en', 16:04:43 INFO - 'LOGNAME': 'cltbld', 16:04:43 INFO - 'MAIL': '/var/mail/cltbld', 16:04:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:04:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:43 INFO - 'MOZ_NO_REMOTE': '1', 16:04:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:04:43 INFO - 'NO_EM_RESTART': '1', 16:04:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:43 INFO - 'PWD': '/builds/slave/test', 16:04:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:04:43 INFO - 'SHELL': '/bin/bash', 16:04:43 INFO - 'SHLVL': '1', 16:04:43 INFO - 'TERM': 'linux', 16:04:43 INFO - 'TMOUT': '86400', 16:04:43 INFO - 'USER': 'cltbld', 16:04:43 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533', 16:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:43 INFO - '_': '/tools/buildbot/bin/python'} 16:04:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:04:43 INFO - mozversion application_buildid: 20170221230813 16:04:43 INFO - mozversion application_changeset: 2bbdf69d4cb3a3196cffecad7c86c73529deda2d 16:04:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:04:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:04:43 INFO - mozversion application_name: Firefox 16:04:43 INFO - mozversion application_remotingname: firefox-dev 16:04:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:04:43 INFO - mozversion application_vendor: Mozilla 16:04:43 INFO - mozversion application_version: 53.0a2 16:04:43 INFO - mozversion platform_buildid: 20170221230813 16:04:43 INFO - mozversion platform_changeset: 2bbdf69d4cb3a3196cffecad7c86c73529deda2d 16:04:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:04:43 INFO - mozversion platform_version: 53.0a2 16:04:43 INFO - using testdate: 1487721883 16:04:43 INFO - actual date: 1487721883 16:04:43 INFO - starting webserver on 'localhost:60683' 16:04:43 INFO - SUITE-START | Running 2 tests 16:04:43 INFO - TEST-START | dromaeo_css 16:04:43 INFO - operating with platform_type : linux_ 16:04:43 INFO - Initialising browser for dromaeo_css test... 16:04:43 INFO - TEST-INFO | started process 7798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmapuLs/profile http://localhost:60683/getInfo.html) 16:04:48 INFO - PROCESS | 7798 | __metrics Screen width/height:1600/1200 16:04:48 INFO - PROCESS | 7798 | colorDepth:24 16:04:48 INFO - PROCESS | 7798 | Browser inner width/height: 1024/697 16:04:48 INFO - PROCESS | 7798 | __metrics 16:04:49 INFO - PROCESS | 7798 | 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" 16:04:49 INFO - PROCESS | 7798 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:50 INFO - TEST-INFO | 7798: exit 0 16:04:50 INFO - Browser initialized. 16:04:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:04:50 INFO - TEST-INFO | started process 7888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmapuLs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:02 INFO - PROCESS | 7888 | RSS: Main: 138477568 16:05:02 INFO - PROCESS | 7888 | 16:08:02 INFO - PROCESS | 7888 | Cycle 1(1): loaded http://localhost:60683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60683/tests/dromaeo/cssquery-ext.html) 16:08:03 INFO - PROCESS | 7888 | RSS: Main: 243765248 16:08:03 INFO - PROCESS | 7888 | 16:09:52 INFO - PROCESS | 7888 | ************************* 16:09:52 INFO - PROCESS | 7888 | A coding exception was thrown and uncaught in a Task. 16:09:52 INFO - PROCESS | 7888 | 16:09:52 ERROR - PROCESS | 7888 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:09:52 INFO - PROCESS | 7888 | Full stack: 16:09:52 INFO - PROCESS | 7888 | ************************* 16:11:05 INFO - PROCESS | 7888 | Cycle 1(1): loaded http://localhost:60683/tests/dromaeo/cssquery-ext.html (next: http://localhost:60683/tests/dromaeo/cssquery-jquery.html) 16:11:06 INFO - PROCESS | 7888 | RSS: Main: 227090432 16:11:06 INFO - PROCESS | 7888 | 16:14:08 INFO - PROCESS | 7888 | Cycle 1(1): loaded http://localhost:60683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60683/tests/dromaeo/cssquery-mootools.html) 16:14:08 INFO - PROCESS | 7888 | RSS: Main: 171941888 16:14:08 INFO - PROCESS | 7888 | 16:17:10 INFO - PROCESS | 7888 | Cycle 1(1): loaded http://localhost:60683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60683/tests/dromaeo/cssquery-prototype.html) 16:17:11 INFO - PROCESS | 7888 | RSS: Main: 218415104 16:17:11 INFO - PROCESS | 7888 | 16:20:13 INFO - PROCESS | 7888 | Cycle 1(1): loaded http://localhost:60683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60683/tests/dromaeo/cssquery-yui.html) 16:20:14 INFO - PROCESS | 7888 | RSS: Main: 172548096 16:20:14 INFO - PROCESS | 7888 | 16:23:16 INFO - PROCESS | 7888 | Cycle 1(1): loaded http://localhost:60683/tests/dromaeo/cssquery-yui.html (next: http://localhost:60683/tests/dromaeo/cssquery-dojo.html) 16:23:16 INFO - PROCESS | 7888 | RSS: Main: 259440640 16:23:16 INFO - PROCESS | 7888 | 16:23:16 INFO - PROCESS | 7888 | __start_tp_report 16:23:16 INFO - PROCESS | 7888 | _x_x_mozilla_page_load 16:23:16 INFO - PROCESS | 7888 | _x_x_mozilla_page_load_details 16:23:16 INFO - PROCESS | 7888 | |i|pagename|runs| 16:23:16 INFO - PROCESS | 7888 | |0;dojo.html;3192.728618067464;3258.706716395525;3275.918102047447;3285.4578994465915;3289.1448223461894;5406.297181366427;5452.890942181154;5478.972605136969;5494.175873618954;5536.474034966677;5437.13005919053;5463.617546771728;5477.4796394342575;5494.642848214863;5500.4499550044975;4865.19724245499;4891.8777030574165;4900.558949694518;4933.1860243059855;4969.62727795415;4820.831270905519;4835.8549243522575;4951.653384263103;4959.355283813117;4975.979924115566;4890.388701412324;4907.950920490803;4931.26031095335;4991.600671946236;4996.050750357421;5017.824376146836;5023.773930173151;5024.598032157419;5026.824061157842;5060.139776238048;4793.592544633675;4931.087748766454;4952.034353301107;4964.801407943678;4995.725235112068;5348.064088784447;5393.595480338951;5437.456254374571;5456.372517160537;5527.53015993641;5885.176075349412;5888.558358123115;5897.587168898179;5905.438983296623;5908.172855800191;5851.912221316684;5881.117832325142;5906.852328691774;5930.495907847838;5930.584859059867;5396.055690254189;5434.510894019518;5446.373667028263;5453.23654688344;5462.644928079662;5978.940210597925;5979.252593425822;5980.073088671263;5980.192673989043;5994.880102397928;5707.857303567361;5761.798337058183;5770.682612456355;5774.422557744276;5775;5741.741621627037;5783.88432231353;5784.305883294031;5784.537237021028;5827.59206855516;5815.941840581625;5864.091065884794;5868.178455016301;5893.499052580493;5902;5843.561732870052;5878.559108066912;5881.558883083786;5885.793997210077;5890.087036509348;4455.68810183284;4467.262901621196;4505.324201369821;4534.523874993079;4539.341795439643;3943.3296339622334;4030.9395359069636;4033.576474470197;4046.5346485154582;4064.8577299794365;5577.191307260425;5584.357798853102;5592.916106258409;5594.580406469531;5599.748011339418;5784.50831679312;5784.652920824764;5841.853953651193;5868.383819698955;5869.031609784423;5635.520980716685;5635.6618602883955;5653.802116925888;5665.5467562594895;5672.801451949162;4992.176290912032;5036.194208926554;5037.622178336566;5041.269015992661;5072.543471087546;5894.4400281974;5954.01758709808;6113.32753397126;6115.755369785248;6123.326434092246;5851.180834683063;5890.204822348928;5895.498882595028;5955.583109182316;5988.401159883977;6097.573169878244;6125.509959203164;6128.142060111677;6129;6132.41742034506;5588.748506317307;5771.192033115283;5811.476967072984;5813.534917206529;5815.505682017076;5711.600187986801;5769.07694768835;5787.623804452697;5789.363170051375;5881.05903055509;5665.093585026376;5710.200571919851;5712.37163911961;5713.314402271754;5719.199312096393;5663.235463212578;5667.149927510742;5671.914921276267;5675.631083979528;5703.116017017369;5581.441855814386;5585.190147428519;5664.915026274692;5685.857853553694;5719.742611582572;5814.534837212928;5822.94177058241;5824.330202026821;5828.154917536848;5849.151872978479;5636.436356364331;5665.263515742927;5678.488935995781;5689.544836412994;5691.146328050825 16:23:16 INFO - PROCESS | 7888 | |1;ext.html;583.6118980877717;612.1277180018474;613.8741557980616;643.6781609195402;650.7169381319123;36839.44740828886;47148.764256178714;48334;48377.758111209485;48400.75799621006;48839.51160488394;48864.755676221655;48896.51103488964;48913.26630100551;49176.50823491764;8794.956025219864;9012.8648070279;9305.767355816091;9502.382345147544;9510.619575216982;11160.720981975475;11424.200305978586;11434.25677330975;11749.530018799238;11773.352465614387;10993.835092473579;11040.779184416308;11045.889541104607;11052.502637381338;11057.06014988727;11236.325820450758;11288.717782055432;11305;11306.208565400426;11310.773784524305;11200.887991120066;11271.09831213501;11273.830892536618;11281.661550153509;11285.37930413835;46052.53947460516;46444.76777616124;46471.5352846474;46481.5351846484;46545.30182047272;4384.232759267147;4484.394606728115;4520.638348932078;4540.841070562515;4686.882827929329;32034.519482207786;32072.839635801905;32406.837965810257;33149.83425082883;33283.500747488804;4236.364545318196;4291.592298731615;4306.483222013347;4318.395424640553;4345.326474396474;369185;370391;371474;371819;372974;59610.40389596135;59750.402495974486;60008.699956499935;60043.699781500814;60091.699541502014;62418;62499.375006250266;62544;62546.68726656429;62553;18682.25270989145;19269;19288.90355548213;19288.903555482415;19289.131989060526;13537.729245415234;13928.37322320498;14201.36093875778;14514.564563063124;14768;19223.711644325347;19311.710324345146;19372.515687107654;19372.80627193738;19517;7428.33145016951;7464.738734144279;7516.24837516244;7539.396848252127;7552.158686129961;998.6904059741358;1006.1296978113879;1008.9445080520495;1021.8824835143905;1022.6880801355658;33997.66002339945;34613.307733845686;34725.82637086798;34982.47526287108;35122;1109.240860183025;1198.376844041111;1203.4223572684984;1227.3188380448937;1233.7285797124619;18154.727679084823;18291.54271143232;18365.3572124975;18412.447626571226;18579.349722759638;507701;508600;510977;511653;512107;70080.6495967517;70306.296937031;70511;70609.64695176491;70763.2923670767;1483.777433385001;1528.977065344043;1538.284697615614;1543.984560154384;1559.7036563052984;32569.511457328634;34012.659873400946;34149.82925085359;34205.828970854986;34234.48648270328;57003;57762;57778.422215778985;57809.71095144498;57815.421845781006;399058;399382;400839;401087;402394;28022.15933521916;28679;29858;30638.387232255674;31103.84448077745;52833.20750188673;57672;58245.70877145587;58851.41148588459;65125.348746513824;44983.77508112438;45148;45852.54147458616;50387;50693.49306506888;47726.284105739134;49062.75468622634;49297.26054109119;49412.25881611707;49823.252651209536;48012.5198748022;48768.2684759736;49230.507694924025;49284.50715492942;49528.25707614316;40220.1955960885;43430.34854477122;43525.47660831856;43570;43790.34314485349;31121.68878311188;31445.842770786;31891;32068.5189722159;32348.514772278904 16:23:16 INFO - PROCESS | 7888 | |2;jquery.html;443.65838304505513;450.12900038425647;453.5373918603025;457.9473360563536;458.2210242587601;20215.696764548542;21527.354179374623;22185.223517176903;22333.888330558344;22381.664275035888;13426.597202083953;13606.047576669613;13700.862991370082;13715.314234288271;14008.299585020759;5710.457506536873;6259.405356491126;6295.937040629604;6300.275468321133;6300.8739825203465;4132.318167502373;5051;6160.445559899608;6252.468540174068;6257.843553911143;6015.548833837458;6141.600795948271;6145.692715364214;6149.3235744068115;6150.1082343060225;6154.230721159855;6159.722812473427;6163.106349579309;7095.89356159658;7107.538010029331;6399;6400.327965563595;6406.967965160145;6410.775622853178;6411.198600174978;24998;25718.6142207867;25754.74245257542;25854.74145258561;26139.08513202048;2749.285185851673;2815.9718402815915;2816.6197563329097;2820.844853533055;2823.378856651533;6299.433051025429;6399.264084630234;10051.648192313234;10515.001074897873;10898.836517452244;1992.282778199847;2028.5638587703716;2028.6551286281367;2034.2473284884538;2040.5816807554415;95724;96939;97396.51301743517;99321;99998.50000749949;12436.502539898484;12516.186447880858;12800.295983720798;12938.188653588506;12986;18549.443516694522;18553.721694174597;18624.16191271396;18645.347412840485;18663.906680466782;8697.652093916298;8886.644534218558;9005.369624126379;9036.367454278268;9299.349045566745;8548.957255213683;8562.315014798802;8608.096149904295;8702.608382622797;8834.204921557091;5039.924401133986;5048.62135339851;5141.485851414828;5621.690807005654;5700.429957004267;2078.285414533016;2143.6784482327776;2220.1230513946903;2259.2205689037255;2285.565742508918;947.8767760191269;948.3077353531822;959.4339339789558;970.3353203055788;977.452626529146;19488.317908873123;20908;20989.16043358279;21263.787362126182;22835.885820571122;1098.5166526728215;1102.4322473925934;1103.6082190822303;1113.6826004588816;1114.8550688410617;11071.225014248925;11468.885311146949;11585.884141158649;11594.942025289989;11607.245529040585;619739;621419;621478;646334;648541;82156;96505;103206;114812.42593786978;118006;1126.2341607706837;1149.40231079838;1191.9582814601447;1192.439553409896;1195.7010747313172;18574.535636609195;19008.42974710761;19116.522086947938;19131.85208887471;19131.90434047821;37393.065173369796;41437.378439322834;45659.77170114128;46295.30557041714;48121.75939120282;56791.432085678614;57935.130973036285;60277;67175.3282467169;67213.66393168003;8569.357298202534;9070.773230669287;9146.268298535968;9164.404313719588;9176.35765496409;10722;14222.502212422516;14350.784738229144;14611.92694036523;14810.25948702539;12334.938325308316;12460.87539124597;12519.123661343618;12549.87450125487;12552.121351505308;12109.69725756863;12345;12462.937685311515;12531.373431328579;12896.226226426445;12150.453229604513;12654.177478463871;12845.871541284841;12902.741945160857;12919.22484650924;8991.685291014783;9064.138906803842;9082.54587270647;9223.262139028728;9601.039896010343;10215.795684086424;12244.142909996215;12314.261144331369;12441.688957776129;12498.625041248777 16:23:16 INFO - PROCESS | 7888 | |3;mootools.html;1501.2418728542084;1503.5639664497294;1518.0815606558033;1522.3453914816625;1539.5612250508605;8221.75334739958;8716.56417179141;8717.782055448617;8723.21491065804;8766.430182038162;7620.771376858689;7816.8827467588035;7838.92161078389;7977.042754869424;8673.436226645279;2322.593546129425;2434.6348047792885;2438.0979037755965;2438.1344622658876;2440.389902524369;2408.4580969281947;2428.6842710447618;2429.866357350345;2448.52253810507;2465.137201979302;2420.9636855447184;2433.3794882304987;2448.1186772761794;2456.680631517909;2457.1891275879007;2353.8587684738886;2366.881655917206;2370.0282884017643;2373.8575685458927;2377.679013333195;2284.6573014048026;2375.1212051541042;2383.296927406402;2386.2125498585424;2387.952240955171;8338.332933365316;8419.621117049686;8420.873686894702;8437.873431898526;8451.154884511561;5224.608154388436;5331.573474122061;5357.062514060063;5369.140937449989;5370.140777475624;3131.248500359897;3159.0996565978585;3295.24209431832;3322.1362445764275;3344.7993120412852;1255.755127750089;1256.1018871506917;1271.961841144767;1345.9905071196602;1372.8078069070239;11824.408779561074;11859.347735874524;11865.288082714978;11876.406179690981;11892.167548271538;4535.909281814345;4676.3453116563705;4719.10337035962;4750.952490475051;4799.28010798383;10260.230482713678;10268.58925642966;10272.280940334105;10275.948620256851;10276.383416995004;5468.890622187613;5495.395506494282;5499.560035197174;5503.532199762985;5509.47659972302;4987.800487980513;5051.090803655304;5060.190369540929;5075.720835354017;5118.718470484085;4128.705568070807;4176.31090870003;4178.309117036617;4211.873643790691;4225.408442818008;1303.758804621148;1323.8051191772745;1329.7407005633809;1332.1673953778889;1333.0069098521662;1002.8946960569181;1034.1519953637944;1048.7587854793287;1053.2890299048265;1055.3193190392153;6055.909161362495;6144.569880108439;6172.783952561639;6245.906311405332;6327.905081423783;1071.4107241017566;1085.9945700271605;1101.5098281264761;1109.916756243285;1113.7215696075982;4240.830366785294;4250.236151996886;4434.733915965053;4639.257718765049;4686.390769199982;10419.322744021614;10608.20438467118;10654.89345106539;10670.35977841332;10673.306235094695;9717.514124293899;10243.180545556337;10498.842517362245;10535.42055186972;10541.893101224261;7861.7641470754825;8062.234087761771;8069.919300806917;8074.515529068275;8092.109867914524;5735.225744524602;5924.407559244041;6026.216591843032;6093.263419925477;6185.103160041679;9346.392484488486;9600.231981441608;9619.5671194795;9637.325387222827;9641.228701703987;8594.570271486276;9704.902950970682;9784.755381115245;9794.608215671293;9796.461194634363;7213.567185968858;7383.335499805044;7513.173550909505;7619.885701714589;7758.379329653501;8468.91531084706;8477.152284771473;8521.573921303787;8526.61630226629;8580.14198580137;7336.523125996793;7409.444291678254;7450.105987281344;7497.062867141607;7666.9616651916385;7535.585542795199;7576.886346704914;7619.771406857803;7636;7699.076110866732;6786.3892249697765;6860.211075726355;6927.58434493932;6935.375816176568;6943.51395402317;5383.67697938125;5402.783888644411;5444.863878403072;5456.454354564512;5571.13647384656;5139.511746384088;5266.104762190514;5282.735863206747;5340.49265319794;5349.919751203657 16:23:16 INFO - PROCESS | 7888 | |4;prototype.html;374.7751349190486;378.4890397962752;379.91262009737756;380.86288935983043;384.96535311821947;5355.892882142355;5358.812441564546;5358.89282214356;5363.383210930744;5390.326209223847;5277;5282.154855223165;5296.25852380667;5300.469953004697;5332.733363331828;3736.9349735325436;3957.5844536323702;4113.71204015719;4208.274607410962;4224.366345048252;4171.416001759756;4172.958270417287;4179.2059508693255;4183.979080104596;4189.245935731567;4082.2447847148223;4143;4156.937645935298;4166.937495937564;4196.685248606367;4194.30793919003;4196.433481479991;4198.6641068714425;4204.747715137101;4244.745315281093;3728.7017038637114;3740.121071548184;3760.623937606245;3766.736328457009;3778.886633401002;5153.845384638467;5179.482051794828;5190;5194.246834209056;5242.449542797989;4864.662217890073;4879.097366987084;4885.413750349981;4892.730899800509;4894.583960363373;5264.814787053816;5592.245046918695;5604.971975140098;5613.354464236624;5620.241267428926;4036.4147198656324;4042.191561687674;4046.1705350403095;4055.2497787909037;4060.4976158821128;5547.944520554743;5586.888262234773;5703.17303990919;5726.5705072119345;5801.680907550083;4040.6867767975527;4060.6548443382053;4061.3907913813164;4096.877093687194;4115.1975364804175;4142.91714165721;4150.813213405404;4151.833926642961;4152;4159.417681524589;4578.5650363215445;4684.625229981593;4769.618430525549;4795.568398844121;4829.372181616367;5567.777288908479;5577;5589.832305030855;5598.412166722517;5688.748475335419;1368.2406264523286;1372.5264783649625;1375.7111006688508;1391.325207274471;1393.815257031515;914.5884352041608;947.5735918836551;957.5534509328731;959.4195511715451;966.4249771386014;5266.815661451831;5300.9734951325;5320.866978325573;5326;5327.627066105335;5506.531944784658;5565.332160140728;5594;5606.495415412633;5626.774929002794;5057.949420505822;5269.920951185735;5286.497782710713;5314.415414304423;5351.892962140735;2934.5891575179494;2948.3366242595243;2953.5126704094014;2954.5715871198554;2957.7190166934106;5694;5727.6849773262875;5736.799212027559;5742.856428589319;5756.675964528098;5330.92003619946;5560.443955604488;5628.212050312959;5697.487226149667;5722.856928576735;5779.52622081375;5787.8874210913555;5791.536677065825;5793.768249269982;5878.353381128072;5315.4418786028455;5484.177373394023;5528.9447105530035;5552.611317207757;5616.5787565931905;5412.864678383072;5484.341878974548;5500.4224556420995;5506.797281087437;5510.090835012178;5666.829995100154;5718.656880587178;5812.593118481835;5890.52875769946;5917.142014407973;4091.2179717792187;4098.405731168904;4100.876973690794;4108.8356465741035;4109.9589004109575;5669.603127781016;5709.600327977168;5817.283901249226;5818.272715910512;5832.812695239285;5569.972150139223;5576.163575463713;5601.60788744784;5610.747516361692;5611.354694210218;5560.471755183251;5579.302587176603;5592.468715472024;5613.719314034363;5628;5268.288781014514;5547.833564993057;5555.166724991283;5572.777088916398;5592.916106258328;5632.859178520406;5644.943550564606;5678.602497825278;5688.232088667977;5692.918345514339;5458.590605704509;5571.439996800902;5573.108302671553;5593.496585307342;5596.748146333343 16:23:16 INFO - PROCESS | 7888 | |5;yui.html;750.2129588578433;768.8654485465042;786.2059320086714;932.1703683721489;941.7221919533739;15763.684726305468;15770.369185232592;16374.508764737062;18459.353922612678;19408.708869366972;16620.33518659252;16851.831481685178;16949;17246.39637612684;17249.137543122826;824.007071478868;840.1766269056328;845.1632883445376;845.480029781686;846.0355195077616;716.6918225163178;740.7518481308769;831.580052073702;852.4970267542149;858.0432817408607;886.2201262888649;888.2671795768484;888.4891187567142;888.8977767556717;889.995550022249;877.0221203358274;883.4478450968145;883.7481317824421;884.4869975414244;884.9292056635454;559.9496045355937;575.3958343739057;622.7042154976396;644.1851058411114;650.2716957008181;17451.738223926524;17890;17942;17949.282028718837;17964.91017544917;13895.610438956124;14585.636454672076;14614.853851461456;15043.398264069425;15803;12853.48586056566;13091.934540327238;13139.211647301097;13177.011724120634;13263.27052012139;3972.1857019310974;4010.5187377514594;4019.397090436458;4043.7573745575064;4065.4918135233097;80086.59956700179;80817.59591202006;81334.59332703358;83489;83657.58171209105;12132.878671213351;12264.754704905852;12275.2021118627;12285.631431057083;12475.313857737912;23133;23380;23461.53076938486;23589.882050589982;23767.762322376555;8616.267617252604;8642.6975055874;8781.385303028726;8782.913548323007;8907;4481.35020422037;4629.745364004944;4708.411448568929;4744.312074749142;4772.260299653559;3440.8623655053516;3524.3832329342263;3528.6118526962014;3534.6642069003406;3540.6459354064386;668.6756922892394;671.378974448633;677.8474843160349;678.2098854834063;690.6098054599236;857.7040920882285;860.1828263150032;863.6558112693164;869.1178453869328;880.7974165941869;9469.952650236704;9981.251406144569;10028.448435336126;10245.282830201815;10279.691609251735;811.6225954930985;812.7196117339508;817.448222449844;824.6907409721355;825.4910034378966;4824.469308376076;4831.9275210871865;4847.175980083394;4848.272759086165;4876.561109500091;77746;78134;79734.20265797384;79758;83830;68984.31015689779;69245.30754692489;69622.65188674025;70759;72060.63969680118;61621.94031267665;62534.68732656308;63011.684941575;64065.03902441467;64125.67937160378;9155.40489868183;9331.393459425115;9350.485723285012;9426.95286523563;9449.763755906157;42669.146617066865;43324.56675433205;43620.72496416204;43626.56373436225;43677.563224367346;47546.28680569863;48550.271745923135;49834.50165498299;55158.44841551533;56226.43773562212;12971.156874803108;13123.475060997835;13162.80255796183;13230.206187628773;13428.261445620585;13719.971002174678;13763.724725505634;13963.162210267417;14191.148531088167;14240.287985600886;13457.461701531829;13547.864521355055;13602.727945441233;13659.726805464034;13909;13219.603411897659;13357.265350405822;13414.396352163982;13480.79778803299;13549.661258468223;13106.279154646585;13366.398512066786;13367.331633418486;13549.525766598123;14007.229602371968;10306.690799276033;10355;10678.62624808128;10926.289791163548;10983.83524247121;9742.31803773729;10266.33268837553;10300.845487317845;10304.690859274233;10358.689239322832 16:23:16 INFO - PROCESS | 7888 | __end_tp_report 16:23:16 INFO - PROCESS | 7888 | __start_cc_report 16:23:16 INFO - PROCESS | 7888 | _x_x_mozilla_cycle_collect,968 16:23:16 INFO - PROCESS | 7888 | __end_cc_report 16:23:16 INFO - PROCESS | 7888 | __startTimestamp1487722996922__endTimestamp 16:23:16 INFO - PROCESS | 7888 | 16:23:16 INFO - PROCESS | 7888 | ------- Summary: start ------- 16:23:16 INFO - PROCESS | 7888 | Number of tests: 6 16:23:16 INFO - PROCESS | 7888 | 16:23:16 INFO - PROCESS | 7888 | [#0] dojo.html Cycles:165 Average:5444.12 Median:5667.15 stddev:611.75 (10.8%) stddev-sans-first:587.58 16:23:16 INFO - PROCESS | 7888 | Values: 3192.7 3258.7 3275.9 3285.5 3289.1 5406.3 5452.9 5479.0 5494.2 5536.5 5437.1 5463.6 5477.5 5494.6 5500.4 4865.2 4891.9 4900.6 4933.2 4969.6 4820.8 4835.9 4951.7 4959.4 4976.0 4890.4 4908.0 4931.3 4991.6 4996.1 5017.8 5023.8 5024.6 5026.8 5060.1 4793.6 4931.1 4952.0 4964.8 4995.7 5348.1 5393.6 5437.5 5456.4 5527.5 5885.2 5888.6 5897.6 5905.4 5908.2 5851.9 5881.1 5906.9 5930.5 5930.6 5396.1 5434.5 5446.4 5453.2 5462.6 5978.9 5979.3 5980.1 5980.2 5994.9 5707.9 5761.8 5770.7 5774.4 5775.0 5741.7 5783.9 5784.3 5784.5 5827.6 5815.9 5864.1 5868.2 5893.5 5902.0 5843.6 5878.6 5881.6 5885.8 5890.1 4455.7 4467.3 4505.3 4534.5 4539.3 3943.3 4030.9 4033.6 4046.5 4064.9 5577.2 5584.4 5592.9 5594.6 5599.7 5784.5 5784.7 5841.9 5868.4 5869.0 5635.5 5635.7 5653.8 5665.5 5672.8 4992.2 5036.2 5037.6 5041.3 5072.5 5894.4 5954.0 6113.3 6115.8 6123.3 5851.2 5890.2 5895.5 5955.6 5988.4 6097.6 6125.5 6128.1 6129.0 6132.4 5588.7 5771.2 5811.5 5813.5 5815.5 5711.6 5769.1 5787.6 5789.4 5881.1 5665.1 5710.2 5712.4 5713.3 5719.2 5663.2 5667.1 5671.9 5675.6 5703.1 5581.4 5585.2 5664.9 5685.9 5719.7 5814.5 5822.9 5824.3 5828.2 5849.2 5636.4 5665.3 5678.5 5689.5 5691.1 16:23:16 INFO - PROCESS | 7888 | 16:23:16 INFO - PROCESS | 7888 | [#1] ext.html Cycles:180 Average:61919.66 Median:203315.18 stddev:113670.68 (55.9%) stddev-sans-first:113896.27 16:23:16 INFO - PROCESS | 7888 | Values: 583.6 612.1 613.9 643.7 650.7 36839.4 47148.8 48334.0 48377.8 48400.8 48839.5 48864.8 48896.5 48913.3 49176.5 8795.0 9012.9 9305.8 9502.4 9510.6 11160.7 11424.2 11434.3 11749.5 11773.4 10993.8 11040.8 11045.9 11052.5 11057.1 11236.3 11288.7 11305.0 11306.2 11310.8 11200.9 11271.1 11273.8 11281.7 11285.4 46052.5 46444.8 46471.5 46481.5 46545.3 4384.2 4484.4 4520.6 4540.8 4686.9 32034.5 32072.8 32406.8 33149.8 33283.5 4236.4 4291.6 4306.5 4318.4 4345.3 369185.0 370391.0 371474.0 371819.0 372974.0 59610.4 59750.4 60008.7 60043.7 60091.7 62418.0 62499.4 62544.0 62546.7 62553.0 18682.3 19269.0 19288.9 19288.9 19289.1 13537.7 13928.4 14201.4 14514.6 14768.0 19223.7 19311.7 19372.5 19372.8 19517.0 7428.3 7464.7 7516.2 7539.4 7552.2 998.7 1006.1 1008.9 1021.9 1022.7 33997.7 34613.3 34725.8 34982.5 35122.0 1109.2 1198.4 1203.4 1227.3 1233.7 18154.7 18291.5 18365.4 18412.4 18579.3 507701.0 508600.0 510977.0 511653.0 512107.0 70080.6 70306.3 70511.0 70609.6 70763.3 1483.8 1529.0 1538.3 1544.0 1559.7 32569.5 34012.7 34149.8 34205.8 34234.5 57003.0 57762.0 57778.4 57809.7 57815.4 399058.0 399382.0 400839.0 401087.0 402394.0 28022.2 28679.0 29858.0 30638.4 31103.8 52833.2 57672.0 58245.7 58851.4 65125.3 44983.8 45148.0 45852.5 50387.0 50693.5 47726.3 49062.8 49297.3 49412.3 49823.3 48012.5 48768.3 49230.5 49284.5 49528.3 40220.2 43430.3 43525.5 43570.0 43790.3 31121.7 31445.8 31891.0 32068.5 32348.5 16:23:16 INFO - PROCESS | 7888 | 16:23:16 INFO - PROCESS | 7888 | [#2] jquery.html Cycles:180 Average:34356.73 Median:14444.19 stddev:103946.90 (719.6%) stddev-sans-first:104207.30 16:23:16 INFO - PROCESS | 7888 | Values: 443.7 450.1 453.5 457.9 458.2 20215.7 21527.4 22185.2 22333.9 22381.7 13426.6 13606.0 13700.9 13715.3 14008.3 5710.5 6259.4 6295.9 6300.3 6300.9 4132.3 5051.0 6160.4 6252.5 6257.8 6015.5 6141.6 6145.7 6149.3 6150.1 6154.2 6159.7 6163.1 7095.9 7107.5 6399.0 6400.3 6407.0 6410.8 6411.2 24998.0 25718.6 25754.7 25854.7 26139.1 2749.3 2816.0 2816.6 2820.8 2823.4 6299.4 6399.3 10051.6 10515.0 10898.8 1992.3 2028.6 2028.7 2034.2 2040.6 95724.0 96939.0 97396.5 99321.0 99998.5 12436.5 12516.2 12800.3 12938.2 12986.0 18549.4 18553.7 18624.2 18645.3 18663.9 8697.7 8886.6 9005.4 9036.4 9299.3 8549.0 8562.3 8608.1 8702.6 8834.2 5039.9 5048.6 5141.5 5621.7 5700.4 2078.3 2143.7 2220.1 2259.2 2285.6 947.9 948.3 959.4 970.3 977.5 19488.3 20908.0 20989.2 21263.8 22835.9 1098.5 1102.4 1103.6 1113.7 1114.9 11071.2 11468.9 11585.9 11594.9 11607.2 619739.0 621419.0 621478.0 646334.0 648541.0 82156.0 96505.0 103206.0 114812.4 118006.0 1126.2 1149.4 1192.0 1192.4 1195.7 18574.5 19008.4 19116.5 19131.9 19131.9 37393.1 41437.4 45659.8 46295.3 48121.8 56791.4 57935.1 60277.0 67175.3 67213.7 8569.4 9070.8 9146.3 9164.4 9176.4 10722.0 14222.5 14350.8 14611.9 14810.3 12334.9 12460.9 12519.1 12549.9 12552.1 12109.7 12345.0 12462.9 12531.4 12896.2 12150.5 12654.2 12845.9 12902.7 12919.2 8991.7 9064.1 9082.5 9223.3 9601.0 10215.8 12244.1 12314.3 12441.7 12498.6 16:23:16 INFO - PROCESS | 7888 | 16:23:16 INFO - PROCESS | 7888 | [#3] mootools.html Cycles:180 Average:5746.63 Median:5055.64 stddev:3107.29 (61.5%) stddev-sans-first:3099.63 16:23:16 INFO - PROCESS | 7888 | Values: 1501.2 1503.6 1518.1 1522.3 1539.6 8221.8 8716.6 8717.8 8723.2 8766.4 7620.8 7816.9 7838.9 7977.0 8673.4 2322.6 2434.6 2438.1 2438.1 2440.4 2408.5 2428.7 2429.9 2448.5 2465.1 2421.0 2433.4 2448.1 2456.7 2457.2 2353.9 2366.9 2370.0 2373.9 2377.7 2284.7 2375.1 2383.3 2386.2 2388.0 8338.3 8419.6 8420.9 8437.9 8451.2 5224.6 5331.6 5357.1 5369.1 5370.1 3131.2 3159.1 3295.2 3322.1 3344.8 1255.8 1256.1 1272.0 1346.0 1372.8 11824.4 11859.3 11865.3 11876.4 11892.2 4535.9 4676.3 4719.1 4751.0 4799.3 10260.2 10268.6 10272.3 10275.9 10276.4 5468.9 5495.4 5499.6 5503.5 5509.5 4987.8 5051.1 5060.2 5075.7 5118.7 4128.7 4176.3 4178.3 4211.9 4225.4 1303.8 1323.8 1329.7 1332.2 1333.0 1002.9 1034.2 1048.8 1053.3 1055.3 6055.9 6144.6 6172.8 6245.9 6327.9 1071.4 1086.0 1101.5 1109.9 1113.7 4240.8 4250.2 4434.7 4639.3 4686.4 10419.3 10608.2 10654.9 10670.4 10673.3 9717.5 10243.2 10498.8 10535.4 10541.9 7861.8 8062.2 8069.9 8074.5 8092.1 5735.2 5924.4 6026.2 6093.3 6185.1 9346.4 9600.2 9619.6 9637.3 9641.2 8594.6 9704.9 9784.8 9794.6 9796.5 7213.6 7383.3 7513.2 7619.9 7758.4 8468.9 8477.2 8521.6 8526.6 8580.1 7336.5 7409.4 7450.1 7497.1 7667.0 7535.6 7576.9 7619.8 7636.0 7699.1 6786.4 6860.2 6927.6 6935.4 6943.5 5383.7 5402.8 5444.9 5456.5 5571.1 5139.5 5266.1 5282.7 5340.5 5349.9 16:23:16 INFO - PROCESS | 7888 | 16:23:16 INFO - PROCESS | 7888 | [#4] prototype.html Cycles:180 Average:4677.98 Median:5329.27 stddev:1359.56 (25.5%) stddev-sans-first:1324.45 16:23:16 INFO - PROCESS | 7888 | Values: 374.8 378.5 379.9 380.9 385.0 5355.9 5358.8 5358.9 5363.4 5390.3 5277.0 5282.2 5296.3 5300.5 5332.7 3736.9 3957.6 4113.7 4208.3 4224.4 4171.4 4173.0 4179.2 4184.0 4189.2 4082.2 4143.0 4156.9 4166.9 4196.7 4194.3 4196.4 4198.7 4204.7 4244.7 3728.7 3740.1 3760.6 3766.7 3778.9 5153.8 5179.5 5190.0 5194.2 5242.4 4864.7 4879.1 4885.4 4892.7 4894.6 5264.8 5592.2 5605.0 5613.4 5620.2 4036.4 4042.2 4046.2 4055.2 4060.5 5547.9 5586.9 5703.2 5726.6 5801.7 4040.7 4060.7 4061.4 4096.9 4115.2 4142.9 4150.8 4151.8 4152.0 4159.4 4578.6 4684.6 4769.6 4795.6 4829.4 5567.8 5577.0 5589.8 5598.4 5688.7 1368.2 1372.5 1375.7 1391.3 1393.8 914.6 947.6 957.6 959.4 966.4 5266.8 5301.0 5320.9 5326.0 5327.6 5506.5 5565.3 5594.0 5606.5 5626.8 5057.9 5269.9 5286.5 5314.4 5351.9 2934.6 2948.3 2953.5 2954.6 2957.7 5694.0 5727.7 5736.8 5742.9 5756.7 5330.9 5560.4 5628.2 5697.5 5722.9 5779.5 5787.9 5791.5 5793.8 5878.4 5315.4 5484.2 5528.9 5552.6 5616.6 5412.9 5484.3 5500.4 5506.8 5510.1 5666.8 5718.7 5812.6 5890.5 5917.1 4091.2 4098.4 4100.9 4108.8 4110.0 5669.6 5709.6 5817.3 5818.3 5832.8 5570.0 5576.2 5601.6 5610.7 5611.4 5560.5 5579.3 5592.5 5613.7 5628.0 5268.3 5547.8 5555.2 5572.8 5592.9 5632.9 5644.9 5678.6 5688.2 5692.9 5458.6 5571.4 5573.1 5593.5 5596.7 16:23:16 INFO - PROCESS | 7888 | 16:23:16 INFO - PROCESS | 7888 | [#5] yui.html Cycles:180 Average:17952.12 Median:26145.30 stddev:22670.20 (86.7%) stddev-sans-first:22697.00 16:23:16 INFO - PROCESS | 7888 | Values: 750.2 768.9 786.2 932.2 941.7 15763.7 15770.4 16374.5 18459.4 19408.7 16620.3 16851.8 16949.0 17246.4 17249.1 824.0 840.2 845.2 845.5 846.0 716.7 740.8 831.6 852.5 858.0 886.2 888.3 888.5 888.9 890.0 877.0 883.4 883.7 884.5 884.9 559.9 575.4 622.7 644.2 650.3 17451.7 17890.0 17942.0 17949.3 17964.9 13895.6 14585.6 14614.9 15043.4 15803.0 12853.5 13091.9 13139.2 13177.0 13263.3 3972.2 4010.5 4019.4 4043.8 4065.5 80086.6 80817.6 81334.6 83489.0 83657.6 12132.9 12264.8 12275.2 12285.6 12475.3 23133.0 23380.0 23461.5 23589.9 23767.8 8616.3 8642.7 8781.4 8782.9 8907.0 4481.4 4629.7 4708.4 4744.3 4772.3 3440.9 3524.4 3528.6 3534.7 3540.6 668.7 671.4 677.8 678.2 690.6 857.7 860.2 863.7 869.1 880.8 9470.0 9981.3 10028.4 10245.3 10279.7 811.6 812.7 817.4 824.7 825.5 4824.5 4831.9 4847.2 4848.3 4876.6 77746.0 78134.0 79734.2 79758.0 83830.0 68984.3 69245.3 69622.7 70759.0 72060.6 61621.9 62534.7 63011.7 64065.0 64125.7 9155.4 9331.4 9350.5 9427.0 9449.8 42669.1 43324.6 43620.7 43626.6 43677.6 47546.3 48550.3 49834.5 55158.4 56226.4 12971.2 13123.5 13162.8 13230.2 13428.3 13720.0 13763.7 13963.2 14191.1 14240.3 13457.5 13547.9 13602.7 13659.7 13909.0 13219.6 13357.3 13414.4 13480.8 13549.7 13106.3 13366.4 13367.3 13549.5 14007.2 10306.7 10355.0 10678.6 10926.3 10983.8 9742.3 10266.3 10300.8 10304.7 10358.7 16:23:16 INFO - PROCESS | 7888 | -------- Summary: end -------- 16:23:16 INFO - PROCESS | 7888 | 16:23:17 INFO - TEST-INFO | 7888: exit 0 16:23:17 INFO - TEST-OK | dromaeo_css | took 1114017ms 16:23:17 INFO - TEST-START | kraken 16:23:17 INFO - operating with platform_type : linux_ 16:23:17 INFO - Initialising browser for kraken test... 16:23:17 INFO - TEST-INFO | started process 8208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6B62xa/profile http://localhost:60683/getInfo.html) 16:23:22 INFO - PROCESS | 8208 | __metrics Screen width/height:1600/1200 16:23:22 INFO - PROCESS | 8208 | colorDepth:24 16:23:22 INFO - PROCESS | 8208 | Browser inner width/height: 1024/697 16:23:22 INFO - PROCESS | 8208 | __metrics 16:23:22 INFO - PROCESS | 8208 | 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" 16:23:22 INFO - PROCESS | 8208 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:23:23 INFO - TEST-INFO | 8208: exit 0 16:23:23 INFO - Browser initialized. 16:23:23 INFO - Running cycle 1/1 for kraken test... 16:23:23 INFO - TEST-INFO | started process 8298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6B62xa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:35 INFO - PROCESS | 8298 | RSS: Main: 138522624 16:23:35 INFO - PROCESS | 8298 | 16:23:38 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60683/tests/kraken/driver.html?testName=audio-beat-detection) 16:23:39 INFO - PROCESS | 8298 | RSS: Main: 182845440 16:23:39 INFO - PROCESS | 8298 | 16:23:41 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60683/tests/kraken/driver.html?testName=audio-dft) 16:23:42 INFO - PROCESS | 8298 | RSS: Main: 172355584 16:23:42 INFO - PROCESS | 8298 | 16:23:45 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60683/tests/kraken/driver.html?testName=audio-fft) 16:23:45 INFO - PROCESS | 8298 | RSS: Main: 263966720 16:23:45 INFO - PROCESS | 8298 | 16:23:47 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60683/tests/kraken/driver.html?testName=audio-oscillator) 16:23:48 INFO - PROCESS | 8298 | RSS: Main: 170532864 16:23:48 INFO - PROCESS | 8298 | 16:23:50 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:23:50 INFO - PROCESS | 8298 | RSS: Main: 173133824 16:23:50 INFO - PROCESS | 8298 | 16:23:53 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60683/tests/kraken/driver.html?testName=imaging-darkroom) 16:23:54 INFO - PROCESS | 8298 | RSS: Main: 212041728 16:23:54 INFO - PROCESS | 8298 | 16:23:57 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60683/tests/kraken/driver.html?testName=imaging-desaturate) 16:23:58 INFO - PROCESS | 8298 | RSS: Main: 210792448 16:23:58 INFO - PROCESS | 8298 | 16:24:01 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60683/tests/kraken/driver.html?testName=json-parse-financial) 16:24:01 INFO - PROCESS | 8298 | RSS: Main: 208875520 16:24:01 INFO - PROCESS | 8298 | 16:24:03 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:24:03 INFO - PROCESS | 8298 | RSS: Main: 171159552 16:24:03 INFO - PROCESS | 8298 | 16:24:05 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60683/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:24:06 INFO - PROCESS | 8298 | RSS: Main: 177897472 16:24:06 INFO - PROCESS | 8298 | 16:24:08 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:24:08 INFO - PROCESS | 8298 | RSS: Main: 187404288 16:24:08 INFO - PROCESS | 8298 | 16:24:11 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:24:12 INFO - PROCESS | 8298 | RSS: Main: 197263360 16:24:12 INFO - PROCESS | 8298 | 16:24:14 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:24:15 INFO - PROCESS | 8298 | RSS: Main: 193454080 16:24:15 INFO - PROCESS | 8298 | 16:24:16 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:60683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60683/tests/kraken/driver.html?testName=ai-astar) 16:24:17 INFO - PROCESS | 8298 | RSS: Main: 244662272 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | __start_tp_report 16:24:17 INFO - PROCESS | 8298 | _x_x_mozilla_page_load 16:24:17 INFO - PROCESS | 8298 | _x_x_mozilla_page_load_details 16:24:17 INFO - PROCESS | 8298 | |i|pagename|runs| 16:24:17 INFO - PROCESS | 8298 | |0;ai-astar;111;111;113;114;114;113;112;111;113;112 16:24:17 INFO - PROCESS | 8298 | |1;audio-beat-detection;143;121;119;154;116;117;123;117;139;119 16:24:17 INFO - PROCESS | 8298 | |2;audio-dft;159;162;160;160;161;160;160;160;161;160 16:24:17 INFO - PROCESS | 8298 | |3;audio-fft;75;76;75;112;77;76;75;75;92;77 16:24:17 INFO - PROCESS | 8298 | |4;audio-oscillator;82;82;108;83;83;83;96;83;82;111 16:24:17 INFO - PROCESS | 8298 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;117 16:24:17 INFO - PROCESS | 8298 | |6;imaging-darkroom;147;146;147;146;146;146;145;146;145;145 16:24:17 INFO - PROCESS | 8298 | |7;imaging-desaturate;95;97;95;95;96;95;96;98;96;96 16:24:17 INFO - PROCESS | 8298 | |8;json-parse-financial;47;48;48;48;49;51;50;50;50;48 16:24:17 INFO - PROCESS | 8298 | |9;json-stringify-tinderbox;62;63;62;63;63;62;63;63;64;63 16:24:17 INFO - PROCESS | 8298 | |10;stanford-crypto-aes;76;81;77;76;76;80;81;76;76;76 16:24:17 INFO - PROCESS | 8298 | |11;stanford-crypto-ccm;136;127;123;122;129;120;122;119;160;129 16:24:17 INFO - PROCESS | 8298 | |12;stanford-crypto-pbkdf2;156;157;155;158;159;159;159;160;155;156 16:24:17 INFO - PROCESS | 8298 | |13;stanford-crypto-sha256-iterative;63;60;60;60;61;61;61;60;57;59 16:24:17 INFO - PROCESS | 8298 | __end_tp_report 16:24:17 INFO - PROCESS | 8298 | __start_cc_report 16:24:17 INFO - PROCESS | 8298 | _x_x_mozilla_cycle_collect,1511 16:24:17 INFO - PROCESS | 8298 | __end_cc_report 16:24:17 INFO - PROCESS | 8298 | __startTimestamp1487723057245__endTimestamp 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | ------- Summary: start ------- 16:24:17 INFO - PROCESS | 8298 | Number of tests: 14 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.17 (1.0%) stddev-sans-first:1.13 16:24:17 INFO - PROCESS | 8298 | Values: 111.0 111.0 113.0 114.0 114.0 113.0 112.0 111.0 113.0 112.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:122.00 stddev:13.46 (11.0%) stddev-sans-first:12.93 16:24:17 INFO - PROCESS | 8298 | Values: 143.0 121.0 119.0 154.0 116.0 117.0 123.0 117.0 139.0 119.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 16:24:17 INFO - PROCESS | 8298 | Values: 159.0 162.0 160.0 160.0 161.0 160.0 160.0 160.0 161.0 160.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:12.06 (15.9%) stddev-sans-first:12.59 16:24:17 INFO - PROCESS | 8298 | Values: 75.0 76.0 75.0 112.0 77.0 76.0 75.0 75.0 92.0 77.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.00 stddev:11.47 (13.8%) stddev-sans-first:11.86 16:24:17 INFO - PROCESS | 8298 | Values: 82.0 82.0 108.0 83.0 83.0 83.0 96.0 83.0 82.0 111.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:24:17 INFO - PROCESS | 8298 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 16:24:17 INFO - PROCESS | 8298 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 16:24:17 INFO - PROCESS | 8298 | Values: 95.0 97.0 95.0 95.0 96.0 95.0 96.0 98.0 96.0 96.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.50 stddev:1.29 (2.6%) stddev-sans-first:1.17 16:24:17 INFO - PROCESS | 8298 | Values: 47.0 48.0 48.0 48.0 49.0 51.0 50.0 50.0 50.0 48.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 16:24:17 INFO - PROCESS | 8298 | Values: 62.0 63.0 62.0 63.0 63.0 62.0 63.0 63.0 64.0 63.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:2.22 (2.9%) stddev-sans-first:2.29 16:24:17 INFO - PROCESS | 8298 | Values: 76.0 81.0 77.0 76.0 76.0 80.0 81.0 76.0 76.0 76.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:128.00 stddev:12.15 (9.5%) stddev-sans-first:12.59 16:24:17 INFO - PROCESS | 8298 | Values: 136.0 127.0 123.0 122.0 129.0 120.0 122.0 119.0 160.0 129.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:158.50 stddev:1.84 (1.2%) stddev-sans-first:1.88 16:24:17 INFO - PROCESS | 8298 | Values: 156.0 157.0 155.0 158.0 159.0 159.0 159.0 160.0 155.0 156.0 16:24:17 INFO - PROCESS | 8298 | 16:24:17 INFO - PROCESS | 8298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:60.50 stddev:1.55 (2.6%) stddev-sans-first:1.27 16:24:17 INFO - PROCESS | 8298 | Values: 63.0 60.0 60.0 60.0 61.0 61.0 61.0 60.0 57.0 59.0 16:24:17 INFO - PROCESS | 8298 | -------- Summary: end -------- 16:24:17 INFO - PROCESS | 8298 | 16:24:18 INFO - TEST-INFO | 8298: exit 0 16:24:18 INFO - TEST-OK | kraken | took 60622ms 16:24:18 INFO - SUITE-END | took 1174s 16:24:18 INFO - Completed test suite (00:19:34) 16:24:18 INFO - javascript benchmark 16:24:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3192.728618067464, 3258.706716395525, 3275.918102047447, 3285.4578994465915, 3289.1448223461894, 5406.297181366427, 5452.890942181154, 5478.972605136969, 5494.175873618954, 5536.474034966677, 5437.13005919053, 5463.617546771728, 5477.4796394342575, 5494.642848214863, 5500.4499550044975, 4865.19724245499, 4891.8777030574165, 4900.558949694518, 4933.1860243059855, 4969.62727795415, 4820.831270905519, 4835.8549243522575, 4951.653384263103, 4959.355283813117, 4975.979924115566, 4890.388701412324, 4907.950920490803, 4931.26031095335, 4991.600671946236, 4996.050750357421, 5017.824376146836, 5023.773930173151, 5024.598032157419, 5026.824061157842, 5060.139776238048, 4793.592544633675, 4931.087748766454, 4952.034353301107, 4964.801407943678, 4995.725235112068, 5348.064088784447, 5393.595480338951, 5437.456254374571, 5456.372517160537, 5527.53015993641, 5885.176075349412, 5888.558358123115, 5897.587168898179, 5905.438983296623, 5908.172855800191, 5851.912221316684, 5881.117832325142, 5906.852328691774, 5930.495907847838, 5930.584859059867, 5396.055690254189, 5434.510894019518, 5446.373667028263, 5453.23654688344, 5462.644928079662, 5978.940210597925, 5979.252593425822, 5980.073088671263, 5980.192673989043, 5994.880102397928, 5707.857303567361, 5761.798337058183, 5770.682612456355, 5774.422557744276, 5775.0, 5741.741621627037, 5783.88432231353, 5784.305883294031, 5784.537237021028, 5827.59206855516, 5815.941840581625, 5864.091065884794, 5868.178455016301, 5893.499052580493, 5902.0, 5843.561732870052, 5878.559108066912, 5881.558883083786, 5885.793997210077, 5890.087036509348, 4455.68810183284, 4467.262901621196, 4505.324201369821, 4534.523874993079, 4539.341795439643, 3943.3296339622334, 4030.9395359069636, 4033.576474470197, 4046.5346485154582, 4064.8577299794365, 5577.191307260425, 5584.357798853102, 5592.916106258409, 5594.580406469531, 5599.748011339418, 5784.50831679312, 5784.652920824764, 5841.853953651193, 5868.383819698955, 5869.031609784423, 5635.520980716685, 5635.6618602883955, 5653.802116925888, 5665.5467562594895, 5672.801451949162, 4992.176290912032, 5036.194208926554, 5037.622178336566, 5041.269015992661, 5072.543471087546, 5894.4400281974, 5954.01758709808, 6113.32753397126, 6115.755369785248, 6123.326434092246, 5851.180834683063, 5890.204822348928, 5895.498882595028, 5955.583109182316, 5988.401159883977, 6097.573169878244, 6125.509959203164, 6128.142060111677, 6129.0, 6132.41742034506, 5588.748506317307, 5771.192033115283, 5811.476967072984, 5813.534917206529, 5815.505682017076, 5711.600187986801, 5769.07694768835, 5787.623804452697, 5789.363170051375, 5881.05903055509, 5665.093585026376, 5710.200571919851, 5712.37163911961, 5713.314402271754, 5719.199312096393, 5663.235463212578, 5667.149927510742, 5671.914921276267, 5675.631083979528, 5703.116017017369, 5581.441855814386, 5585.190147428519, 5664.915026274692, 5685.857853553694, 5719.742611582572, 5814.534837212928, 5822.94177058241, 5824.330202026821, 5828.154917536848, 5849.151872978479, 5636.436356364331, 5665.263515742927, 5678.488935995781, 5689.544836412994, 5691.146328050825], "value": 5403.792375661835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6118980877717, 612.1277180018474, 613.8741557980616, 643.6781609195402, 650.7169381319123, 36839.44740828886, 47148.764256178714, 48334.0, 48377.758111209485, 48400.75799621006, 48839.51160488394, 48864.755676221655, 48896.51103488964, 48913.26630100551, 49176.50823491764, 8794.956025219864, 9012.8648070279, 9305.767355816091, 9502.382345147544, 9510.619575216982, 11160.720981975475, 11424.200305978586, 11434.25677330975, 11749.530018799238, 11773.352465614387, 10993.835092473579, 11040.779184416308, 11045.889541104607, 11052.502637381338, 11057.06014988727, 11236.325820450758, 11288.717782055432, 11305.0, 11306.208565400426, 11310.773784524305, 11200.887991120066, 11271.09831213501, 11273.830892536618, 11281.661550153509, 11285.37930413835, 46052.53947460516, 46444.76777616124, 46471.5352846474, 46481.5351846484, 46545.30182047272, 4384.232759267147, 4484.394606728115, 4520.638348932078, 4540.841070562515, 4686.882827929329, 32034.519482207786, 32072.839635801905, 32406.837965810257, 33149.83425082883, 33283.500747488804, 4236.364545318196, 4291.592298731615, 4306.483222013347, 4318.395424640553, 4345.326474396474, 369185.0, 370391.0, 371474.0, 371819.0, 372974.0, 59610.40389596135, 59750.402495974486, 60008.699956499935, 60043.699781500814, 60091.699541502014, 62418.0, 62499.375006250266, 62544.0, 62546.68726656429, 62553.0, 18682.25270989145, 19269.0, 19288.90355548213, 19288.903555482415, 19289.131989060526, 13537.729245415234, 13928.37322320498, 14201.36093875778, 14514.564563063124, 14768.0, 19223.711644325347, 19311.710324345146, 19372.515687107654, 19372.80627193738, 19517.0, 7428.33145016951, 7464.738734144279, 7516.24837516244, 7539.396848252127, 7552.158686129961, 998.6904059741358, 1006.1296978113879, 1008.9445080520495, 1021.8824835143905, 1022.6880801355658, 33997.66002339945, 34613.307733845686, 34725.82637086798, 34982.47526287108, 35122.0, 1109.240860183025, 1198.376844041111, 1203.4223572684984, 1227.3188380448937, 1233.7285797124619, 18154.727679084823, 18291.54271143232, 18365.3572124975, 18412.447626571226, 18579.349722759638, 507701.0, 508600.0, 510977.0, 511653.0, 512107.0, 70080.6495967517, 70306.296937031, 70511.0, 70609.64695176491, 70763.2923670767, 1483.777433385001, 1528.977065344043, 1538.284697615614, 1543.984560154384, 1559.7036563052984, 32569.511457328634, 34012.659873400946, 34149.82925085359, 34205.828970854986, 34234.48648270328, 57003.0, 57762.0, 57778.422215778985, 57809.71095144498, 57815.421845781006, 399058.0, 399382.0, 400839.0, 401087.0, 402394.0, 28022.15933521916, 28679.0, 29858.0, 30638.387232255674, 31103.84448077745, 52833.20750188673, 57672.0, 58245.70877145587, 58851.41148588459, 65125.348746513824, 44983.77508112438, 45148.0, 45852.54147458616, 50387.0, 50693.49306506888, 47726.284105739134, 49062.75468622634, 49297.26054109119, 49412.25881611707, 49823.252651209536, 48012.5198748022, 48768.2684759736, 49230.507694924025, 49284.50715492942, 49528.25707614316, 40220.1955960885, 43430.34854477122, 43525.47660831856, 43570.0, 43790.34314485349, 31121.68878311188, 31445.842770786, 31891.0, 32068.5189722159, 32348.514772278904], "value": 22211.690790036144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.65838304505513, 450.12900038425647, 453.5373918603025, 457.9473360563536, 458.2210242587601, 20215.696764548542, 21527.354179374623, 22185.223517176903, 22333.888330558344, 22381.664275035888, 13426.597202083953, 13606.047576669613, 13700.862991370082, 13715.314234288271, 14008.299585020759, 5710.457506536873, 6259.405356491126, 6295.937040629604, 6300.275468321133, 6300.8739825203465, 4132.318167502373, 5051.0, 6160.445559899608, 6252.468540174068, 6257.843553911143, 6015.548833837458, 6141.600795948271, 6145.692715364214, 6149.3235744068115, 6150.1082343060225, 6154.230721159855, 6159.722812473427, 6163.106349579309, 7095.89356159658, 7107.538010029331, 6399.0, 6400.327965563595, 6406.967965160145, 6410.775622853178, 6411.198600174978, 24998.0, 25718.6142207867, 25754.74245257542, 25854.74145258561, 26139.08513202048, 2749.285185851673, 2815.9718402815915, 2816.6197563329097, 2820.844853533055, 2823.378856651533, 6299.433051025429, 6399.264084630234, 10051.648192313234, 10515.001074897873, 10898.836517452244, 1992.282778199847, 2028.5638587703716, 2028.6551286281367, 2034.2473284884538, 2040.5816807554415, 95724.0, 96939.0, 97396.51301743517, 99321.0, 99998.50000749949, 12436.502539898484, 12516.186447880858, 12800.295983720798, 12938.188653588506, 12986.0, 18549.443516694522, 18553.721694174597, 18624.16191271396, 18645.347412840485, 18663.906680466782, 8697.652093916298, 8886.644534218558, 9005.369624126379, 9036.367454278268, 9299.349045566745, 8548.957255213683, 8562.315014798802, 8608.096149904295, 8702.608382622797, 8834.204921557091, 5039.924401133986, 5048.62135339851, 5141.485851414828, 5621.690807005654, 5700.429957004267, 2078.285414533016, 2143.6784482327776, 2220.1230513946903, 2259.2205689037255, 2285.565742508918, 947.8767760191269, 948.3077353531822, 959.4339339789558, 970.3353203055788, 977.452626529146, 19488.317908873123, 20908.0, 20989.16043358279, 21263.787362126182, 22835.885820571122, 1098.5166526728215, 1102.4322473925934, 1103.6082190822303, 1113.6826004588816, 1114.8550688410617, 11071.225014248925, 11468.885311146949, 11585.884141158649, 11594.942025289989, 11607.245529040585, 619739.0, 621419.0, 621478.0, 646334.0, 648541.0, 82156.0, 96505.0, 103206.0, 114812.42593786978, 118006.0, 1126.2341607706837, 1149.40231079838, 1191.9582814601447, 1192.439553409896, 1195.7010747313172, 18574.535636609195, 19008.42974710761, 19116.522086947938, 19131.85208887471, 19131.90434047821, 37393.065173369796, 41437.378439322834, 45659.77170114128, 46295.30557041714, 48121.75939120282, 56791.432085678614, 57935.130973036285, 60277.0, 67175.3282467169, 67213.66393168003, 8569.357298202534, 9070.773230669287, 9146.268298535968, 9164.404313719588, 9176.35765496409, 10722.0, 14222.502212422516, 14350.784738229144, 14611.92694036523, 14810.25948702539, 12334.938325308316, 12460.87539124597, 12519.123661343618, 12549.87450125487, 12552.121351505308, 12109.69725756863, 12345.0, 12462.937685311515, 12531.373431328579, 12896.226226426445, 12150.453229604513, 12654.177478463871, 12845.871541284841, 12902.741945160857, 12919.22484650924, 8991.685291014783, 9064.138906803842, 9082.54587270647, 9223.262139028728, 9601.039896010343, 10215.795684086424, 12244.142909996215, 12314.261144331369, 12441.688957776129, 12498.625041248777], "value": 9963.610851517868, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.2418728542084, 1503.5639664497294, 1518.0815606558033, 1522.3453914816625, 1539.5612250508605, 8221.75334739958, 8716.56417179141, 8717.782055448617, 8723.21491065804, 8766.430182038162, 7620.771376858689, 7816.8827467588035, 7838.92161078389, 7977.042754869424, 8673.436226645279, 2322.593546129425, 2434.6348047792885, 2438.0979037755965, 2438.1344622658876, 2440.389902524369, 2408.4580969281947, 2428.6842710447618, 2429.866357350345, 2448.52253810507, 2465.137201979302, 2420.9636855447184, 2433.3794882304987, 2448.1186772761794, 2456.680631517909, 2457.1891275879007, 2353.8587684738886, 2366.881655917206, 2370.0282884017643, 2373.8575685458927, 2377.679013333195, 2284.6573014048026, 2375.1212051541042, 2383.296927406402, 2386.2125498585424, 2387.952240955171, 8338.332933365316, 8419.621117049686, 8420.873686894702, 8437.873431898526, 8451.154884511561, 5224.608154388436, 5331.573474122061, 5357.062514060063, 5369.140937449989, 5370.140777475624, 3131.248500359897, 3159.0996565978585, 3295.24209431832, 3322.1362445764275, 3344.7993120412852, 1255.755127750089, 1256.1018871506917, 1271.961841144767, 1345.9905071196602, 1372.8078069070239, 11824.408779561074, 11859.347735874524, 11865.288082714978, 11876.406179690981, 11892.167548271538, 4535.909281814345, 4676.3453116563705, 4719.10337035962, 4750.952490475051, 4799.28010798383, 10260.230482713678, 10268.58925642966, 10272.280940334105, 10275.948620256851, 10276.383416995004, 5468.890622187613, 5495.395506494282, 5499.560035197174, 5503.532199762985, 5509.47659972302, 4987.800487980513, 5051.090803655304, 5060.190369540929, 5075.720835354017, 5118.718470484085, 4128.705568070807, 4176.31090870003, 4178.309117036617, 4211.873643790691, 4225.408442818008, 1303.758804621148, 1323.8051191772745, 1329.7407005633809, 1332.1673953778889, 1333.0069098521662, 1002.8946960569181, 1034.1519953637944, 1048.7587854793287, 1053.2890299048265, 1055.3193190392153, 6055.909161362495, 6144.569880108439, 6172.783952561639, 6245.906311405332, 6327.905081423783, 1071.4107241017566, 1085.9945700271605, 1101.5098281264761, 1109.916756243285, 1113.7215696075982, 4240.830366785294, 4250.236151996886, 4434.733915965053, 4639.257718765049, 4686.390769199982, 10419.322744021614, 10608.20438467118, 10654.89345106539, 10670.35977841332, 10673.306235094695, 9717.514124293899, 10243.180545556337, 10498.842517362245, 10535.42055186972, 10541.893101224261, 7861.7641470754825, 8062.234087761771, 8069.919300806917, 8074.515529068275, 8092.109867914524, 5735.225744524602, 5924.407559244041, 6026.216591843032, 6093.263419925477, 6185.103160041679, 9346.392484488486, 9600.231981441608, 9619.5671194795, 9637.325387222827, 9641.228701703987, 8594.570271486276, 9704.902950970682, 9784.755381115245, 9794.608215671293, 9796.461194634363, 7213.567185968858, 7383.335499805044, 7513.173550909505, 7619.885701714589, 7758.379329653501, 8468.91531084706, 8477.152284771473, 8521.573921303787, 8526.61630226629, 8580.14198580137, 7336.523125996793, 7409.444291678254, 7450.105987281344, 7497.062867141607, 7666.9616651916385, 7535.585542795199, 7576.886346704914, 7619.771406857803, 7636.0, 7699.076110866732, 6786.3892249697765, 6860.211075726355, 6927.58434493932, 6935.375816176568, 6943.51395402317, 5383.67697938125, 5402.783888644411, 5444.863878403072, 5456.454354564512, 5571.13647384656, 5139.511746384088, 5266.104762190514, 5282.735863206747, 5340.49265319794, 5349.919751203657], "value": 4696.5625763007665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.7751349190486, 378.4890397962752, 379.91262009737756, 380.86288935983043, 384.96535311821947, 5355.892882142355, 5358.812441564546, 5358.89282214356, 5363.383210930744, 5390.326209223847, 5277.0, 5282.154855223165, 5296.25852380667, 5300.469953004697, 5332.733363331828, 3736.9349735325436, 3957.5844536323702, 4113.71204015719, 4208.274607410962, 4224.366345048252, 4171.416001759756, 4172.958270417287, 4179.2059508693255, 4183.979080104596, 4189.245935731567, 4082.2447847148223, 4143.0, 4156.937645935298, 4166.937495937564, 4196.685248606367, 4194.30793919003, 4196.433481479991, 4198.6641068714425, 4204.747715137101, 4244.745315281093, 3728.7017038637114, 3740.121071548184, 3760.623937606245, 3766.736328457009, 3778.886633401002, 5153.845384638467, 5179.482051794828, 5190.0, 5194.246834209056, 5242.449542797989, 4864.662217890073, 4879.097366987084, 4885.413750349981, 4892.730899800509, 4894.583960363373, 5264.814787053816, 5592.245046918695, 5604.971975140098, 5613.354464236624, 5620.241267428926, 4036.4147198656324, 4042.191561687674, 4046.1705350403095, 4055.2497787909037, 4060.4976158821128, 5547.944520554743, 5586.888262234773, 5703.17303990919, 5726.5705072119345, 5801.680907550083, 4040.6867767975527, 4060.6548443382053, 4061.3907913813164, 4096.877093687194, 4115.1975364804175, 4142.91714165721, 4150.813213405404, 4151.833926642961, 4152.0, 4159.417681524589, 4578.5650363215445, 4684.625229981593, 4769.618430525549, 4795.568398844121, 4829.372181616367, 5567.777288908479, 5577.0, 5589.832305030855, 5598.412166722517, 5688.748475335419, 1368.2406264523286, 1372.5264783649625, 1375.7111006688508, 1391.325207274471, 1393.815257031515, 914.5884352041608, 947.5735918836551, 957.5534509328731, 959.4195511715451, 966.4249771386014, 5266.815661451831, 5300.9734951325, 5320.866978325573, 5326.0, 5327.627066105335, 5506.531944784658, 5565.332160140728, 5594.0, 5606.495415412633, 5626.774929002794, 5057.949420505822, 5269.920951185735, 5286.497782710713, 5314.415414304423, 5351.892962140735, 2934.5891575179494, 2948.3366242595243, 2953.5126704094014, 2954.5715871198554, 2957.7190166934106, 5694.0, 5727.6849773262875, 5736.799212027559, 5742.856428589319, 5756.675964528098, 5330.92003619946, 5560.443955604488, 5628.212050312959, 5697.487226149667, 5722.856928576735, 5779.52622081375, 5787.8874210913555, 5791.536677065825, 5793.768249269982, 5878.353381128072, 5315.4418786028455, 5484.177373394023, 5528.9447105530035, 5552.611317207757, 5616.5787565931905, 5412.864678383072, 5484.341878974548, 5500.4224556420995, 5506.797281087437, 5510.090835012178, 5666.829995100154, 5718.656880587178, 5812.593118481835, 5890.52875769946, 5917.142014407973, 4091.2179717792187, 4098.405731168904, 4100.876973690794, 4108.8356465741035, 4109.9589004109575, 5669.603127781016, 5709.600327977168, 5817.283901249226, 5818.272715910512, 5832.812695239285, 5569.972150139223, 5576.163575463713, 5601.60788744784, 5610.747516361692, 5611.354694210218, 5560.471755183251, 5579.302587176603, 5592.468715472024, 5613.719314034363, 5628.0, 5268.288781014514, 5547.833564993057, 5555.166724991283, 5572.777088916398, 5592.916106258328, 5632.859178520406, 5644.943550564606, 5678.602497825278, 5688.232088667977, 5692.918345514339, 5458.590605704509, 5571.439996800902, 5573.108302671553, 5593.496585307342, 5596.748146333343], "value": 4255.001206539515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2129588578433, 768.8654485465042, 786.2059320086714, 932.1703683721489, 941.7221919533739, 15763.684726305468, 15770.369185232592, 16374.508764737062, 18459.353922612678, 19408.708869366972, 16620.33518659252, 16851.831481685178, 16949.0, 17246.39637612684, 17249.137543122826, 824.007071478868, 840.1766269056328, 845.1632883445376, 845.480029781686, 846.0355195077616, 716.6918225163178, 740.7518481308769, 831.580052073702, 852.4970267542149, 858.0432817408607, 886.2201262888649, 888.2671795768484, 888.4891187567142, 888.8977767556717, 889.995550022249, 877.0221203358274, 883.4478450968145, 883.7481317824421, 884.4869975414244, 884.9292056635454, 559.9496045355937, 575.3958343739057, 622.7042154976396, 644.1851058411114, 650.2716957008181, 17451.738223926524, 17890.0, 17942.0, 17949.282028718837, 17964.91017544917, 13895.610438956124, 14585.636454672076, 14614.853851461456, 15043.398264069425, 15803.0, 12853.48586056566, 13091.934540327238, 13139.211647301097, 13177.011724120634, 13263.27052012139, 3972.1857019310974, 4010.5187377514594, 4019.397090436458, 4043.7573745575064, 4065.4918135233097, 80086.59956700179, 80817.59591202006, 81334.59332703358, 83489.0, 83657.58171209105, 12132.878671213351, 12264.754704905852, 12275.2021118627, 12285.631431057083, 12475.313857737912, 23133.0, 23380.0, 23461.53076938486, 23589.882050589982, 23767.762322376555, 8616.267617252604, 8642.6975055874, 8781.385303028726, 8782.913548323007, 8907.0, 4481.35020422037, 4629.745364004944, 4708.411448568929, 4744.312074749142, 4772.260299653559, 3440.8623655053516, 3524.3832329342263, 3528.6118526962014, 3534.6642069003406, 3540.6459354064386, 668.6756922892394, 671.378974448633, 677.8474843160349, 678.2098854834063, 690.6098054599236, 857.7040920882285, 860.1828263150032, 863.6558112693164, 869.1178453869328, 880.7974165941869, 9469.952650236704, 9981.251406144569, 10028.448435336126, 10245.282830201815, 10279.691609251735, 811.6225954930985, 812.7196117339508, 817.448222449844, 824.6907409721355, 825.4910034378966, 4824.469308376076, 4831.9275210871865, 4847.175980083394, 4848.272759086165, 4876.561109500091, 77746.0, 78134.0, 79734.20265797384, 79758.0, 83830.0, 68984.31015689779, 69245.30754692489, 69622.65188674025, 70759.0, 72060.63969680118, 61621.94031267665, 62534.68732656308, 63011.684941575, 64065.03902441467, 64125.67937160378, 9155.40489868183, 9331.393459425115, 9350.485723285012, 9426.95286523563, 9449.763755906157, 42669.146617066865, 43324.56675433205, 43620.72496416204, 43626.56373436225, 43677.563224367346, 47546.28680569863, 48550.271745923135, 49834.50165498299, 55158.44841551533, 56226.43773562212, 12971.156874803108, 13123.475060997835, 13162.80255796183, 13230.206187628773, 13428.261445620585, 13719.971002174678, 13763.724725505634, 13963.162210267417, 14191.148531088167, 14240.287985600886, 13457.461701531829, 13547.864521355055, 13602.727945441233, 13659.726805464034, 13909.0, 13219.603411897659, 13357.265350405822, 13414.396352163982, 13480.79778803299, 13549.661258468223, 13106.279154646585, 13366.398512066786, 13367.331633418486, 13549.525766598123, 14007.229602371968, 10306.690799276033, 10355.0, 10678.62624808128, 10926.289791163548, 10983.83524247121, 9742.31803773729, 10266.33268837553, 10300.845487317845, 10304.690859274233, 10358.689239322832], "value": 7497.830406233176, "unit": "score"}], "name": "dromaeo_css", "value": 7508.621753263249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 113.0, 114.0, 114.0, 113.0, 112.0, 111.0, 113.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 119.0, 154.0, 116.0, 117.0, 123.0, 117.0, 139.0, 119.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 112.0, 77.0, 76.0, 75.0, 75.0, 92.0, 77.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 108.0, 83.0, 83.0, 83.0, 96.0, 83.0, 82.0, 111.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 98.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 48.0, 48.0, 48.0, 49.0, 51.0, 50.0, 50.0, 50.0, 48.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 64.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 77.0, 76.0, 76.0, 80.0, 81.0, 76.0, 76.0, 76.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 127.0, 123.0, 122.0, 129.0, 120.0, 122.0, 119.0, 160.0, 129.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 155.0, 158.0, 159.0, 159.0, 159.0, 160.0, 155.0, 156.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 60.0, 57.0, 59.0], "value": 60.2, "unit": "score"}], "name": "kraken", "value": 1463.9, "alertThreshold": 2.0}]} 16:24:18 INFO - Return code: 0 16:24:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:24:18 ERROR - # TBPL SUCCESS # 16:24:18 INFO - Running post-action listener: _resource_record_post_action 16:24:18 INFO - [mozharness: 2017-02-22 00:24:18.585636Z] Finished run-tests step (success) 16:24:18 INFO - Running post-run listener: _resource_record_post_run 16:24:18 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 363732992; Read time: 0; Write time: 494868 16:24:18 INFO - TinderboxPrint: CPU usage
13.1% 16:24:18 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:24:18 INFO - TinderboxPrint: I/O write bytes / time
363,732,992 / 494,868 16:24:18 INFO - TinderboxPrint: CPU idle
8,263.5 (86.9%) 16:24:18 INFO - TinderboxPrint: CPU user
1,192.9 (12.5%) 16:24:18 INFO - TinderboxPrint: Swap in / out
0 / 0 16:24:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110116864; Read time: 0; Write time: 211388 16:24:18 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 253616128; Read time: 0; Write time: 283480 16:24:19 INFO - Running post-run listener: _upload_blobber_files 16:24:19 INFO - Blob upload gear active. 16:24:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:24:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:24:19 INFO - (blobuploader) - INFO - Open directory for files ... 16:24:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:24:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:24:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:20 INFO - (blobuploader) - INFO - Done attempting. 16:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:24:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:21 INFO - (blobuploader) - INFO - Done attempting. 16:24:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:24:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:24:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:24 INFO - (blobuploader) - INFO - Done attempting. 16:24:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:24:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:24:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:24:25 INFO - (blobuploader) - INFO - Done attempting. 16:24:25 INFO - (blobuploader) - INFO - Iteration through files over. 16:24:25 INFO - Return code: 0 16:24:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:24:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:24:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51c1cb21043a27f174055705414b9335b58292a770baa221b85dddc89628c3980907b0d75e11a206da97a3c3cf24685c7297b814db9327a30caf398cab41b35a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da2d23c49a750b35f9aca3a181a1ce8336409cc81317a58d78cf75d4494b0cef3fa0aad57c3829741d549b8e701a14b8ffda66ffa9ca2b4025b00e7e5cebc587", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3af8ff9350d3bd3ffb24df865553d67ecfb0339720b7cc1ec86b28fa6ee767dcf30ba49b2c8f47aa5e0f1c4b3db6d8074235ed58c04c17c693a042c1b0d94582", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e12fcb42d8bf755449069f87485155d30768deb208921d159b29672ace4424b7483acebf3ea613139b50a04e83431d44ac32d729c4ddbfff0353d3ea9c2f08aa"} 16:24:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:24:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:24:25 INFO - Contents: 16:24:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51c1cb21043a27f174055705414b9335b58292a770baa221b85dddc89628c3980907b0d75e11a206da97a3c3cf24685c7297b814db9327a30caf398cab41b35a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da2d23c49a750b35f9aca3a181a1ce8336409cc81317a58d78cf75d4494b0cef3fa0aad57c3829741d549b8e701a14b8ffda66ffa9ca2b4025b00e7e5cebc587", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3af8ff9350d3bd3ffb24df865553d67ecfb0339720b7cc1ec86b28fa6ee767dcf30ba49b2c8f47aa5e0f1c4b3db6d8074235ed58c04c17c693a042c1b0d94582", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e12fcb42d8bf755449069f87485155d30768deb208921d159b29672ace4424b7483acebf3ea613139b50a04e83431d44ac32d729c4ddbfff0353d3ea9c2f08aa"} 16:24:25 INFO - Running post-run listener: copy_logs_to_upload_dir 16:24:25 INFO - Copying logs to upload dir... 16:24:25 INFO - mkdir: /builds/slave/test/build/upload/logs 16:24:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.598449 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-21 16:24:24.704966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 16:24:24.712618) ========= 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=ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533 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-Aurora/sha512/51c1cb21043a27f174055705414b9335b58292a770baa221b85dddc89628c3980907b0d75e11a206da97a3c3cf24685c7297b814db9327a30caf398cab41b35a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da2d23c49a750b35f9aca3a181a1ce8336409cc81317a58d78cf75d4494b0cef3fa0aad57c3829741d549b8e701a14b8ffda66ffa9ca2b4025b00e7e5cebc587", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3af8ff9350d3bd3ffb24df865553d67ecfb0339720b7cc1ec86b28fa6ee767dcf30ba49b2c8f47aa5e0f1c4b3db6d8074235ed58c04c17c693a042c1b0d94582", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e12fcb42d8bf755449069f87485155d30768deb208921d159b29672ace4424b7483acebf3ea613139b50a04e83431d44ac32d729c4ddbfff0353d3ea9c2f08aa"} build_url:https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/Ys35NFhtTSSEKzfEjSp5-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51c1cb21043a27f174055705414b9335b58292a770baa221b85dddc89628c3980907b0d75e11a206da97a3c3cf24685c7297b814db9327a30caf398cab41b35a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da2d23c49a750b35f9aca3a181a1ce8336409cc81317a58d78cf75d4494b0cef3fa0aad57c3829741d549b8e701a14b8ffda66ffa9ca2b4025b00e7e5cebc587", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3af8ff9350d3bd3ffb24df865553d67ecfb0339720b7cc1ec86b28fa6ee767dcf30ba49b2c8f47aa5e0f1c4b3db6d8074235ed58c04c17c693a042c1b0d94582", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e12fcb42d8bf755449069f87485155d30768deb208921d159b29672ace4424b7483acebf3ea613139b50a04e83431d44ac32d729c4ddbfff0353d3ea9c2f08aa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 16:24:24.736566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 16:24:24.736866) ========= 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=ba164b0a7b0ec7655860e956000001c1-1487721826.72876-555136533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 16:24:24.819896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 16:24:24.820190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 16:24:24.823493) ========= ========= Total master_lag: 0.17 =========