builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1484101537.9 results: success (0) revision: b079c9833e3ed047e1b984e26b8d62d739baa40b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:37.901267) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:37.901746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:37.902029) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:37.916418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:37.916701) ========= 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=923d835db2ba3686ebe126b700000192-1484101538.131696-37847782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-10 18:25:38-- 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% 35.2M=0s 2017-01-10 18:25:38 (35.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:38.015757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:38.016076) ========= 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=923d835db2ba3686ebe126b700000192-1484101538.131696-37847782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020026 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:38.066316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 18:25:38.066656) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b079c9833e3ed047e1b984e26b8d62d739baa40b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b079c9833e3ed047e1b984e26b8d62d739baa40b --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=923d835db2ba3686ebe126b700000192-1484101538.131696-37847782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-10 18:25:38,961 truncating revision to first 12 chars 2017-01-10 18:25:38,961 Setting DEBUG logging. 2017-01-10 18:25:38,961 attempt 1/10 2017-01-10 18:25:38,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b079c9833e3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 18:25:40,036 unpacking tar archive at: mozilla-central-b079c9833e3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.391932 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 18:25:39.475286) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:39.475684) ========= script_repo_revision: b079c9833e3ed047e1b984e26b8d62d739baa40b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:39.476134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:39.476430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 18:25:39.487172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-10 18:25:39.487711) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1484101538.131696-37847782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:25:40 INFO - MultiFileLogger online at 20170110 18:25:40 in /builds/slave/test 18:25:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:25:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:25:40 INFO - {'append_to_log': False, 18:25:40 INFO - 'base_work_dir': '/builds/slave/test', 18:25:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:25:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:25:40 INFO - 'branch': 'Firefox-Non-PGO', 18:25:40 INFO - 'buildbot_json_path': 'buildprops.json', 18:25:40 INFO - 'config_files': ('talos/linux_config.py',), 18:25:40 INFO - 'default_actions': ('clobber', 18:25:40 INFO - 'read-buildbot-config', 18:25:40 INFO - 'download-and-extract', 18:25:40 INFO - 'populate-webroot', 18:25:40 INFO - 'create-virtualenv', 18:25:40 INFO - 'install', 18:25:40 INFO - 'run-tests'), 18:25:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:25:40 INFO - 'download_minidump_stackwalk': True, 18:25:40 INFO - 'download_symbols': 'ondemand', 18:25:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:25:40 INFO - 'tooltool.py': '/tools/tooltool.py', 18:25:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:25:40 INFO - '/tools/misc-python/virtualenv.py')}, 18:25:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:25:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:25:40 INFO - 'installer_path': 'installer.exe', 18:25:40 INFO - 'log_level': 'info', 18:25:40 INFO - 'log_name': 'talos', 18:25:40 INFO - 'log_to_console': True, 18:25:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:25:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:25:40 INFO - 'opt_config_files': (), 18:25:40 INFO - 'pip_index': False, 18:25:40 INFO - 'sps_profile': False, 18:25:40 INFO - 'sps_profile_interval': 0, 18:25:40 INFO - 'suite': 'dromaeojs', 18:25:40 INFO - 'system_bits': '32', 18:25:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:25:40 INFO - 'title': 'talos-linux64-ix-007', 18:25:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:25:40 INFO - 'use_talos_json': True, 18:25:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:25:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:25:40 INFO - 'work_dir': 'build'} 18:25:40 INFO - [mozharness: 2017-01-11 02:25:40.485332Z] Running clobber step. 18:25:40 INFO - Running pre-action listener: _resource_record_pre_action 18:25:40 INFO - Running main action method: clobber 18:25:40 INFO - rmtree: /builds/slave/test/build 18:25:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:25:40 INFO - Running post-action listener: _resource_record_post_action 18:25:40 INFO - [mozharness: 2017-01-11 02:25:40.952708Z] Finished clobber step (success) 18:25:40 INFO - [mozharness: 2017-01-11 02:25:40.952808Z] Running read-buildbot-config step. 18:25:40 INFO - Running pre-action listener: _resource_record_pre_action 18:25:40 INFO - Running main action method: read_buildbot_config 18:25:40 INFO - Using buildbot properties: 18:25:40 INFO - { 18:25:40 INFO - "project": "", 18:25:40 INFO - "product": "firefox", 18:25:40 INFO - "who": "kwierso@gmail.com", 18:25:40 INFO - "installer_path": "public/build/target.tar.bz2", 18:25:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:25:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:25:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:25:40 INFO - "stage_platform": "linux64", 18:25:40 INFO - "basedir": "/builds/slave/test", 18:25:40 INFO - "buildnumber": 380, 18:25:40 INFO - "platform": "ubuntu64_hw", 18:25:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:25:40 INFO - "slavebuilddir": "test", 18:25:40 INFO - "taskId": "EkEl9kXfQuGCfaNjruE_Eg", 18:25:40 INFO - "branch": "mozilla-central", 18:25:40 INFO - "script_repo_revision": "production", 18:25:40 INFO - "revision": "b079c9833e3ed047e1b984e26b8d62d739baa40b", 18:25:40 INFO - "slavename": "talos-linux64-ix-007", 18:25:40 INFO - "repo_path": "mozilla-central" 18:25:40 INFO - } 18:25:40 INFO - Finding installer, test and symbols from parent task. 18:25:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EkEl9kXfQuGCfaNjruE_Eg'}, attempt #1 18:25:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EkEl9kXfQuGCfaNjruE_Eg'}, attempt #1 18:25:41 INFO - Task dependencies: GQqIBWpfR5ylz9r8qPC_Zw 18:25:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw'}, attempt #1 18:25:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.tar.bz2 18:25:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/test_packages.json 18:25:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.crashreporter-symbols.zip 18:25:42 INFO - Running post-action listener: _resource_record_post_action 18:25:42 INFO - [mozharness: 2017-01-11 02:25:42.396829Z] Finished read-buildbot-config step (success) 18:25:42 INFO - [mozharness: 2017-01-11 02:25:42.397046Z] Running download-and-extract step. 18:25:42 INFO - Running pre-action listener: _resource_record_pre_action 18:25:42 INFO - Running main action method: download_and_extract 18:25:42 INFO - mkdir: /builds/slave/test/build/tests 18:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:42 INFO - trying https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.test_packages.json 18:25:42 INFO - Downloading https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:25:42 INFO - Downloaded 896 bytes. 18:25:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:25:42 INFO - Using the following test package requirements: 18:25:42 INFO - {u'common': [u'target.common.tests.zip'], 18:25:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:25:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:25:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:25:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:25:42 INFO - u'mozbase': [u'target.common.tests.zip'], 18:25:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:25:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:25:42 INFO - u'web-platform': [u'target.common.tests.zip', 18:25:42 INFO - u'target.web-platform.tests.zip'], 18:25:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:25:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:25:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.common.tests.zip 18:25:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:25:42 INFO - Fetch https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.common.tests.zip into memory 18:25:43 INFO - Expected file size: 20257948 18:25:43 INFO - Obtained file size: 20257948 18:25:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:25:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.common.tests.zip 18:25:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:25:47 INFO - Fetch https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.common.tests.zip into memory 18:25:48 INFO - Expected file size: 20257948 18:25:48 INFO - Obtained file size: 20257948 18:25:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.talos.tests.zip 18:25:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:25:53 INFO - Fetch https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.talos.tests.zip into memory 18:25:54 INFO - Expected file size: 14403529 18:25:54 INFO - Obtained file size: 14403529 18:25:54 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')]} 18:25:54 INFO - trying https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.tar.bz2 18:25:54 INFO - Downloading https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:25:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:25:55 INFO - Downloaded 56019921 bytes. 18:25:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.tar.bz2 18:25:55 INFO - mkdir: /builds/slave/test/properties 18:25:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:55 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:55 INFO - Contents: 18:25:55 INFO - build_url:https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.tar.bz2 18:25:55 INFO - Running post-action listener: _resource_record_post_action 18:25:55 INFO - Running post-action listener: set_extra_try_arguments 18:25:55 INFO - [mozharness: 2017-01-11 02:25:55.355796Z] Finished download-and-extract step (success) 18:25:55 INFO - [mozharness: 2017-01-11 02:25:55.355893Z] Running populate-webroot step. 18:25:55 INFO - Running pre-action listener: _resource_record_pre_action 18:25:55 INFO - Running main action method: populate_webroot 18:25:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:25:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:25:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:25:55 INFO - '--tppagecycles', 18:25:55 INFO - '7'], 18:25:55 INFO - 'tests': ['tsvgm']}}, 18:25:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:25:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:25:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:25:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:25:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:25:55 INFO - 'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:25:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:25:55 INFO - 'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['damp', 'tps']}, 18:25:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:25:55 INFO - 'tests': ['damp', 'tps']}, 18:25:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['dromaeo_dom']}, 18:25:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['basic_compositor_video']}, 18:25:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:25:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other-e10s': {'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['a11yr', 18:25:55 INFO - 'ts_paint', 18:25:55 INFO - 'tpaint', 18:25:55 INFO - 'sessionrestore', 18:25:55 INFO - 'sessionrestore_no_auto_restore', 18:25:55 INFO - 'tabpaint']}, 18:25:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['tsvgx', 18:25:55 INFO - 'tsvgr_opacity', 18:25:55 INFO - 'tart', 18:25:55 INFO - 'tscrollx', 18:25:55 INFO - 'cart', 18:25:55 INFO - 'tsvg_static']}, 18:25:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:25:55 INFO - 'tsvgr_opacity', 18:25:55 INFO - 'tart', 18:25:55 INFO - 'tscrollx', 18:25:55 INFO - 'cart', 18:25:55 INFO - 'tsvg_static']}, 18:25:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:25:55 INFO - 'talos_options': ['--disable-e10s'], 18:25:55 INFO - 'tests': ['tp5o']}, 18:25:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:25:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:25:55 INFO - 'talos_options': ['--disable-e10s', 18:25:55 INFO - '--xperf_path', 18:25:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:55 INFO - 'tests': ['tp5n']}, 18:25:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:25:55 INFO - 'talos_options': ['--xperf_path', 18:25:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:55 INFO - 'tests': ['tp5n']}}, 18:25:55 INFO - 'talos.zip': {'path': '', 18:25:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:25:55 INFO - Running post-action listener: _resource_record_post_action 18:25:55 INFO - [mozharness: 2017-01-11 02:25:55.368922Z] Finished populate-webroot step (success) 18:25:55 INFO - [mozharness: 2017-01-11 02:25:55.369014Z] Running create-virtualenv step. 18:25:55 INFO - Running pre-action listener: _resource_record_pre_action 18:25:55 INFO - Running main action method: create_virtualenv 18:25:55 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:55 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 18:25:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:25:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:55 INFO - Using real prefix '/usr' 18:25:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:25:55 INFO - Installing distribute.............................................................................................................................................................................................done. 18:25:57 INFO - Installing pip.................done. 18:25:57 INFO - Return code: 0 18:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:25:58 INFO - Reading from file tmpfile_stdout 18:25:58 INFO - Output received: 18:25:58 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) 18:25:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:25:58 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')]} 18:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:58 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')]} 18:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:58 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 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:25:58 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 18:25:58 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 18:25:58 INFO - Using env: {'DISPLAY': ':0', 18:25:58 INFO - 'HOME': '/home/cltbld', 18:25:58 INFO - 'LANG': 'en_US.UTF-8', 18:25:58 INFO - 'LANGUAGE': 'en_US:en', 18:25:58 INFO - 'LOGNAME': 'cltbld', 18:25:58 INFO - 'MAIL': '/var/mail/cltbld', 18:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:58 INFO - 'MOZ_NO_REMOTE': '1', 18:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:58 INFO - 'NO_EM_RESTART': '1', 18:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:58 INFO - 'PWD': '/builds/slave/test', 18:25:58 INFO - 'SHELL': '/bin/bash', 18:25:58 INFO - 'SHLVL': '1', 18:25:58 INFO - 'TERM': 'linux', 18:25:58 INFO - 'TMOUT': '86400', 18:25:58 INFO - 'USER': 'cltbld', 18:25:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:58 INFO - '_': '/tools/buildbot/bin/python'} 18:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:58 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 18:25:58 INFO - Cleaning up... 18:25:58 INFO - Return code: 0 18:25:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:25:58 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')]} 18:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:58 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')]} 18:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:58 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 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:25:58 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 18:25:58 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 18:25:58 INFO - Using env: {'DISPLAY': ':0', 18:25:58 INFO - 'HOME': '/home/cltbld', 18:25:58 INFO - 'LANG': 'en_US.UTF-8', 18:25:58 INFO - 'LANGUAGE': 'en_US:en', 18:25:58 INFO - 'LOGNAME': 'cltbld', 18:25:58 INFO - 'MAIL': '/var/mail/cltbld', 18:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:58 INFO - 'MOZ_NO_REMOTE': '1', 18:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:58 INFO - 'NO_EM_RESTART': '1', 18:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:58 INFO - 'PWD': '/builds/slave/test', 18:25:58 INFO - 'SHELL': '/bin/bash', 18:25:58 INFO - 'SHLVL': '1', 18:25:58 INFO - 'TERM': 'linux', 18:25:58 INFO - 'TMOUT': '86400', 18:25:58 INFO - 'USER': 'cltbld', 18:25:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:58 INFO - '_': '/tools/buildbot/bin/python'} 18:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:58 INFO - Downloading/unpacking psutil>=3.1.1 18:25:58 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 18:25:58 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 18:25:58 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 18:25:58 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 18:25:58 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 18:25:58 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 18:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:26:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:00 INFO - Installing collected packages: psutil 18:26:00 INFO - Running setup.py install for psutil 18:26:00 INFO - building 'psutil._psutil_linux' extension 18:26:00 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 18:26:00 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 18:26:00 INFO - building 'psutil._psutil_posix' extension 18:26:00 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 18:26:01 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 18:26:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:01 INFO - Successfully installed psutil 18:26:01 INFO - Cleaning up... 18:26:01 INFO - Return code: 0 18:26:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:26:01 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')]} 18:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:01 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')]} 18:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:01 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 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:26:01 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 18:26:01 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 18:26:01 INFO - Using env: {'DISPLAY': ':0', 18:26:01 INFO - 'HOME': '/home/cltbld', 18:26:01 INFO - 'LANG': 'en_US.UTF-8', 18:26:01 INFO - 'LANGUAGE': 'en_US:en', 18:26:01 INFO - 'LOGNAME': 'cltbld', 18:26:01 INFO - 'MAIL': '/var/mail/cltbld', 18:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:01 INFO - 'MOZ_NO_REMOTE': '1', 18:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:01 INFO - 'NO_EM_RESTART': '1', 18:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:01 INFO - 'PWD': '/builds/slave/test', 18:26:01 INFO - 'SHELL': '/bin/bash', 18:26:01 INFO - 'SHLVL': '1', 18:26:01 INFO - 'TERM': 'linux', 18:26:01 INFO - 'TMOUT': '86400', 18:26:01 INFO - 'USER': 'cltbld', 18:26:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:01 INFO - '_': '/tools/buildbot/bin/python'} 18:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:26:01 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 18:26:01 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 18:26:01 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 18:26:01 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 18:26:01 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 18:26:01 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 18:26:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:26:03 INFO - Installing collected packages: mozsystemmonitor 18:26:03 INFO - Running setup.py install for mozsystemmonitor 18:26:03 INFO - Successfully installed mozsystemmonitor 18:26:03 INFO - Cleaning up... 18:26:03 INFO - Return code: 0 18:26:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:26:03 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')]} 18:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:03 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')]} 18:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:03 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 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:26:03 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 18:26:03 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 18:26:03 INFO - Using env: {'DISPLAY': ':0', 18:26:03 INFO - 'HOME': '/home/cltbld', 18:26:03 INFO - 'LANG': 'en_US.UTF-8', 18:26:03 INFO - 'LANGUAGE': 'en_US:en', 18:26:03 INFO - 'LOGNAME': 'cltbld', 18:26:03 INFO - 'MAIL': '/var/mail/cltbld', 18:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:03 INFO - 'MOZ_NO_REMOTE': '1', 18:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:03 INFO - 'NO_EM_RESTART': '1', 18:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:03 INFO - 'PWD': '/builds/slave/test', 18:26:03 INFO - 'SHELL': '/bin/bash', 18:26:03 INFO - 'SHLVL': '1', 18:26:03 INFO - 'TERM': 'linux', 18:26:03 INFO - 'TMOUT': '86400', 18:26:03 INFO - 'USER': 'cltbld', 18:26:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:03 INFO - '_': '/tools/buildbot/bin/python'} 18:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:03 INFO - Downloading/unpacking jsonschema==2.5.1 18:26:03 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 18:26:03 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 18:26:03 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 18:26:03 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 18:26:03 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 18:26:03 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 18:26:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:26:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:05 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 18:26:06 INFO - Downloading functools32-3.2.3-2.tar.gz 18:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:26:06 INFO - warning: no files found matching '*.txt' 18:26:06 INFO - no previously-included directories found matching 'build' 18:26:06 INFO - no previously-included directories found matching 'dist' 18:26:06 INFO - no previously-included directories found matching '.git*' 18:26:06 INFO - Installing collected packages: jsonschema, functools32 18:26:06 INFO - Running setup.py install for functools32 18:26:06 INFO - warning: no files found matching '*.txt' 18:26:06 INFO - no previously-included directories found matching 'build' 18:26:06 INFO - no previously-included directories found matching 'dist' 18:26:06 INFO - no previously-included directories found matching '.git*' 18:26:06 INFO - Successfully installed jsonschema functools32 18:26:06 INFO - Cleaning up... 18:26:06 INFO - Return code: 0 18:26:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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', '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 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:26: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:26: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 functools32==3.2.3-2 18:26:06 INFO - Using env: {'DISPLAY': ':0', 18:26:06 INFO - 'HOME': '/home/cltbld', 18:26:06 INFO - 'LANG': 'en_US.UTF-8', 18:26:06 INFO - 'LANGUAGE': 'en_US:en', 18:26:06 INFO - 'LOGNAME': 'cltbld', 18:26:06 INFO - 'MAIL': '/var/mail/cltbld', 18:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:06 INFO - 'MOZ_NO_REMOTE': '1', 18:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:06 INFO - 'NO_EM_RESTART': '1', 18:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:06 INFO - 'PWD': '/builds/slave/test', 18:26:06 INFO - 'SHELL': '/bin/bash', 18:26:06 INFO - 'SHLVL': '1', 18:26:06 INFO - 'TERM': 'linux', 18:26:06 INFO - 'TMOUT': '86400', 18:26:06 INFO - 'USER': 'cltbld', 18:26:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:06 INFO - '_': '/tools/buildbot/bin/python'} 18:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:26:06 INFO - Cleaning up... 18:26:06 INFO - Return code: 0 18:26:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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', '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 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:26: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 blobuploader==1.2.4 18:26:06 INFO - Using env: {'DISPLAY': ':0', 18:26:06 INFO - 'HOME': '/home/cltbld', 18:26:06 INFO - 'LANG': 'en_US.UTF-8', 18:26:06 INFO - 'LANGUAGE': 'en_US:en', 18:26:06 INFO - 'LOGNAME': 'cltbld', 18:26:06 INFO - 'MAIL': '/var/mail/cltbld', 18:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:06 INFO - 'MOZ_NO_REMOTE': '1', 18:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:06 INFO - 'NO_EM_RESTART': '1', 18:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:06 INFO - 'PWD': '/builds/slave/test', 18:26:06 INFO - 'SHELL': '/bin/bash', 18:26:06 INFO - 'SHLVL': '1', 18:26:06 INFO - 'TERM': 'linux', 18:26:06 INFO - 'TMOUT': '86400', 18:26:06 INFO - 'USER': 'cltbld', 18:26:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:06 INFO - '_': '/tools/buildbot/bin/python'} 18:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:06 INFO - Downloading/unpacking blobuploader==1.2.4 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 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 18:26:06 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 18:26:08 INFO - Downloading blobuploader-1.2.4.tar.gz 18:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:26:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:26:08 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 18:26:08 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 18:26:08 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 18:26:08 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 18:26:08 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 18:26:08 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 18:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:26:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:09 INFO - Downloading docopt-0.6.1.tar.gz 18:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:26:09 INFO - Installing collected packages: blobuploader, requests, docopt 18:26:09 INFO - Running setup.py install for blobuploader 18:26:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:26:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:26:09 INFO - Running setup.py install for requests 18:26:10 INFO - Running setup.py install for docopt 18:26:10 INFO - Successfully installed blobuploader requests docopt 18:26:10 INFO - Cleaning up... 18:26:10 INFO - Return code: 0 18:26:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:10 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 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:26:10 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 18:26:10 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 18:26:10 INFO - Using env: {'DISPLAY': ':0', 18:26:10 INFO - 'HOME': '/home/cltbld', 18:26:10 INFO - 'LANG': 'en_US.UTF-8', 18:26:10 INFO - 'LANGUAGE': 'en_US:en', 18:26:10 INFO - 'LOGNAME': 'cltbld', 18:26:10 INFO - 'MAIL': '/var/mail/cltbld', 18:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:10 INFO - 'MOZ_NO_REMOTE': '1', 18:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:10 INFO - 'NO_EM_RESTART': '1', 18:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:10 INFO - 'PWD': '/builds/slave/test', 18:26:10 INFO - 'SHELL': '/bin/bash', 18:26:10 INFO - 'SHLVL': '1', 18:26:10 INFO - 'TERM': 'linux', 18:26:10 INFO - 'TMOUT': '86400', 18:26:10 INFO - 'USER': 'cltbld', 18:26:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:10 INFO - '_': '/tools/buildbot/bin/python'} 18:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:10 INFO - Running setup.py (path:/tmp/pip-LRW91s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:10 INFO - Running setup.py (path:/tmp/pip-nlMBPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:10 INFO - Running setup.py (path:/tmp/pip-x4XZ5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:10 INFO - Running setup.py (path:/tmp/pip-YFt4zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:10 INFO - Running setup.py (path:/tmp/pip-WBLSbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:10 INFO - Running setup.py (path:/tmp/pip-Ierstf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:10 INFO - Running setup.py (path:/tmp/pip-SY1c2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:11 INFO - Running setup.py (path:/tmp/pip-wA7sKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:11 INFO - Running setup.py (path:/tmp/pip-ZV9J8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:11 INFO - Running setup.py (path:/tmp/pip-Ced8o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:11 INFO - Running setup.py (path:/tmp/pip-eyAymS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:11 INFO - Running setup.py (path:/tmp/pip-TWtM5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:11 INFO - Running setup.py (path:/tmp/pip-Up1LHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:11 INFO - Running setup.py (path:/tmp/pip-HdRZHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:11 INFO - Running setup.py (path:/tmp/pip-KYRILl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:11 INFO - Running setup.py (path:/tmp/pip-H6jCco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:11 INFO - Running setup.py (path:/tmp/pip-C_l3QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:26:11 INFO - Running setup.py install for manifestparser 18:26:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:26:11 INFO - Running setup.py install for mozcrash 18:26:11 INFO - Running setup.py install for mozdebug 18:26:12 INFO - Running setup.py install for mozdevice 18:26:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Running setup.py install for mozfile 18:26:12 INFO - Running setup.py install for mozhttpd 18:26:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Running setup.py install for mozinfo 18:26:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Running setup.py install for mozInstall 18:26:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Running setup.py install for mozleak 18:26:12 INFO - Running setup.py install for mozlog 18:26:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Running setup.py install for moznetwork 18:26:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:26:12 INFO - Running setup.py install for mozprocess 18:26:12 INFO - Running setup.py install for mozprofile 18:26:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:26:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:26:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:26:13 INFO - Running setup.py install for mozrunner 18:26:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:26:13 INFO - Running setup.py install for mozscreenshot 18:26:13 INFO - Running setup.py install for moztest 18:26:13 INFO - Running setup.py install for mozversion 18:26:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:26:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:26:13 INFO - Cleaning up... 18:26:13 INFO - Return code: 0 18:26:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:13 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 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:26:13 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 18:26:13 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 18:26:13 INFO - Using env: {'DISPLAY': ':0', 18:26:13 INFO - 'HOME': '/home/cltbld', 18:26:13 INFO - 'LANG': 'en_US.UTF-8', 18:26:13 INFO - 'LANGUAGE': 'en_US:en', 18:26:13 INFO - 'LOGNAME': 'cltbld', 18:26:13 INFO - 'MAIL': '/var/mail/cltbld', 18:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:13 INFO - 'MOZ_NO_REMOTE': '1', 18:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:13 INFO - 'NO_EM_RESTART': '1', 18:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:13 INFO - 'PWD': '/builds/slave/test', 18:26:13 INFO - 'SHELL': '/bin/bash', 18:26:13 INFO - 'SHLVL': '1', 18:26:13 INFO - 'TERM': 'linux', 18:26:13 INFO - 'TMOUT': '86400', 18:26:13 INFO - 'USER': 'cltbld', 18:26:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:13 INFO - '_': '/tools/buildbot/bin/python'} 18:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:13 INFO - Running setup.py (path:/tmp/pip-EUvpoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:13 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)) 18:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:13 INFO - Running setup.py (path:/tmp/pip-QnEhYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:13 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)) 18:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:13 INFO - Running setup.py (path:/tmp/pip-fzPSEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:13 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)) 18:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:13 INFO - Running setup.py (path:/tmp/pip-KadBQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:14 INFO - Running setup.py (path:/tmp/pip-ohjqzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:14 INFO - Running setup.py (path:/tmp/pip-ELScl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:14 INFO - Running setup.py (path:/tmp/pip-XPVkVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:14 INFO - Running setup.py (path:/tmp/pip-RSdwpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:14 INFO - Running setup.py (path:/tmp/pip-ua4VK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:14 INFO - Running setup.py (path:/tmp/pip-yRfKba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:14 INFO - Running setup.py (path:/tmp/pip-Hre6zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:14 INFO - Running setup.py (path:/tmp/pip-H7aEvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:14 INFO - Running setup.py (path:/tmp/pip-rlv2xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:14 INFO - Running setup.py (path:/tmp/pip-F1NUql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:14 INFO - Running setup.py (path:/tmp/pip-UxEJXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:14 INFO - Running setup.py (path:/tmp/pip-dvueDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:14 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)) 18:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:14 INFO - Running setup.py (path:/tmp/pip-vuCpMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:14 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)) 18:26:14 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)) 18:26:14 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)) 18:26:14 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)) 18:26:14 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)) 18:26:14 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)) 18:26:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26: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 18:26:17 INFO - Downloading blessings-1.6.tar.gz 18:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:26:17 INFO - Installing collected packages: blessings 18:26:17 INFO - Running setup.py install for blessings 18:26:17 INFO - Successfully installed blessings 18:26:17 INFO - Cleaning up... 18:26:17 INFO - Return code: 0 18:26:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:17 INFO - Reading from file tmpfile_stdout 18:26:17 INFO - Current package versions: 18:26:17 INFO - argparse == 1.2.1 18:26:17 INFO - blessings == 1.6 18:26:17 INFO - blobuploader == 1.2.4 18:26:17 INFO - docopt == 0.6.1 18:26:17 INFO - functools32 == 3.2.3-2 18:26:17 INFO - jsonschema == 2.5.1 18:26:17 INFO - manifestparser == 1.1 18:26:17 INFO - mozInstall == 1.12 18:26:17 INFO - mozcrash == 1.0 18:26:17 INFO - mozdebug == 0.1 18:26:17 INFO - mozdevice == 0.49 18:26:17 INFO - mozfile == 1.2 18:26:17 INFO - mozhttpd == 0.7 18:26:17 INFO - mozinfo == 0.9 18:26:17 INFO - mozleak == 0.1 18:26:17 INFO - mozlog == 3.4 18:26:17 INFO - moznetwork == 0.27 18:26:17 INFO - mozprocess == 0.24 18:26:17 INFO - mozprofile == 0.28 18:26:17 INFO - mozrunner == 6.13 18:26:17 INFO - mozscreenshot == 0.1 18:26:17 INFO - mozsystemmonitor == 0.3 18:26:17 INFO - moztest == 0.8 18:26:17 INFO - mozversion == 1.4 18:26:17 INFO - psutil == 3.1.1 18:26:17 INFO - requests == 1.2.3 18:26:17 INFO - wsgiref == 0.1.2 18:26:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:17 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 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:26:17 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 18:26:17 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 18:26:17 INFO - Using env: {'DISPLAY': ':0', 18:26:17 INFO - 'HOME': '/home/cltbld', 18:26:17 INFO - 'LANG': 'en_US.UTF-8', 18:26:17 INFO - 'LANGUAGE': 'en_US:en', 18:26:17 INFO - 'LOGNAME': 'cltbld', 18:26:17 INFO - 'MAIL': '/var/mail/cltbld', 18:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:17 INFO - 'MOZ_NO_REMOTE': '1', 18:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:17 INFO - 'NO_EM_RESTART': '1', 18:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:17 INFO - 'PWD': '/builds/slave/test', 18:26:17 INFO - 'SHELL': '/bin/bash', 18:26:17 INFO - 'SHLVL': '1', 18:26:17 INFO - 'TERM': 'linux', 18:26:17 INFO - 'TMOUT': '86400', 18:26:17 INFO - 'USER': 'cltbld', 18:26:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:17 INFO - '_': '/tools/buildbot/bin/python'} 18:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 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)) 18:26:17 INFO - Cleaning up... 18:26:17 INFO - Return code: 0 18:26:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1001630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, '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': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', '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 18:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:26:17 INFO - Using env: {'DISPLAY': ':0', 18:26:17 INFO - 'HOME': '/home/cltbld', 18:26:17 INFO - 'LANG': 'en_US.UTF-8', 18:26:17 INFO - 'LANGUAGE': 'en_US:en', 18:26:17 INFO - 'LOGNAME': 'cltbld', 18:26:17 INFO - 'MAIL': '/var/mail/cltbld', 18:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:17 INFO - 'MOZ_NO_REMOTE': '1', 18:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:17 INFO - 'NO_EM_RESTART': '1', 18:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:17 INFO - 'PWD': '/builds/slave/test', 18:26:17 INFO - 'SHELL': '/bin/bash', 18:26:17 INFO - 'SHLVL': '1', 18:26:17 INFO - 'TERM': 'linux', 18:26:17 INFO - 'TMOUT': '86400', 18:26:17 INFO - 'USER': 'cltbld', 18:26:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:17 INFO - '_': '/tools/buildbot/bin/python'} 18:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:26:17 INFO - Cleaning up... 18:26:17 INFO - Return code: 0 18:26:17 INFO - Running post-action listener: _resource_record_post_action 18:26:17 INFO - Running post-action listener: _start_resource_monitoring 18:26:17 INFO - Starting resource monitoring. 18:26:17 INFO - [mozharness: 2017-01-11 02:26:17.968920Z] Finished create-virtualenv step (success) 18:26:17 INFO - [mozharness: 2017-01-11 02:26:17.969438Z] Running install step. 18:26:17 INFO - Running pre-action listener: _resource_record_pre_action 18:26:17 INFO - Running main action method: install 18:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:18 INFO - Reading from file tmpfile_stdout 18:26:18 INFO - Detecting whether we're running mozinstall >=1.0... 18:26:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:26:18 INFO - Reading from file tmpfile_stdout 18:26:18 INFO - Output received: 18:26:18 INFO - Usage: mozinstall [options] installer 18:26:18 INFO - Options: 18:26:18 INFO - -h, --help show this help message and exit 18:26:18 INFO - -d DEST, --destination=DEST 18:26:18 INFO - Directory to install application into. [default: 18:26:18 INFO - "/builds/slave/test"] 18:26:18 INFO - --app=APP Application being installed. [default: firefox] 18:26:18 INFO - mkdir: /builds/slave/test/build/application 18:26:18 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'] 18:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:26:34 INFO - Reading from file tmpfile_stdout 18:26:34 INFO - Output received: 18:26:34 INFO - /builds/slave/test/build/application/firefox/firefox 18:26:34 INFO - Running post-action listener: _resource_record_post_action 18:26:34 INFO - [mozharness: 2017-01-11 02:26:34.393783Z] Finished install step (success) 18:26:34 INFO - [mozharness: 2017-01-11 02:26:34.394061Z] Running run-tests step. 18:26:34 INFO - Running pre-action listener: _resource_record_pre_action 18:26:34 INFO - Running main action method: run_tests 18:26:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:26:34 INFO - Python 2.7.3 18:26:34 INFO - Return code: 0 18:26:34 INFO - grabbing minidump binary from tooltool 18:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:34 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 0x108a850>, '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 0xfff6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfffb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:26:34 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 18:26:34 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 18:26:34 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 18:26:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:26:34 INFO - Return code: 0 18:26:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:26:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:26:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:26:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:26:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:26:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 18:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 18:26:34 INFO - Using env: {'DISPLAY': ':0', 18:26:34 INFO - 'HOME': '/home/cltbld', 18:26:34 INFO - 'LANG': 'en_US.UTF-8', 18:26:34 INFO - 'LANGUAGE': 'en_US:en', 18:26:34 INFO - 'LOGNAME': 'cltbld', 18:26:34 INFO - 'MAIL': '/var/mail/cltbld', 18:26:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:34 INFO - 'MOZ_NO_REMOTE': '1', 18:26:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:34 INFO - 'NO_EM_RESTART': '1', 18:26:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:34 INFO - 'PWD': '/builds/slave/test', 18:26:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:34 INFO - 'SHELL': '/bin/bash', 18:26:34 INFO - 'SHLVL': '1', 18:26:34 INFO - 'TERM': 'linux', 18:26:34 INFO - 'TMOUT': '86400', 18:26:34 INFO - 'USER': 'cltbld', 18:26:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1484101538.131696-37847782', 18:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:34 INFO - '_': '/tools/buildbot/bin/python'} 18:26:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 18:26:34 INFO - mozversion application_buildid: 20170111015654 18:26:34 INFO - mozversion application_changeset: b079c9833e3ed047e1b984e26b8d62d739baa40b 18:26:34 INFO - mozversion application_display_name: Nightly 18:26:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:26:34 INFO - mozversion application_name: Firefox 18:26:34 INFO - mozversion application_remotingname: firefox 18:26:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:26:34 INFO - mozversion application_vendor: Mozilla 18:26:34 INFO - mozversion application_version: 53.0a1 18:26:34 INFO - mozversion platform_buildid: 20170111015654 18:26:34 INFO - mozversion platform_changeset: b079c9833e3ed047e1b984e26b8d62d739baa40b 18:26:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:26:34 INFO - mozversion platform_version: 53.0a1 18:26:34 INFO - using testdate: 1484101594 18:26:34 INFO - actual date: 1484101594 18:26:34 INFO - starting webserver on 'localhost:59086' 18:26:34 INFO - SUITE-START | Running 2 tests 18:26:34 INFO - TEST-START | dromaeo_css 18:26:34 INFO - operating with platform_type : linux_ 18:26:34 INFO - Initialising browser for dromaeo_css test... 18:26:34 INFO - TEST-INFO | started process 13875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7OwzFe/profile http://localhost:59086/getInfo.html) 18:26:38 INFO - PROCESS | 13875 | __metrics Screen width/height:1600/1200 18:26:38 INFO - PROCESS | 13875 | colorDepth:24 18:26:38 INFO - PROCESS | 13875 | Browser inner width/height: 1024/697 18:26:38 INFO - PROCESS | 13875 | __metrics 18:26:38 INFO - PROCESS | 13875 | 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" 18:26:38 INFO - PROCESS | 13875 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:26:38 INFO - PROCESS | 13875 | console.error: PushService: 18:26:38 INFO - PROCESS | 13875 | stateChangeProcessEnqueue: Error transitioning state 18:26:38 INFO - PROCESS | 13875 | UnknownError 18:26:39 INFO - TEST-INFO | 13875: exit 0 18:26:39 INFO - Browser initialized. 18:26:39 INFO - Running cycle 1/1 for dromaeo_css test... 18:26:39 INFO - TEST-INFO | started process 13957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7OwzFe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:51 INFO - PROCESS | 13957 | RSS: Main: 151810048 18:26:51 INFO - PROCESS | 13957 | 18:29:57 INFO - PROCESS | 13957 | Cycle 1(1): loaded http://localhost:59086/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59086/tests/dromaeo/cssquery-ext.html) 18:29:59 INFO - PROCESS | 13957 | RSS: Main: 275251200 18:29:59 INFO - PROCESS | 13957 | 18:31:39 INFO - PROCESS | 13957 | ************************* 18:31:39 INFO - PROCESS | 13957 | A coding exception was thrown and uncaught in a Task. 18:31:39 INFO - PROCESS | 13957 | 18:31:39 INFO - PROCESS | 13957 | Full message: ReferenceError: fetch is not defined 18:31:39 INFO - PROCESS | 13957 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 18:31:39 INFO - PROCESS | 13957 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 18:31:39 INFO - PROCESS | 13957 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 18:31:39 INFO - PROCESS | 13957 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 18:31:39 INFO - PROCESS | 13957 | TaskImpl@resource://gre/modules/Task.jsm:277:3 18:31:39 INFO - PROCESS | 13957 | asyncFunction@resource://gre/modules/Task.jsm:252:14 18:31:39 INFO - PROCESS | 13957 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 18:31:39 INFO - PROCESS | 13957 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 18:31:39 INFO - PROCESS | 13957 | TaskImpl@resource://gre/modules/Task.jsm:277:3 18:31:39 INFO - PROCESS | 13957 | asyncFunction@resource://gre/modules/Task.jsm:252:14 18:31:39 INFO - PROCESS | 13957 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 18:31:39 INFO - PROCESS | 13957 | 18:31:39 INFO - PROCESS | 13957 | ************************* 18:33:01 INFO - PROCESS | 13957 | Cycle 1(1): loaded http://localhost:59086/tests/dromaeo/cssquery-ext.html (next: http://localhost:59086/tests/dromaeo/cssquery-jquery.html) 18:33:02 INFO - PROCESS | 13957 | RSS: Main: 250294272 18:33:02 INFO - PROCESS | 13957 | 18:36:04 INFO - PROCESS | 13957 | Cycle 1(1): loaded http://localhost:59086/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59086/tests/dromaeo/cssquery-mootools.html) 18:36:05 INFO - PROCESS | 13957 | RSS: Main: 185528320 18:36:05 INFO - PROCESS | 13957 | 18:39:07 INFO - PROCESS | 13957 | Cycle 1(1): loaded http://localhost:59086/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59086/tests/dromaeo/cssquery-prototype.html) 18:39:08 INFO - PROCESS | 13957 | RSS: Main: 230125568 18:39:08 INFO - PROCESS | 13957 | 18:42:11 INFO - PROCESS | 13957 | Cycle 1(1): loaded http://localhost:59086/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59086/tests/dromaeo/cssquery-yui.html) 18:42:12 INFO - PROCESS | 13957 | RSS: Main: 187170816 18:42:12 INFO - PROCESS | 13957 | 18:45:15 INFO - PROCESS | 13957 | Cycle 1(1): loaded http://localhost:59086/tests/dromaeo/cssquery-yui.html (next: http://localhost:59086/tests/dromaeo/cssquery-dojo.html) 18:45:15 INFO - PROCESS | 13957 | RSS: Main: 276328448 18:45:15 INFO - PROCESS | 13957 | 18:45:15 INFO - PROCESS | 13957 | __start_tp_report 18:45:15 INFO - PROCESS | 13957 | _x_x_mozilla_page_load 18:45:15 INFO - PROCESS | 13957 | _x_x_mozilla_page_load_details 18:45:15 INFO - PROCESS | 13957 | |i|pagename|runs| 18:45:15 INFO - PROCESS | 13957 | |0;dojo.html;2602.310387747247;2628.7896968242544;2632.4998250332437;2634.2492389668946;2644.6694163229595;4674.4624368197665;4697.436307643079;4812.302216178657;4828.7585620718955;4839.4918533553955;4771.737554434505;4773.06925149596;4812.687175333601;4842.903141937168;4898.363212782342;4344.109457561192;4379.627731642814;4386.714863533876;4472.396226509412;4540.727556346614;4027.7986100694993;4374.97812510937;4405.86782396527;4433.290673492242;4503.076869241798;4344.89137771555;4369.235383807821;4470.597646211857;4478.686491945565;4522.5025247222775;4330.198913201068;4358.782060896942;4383.9342409863875;4403.64770818337;4432.822687092513;4346;4350.195213885441;4384.145091707119;4400.339949007643;4403.229434848889;4688.624910007191;4716.787744551469;4720.3863497745415;4725.740084295362;4773.403324584427;4965.180745177042;5009.599232061426;5059.06407314648;5059.468755780626;5070;5130.71781052042;5179.637425380225;5180.248863914749;5201.895962080737;5232.372115346145;4842.685225460334;4845.927311090337;4847.175980083394;4848.660593758403;4897.4857639947295;5153.974230128825;5205.973970130125;5271.973640131851;5281.656692314988;5286.524212820865;5008.198688209942;5052.873678158076;5053.9747301264;5059.8988020239385;5060.190369540929;5121.052605268037;5127.9230811537855;5128.25640282157;5128.640995130379;5133.666311689728;5068.6451948363265;5110.182370820651;5114.565261952701;5115.7442127893455;5123.538881500683;5096.388433387943;5103.413107492612;5107.157319042391;5109.693418394908;5115.360579927509;4280.486341638961;4295.119500502389;4312.05134870328;4315.697901146889;4321.351797230441;3745.382011968049;3747.2130852521277;3750.7937063461773;3781.4516895050065;3808.1050953026015;4475.7985890635;4481.305397663367;4486.641068714495;4523.84166554169;4526.162659907927;4993.27597498368;5030.547250747451;5038.420581633086;5088.0587091388215;5179.896402071938;4421.46942366918;4424.11517696462;4444.955550444454;4465.441819772528;4466.932996005063;4565.657575681837;4573.611243044378;4576.565226303496;4581.816727330869;4621.260598304255;4666.323383109498;4689.835855745033;4778.33103365536;4806.255030470283;4815.2054910939305;5039.84880453587;5172;5174.379074510932;5204.8178313758835;5230.241614965885;4814.927776083291;4819.831305904277;4826.782794774173;4837.443693975097;4874.561289483963;4953.826616068564;4959.156943319716;5072.695638261716;5075.949240507548;5122.948770512247;5045.117104506623;5071.670341427795;5093.134167191661;5125.79496820138;5162.122439185272;4866.29438731389;4966.701997880139;4975.800967961241;4981.178105612534;5021.472745361831;4896.020795840775;4965.577925876341;4965.702057876539;4965.925511117408;4966.155753521838;4894.143524883202;4895.363602731622;4926.531979461945;4935.531124543163;4937.185364414831;4993.6254780892305;5000.899982000413;5001.124803159505;5003.624728145331;5019.472955339783;4897.8285759998225;4916.434610019894;4919.7540122993;4943.876403089952;4959.851204463872 18:45:15 INFO - PROCESS | 13957 | |1;ext.html;545.5144921020291;546.8878879829634;561.8651523634329;566.3373852592466;572.5248044123379;29244.415111697752;38445.80777096114;40412.79793601035;40424.19151616966;44791;42222.788886055605;42672.35991460131;42695.3595696064;42704.78647606765;42733.35899961495;7576.621168941545;7777.650005749755;7782.610869456533;7788.532688038736;7797.298243158115;7228.638568071602;7428.442866784986;9969.50152492376;10240.590376384936;10279.22460935547;10078.294519383646;10150.137238334713;10150.898491015107;10158.898411015869;10175.084242418181;10073.093421592055;10137.493125343703;10140.087392134743;10146.84779728301;10149.797004059878;9911.10800028001;9985.800283994353;9989.300748947577;9993.050660187271;9995.650152244636;39329.60670393288;39615;39633.801830990946;39639.40540891889;39686.20627587432;3336.7497437692027;3343.114074770188;3354.630990591033;3377.4089534331392;3417.4361230396953;29269.707302926912;29792.702072979428;29884.701152988408;29894.103176904726;29942.251443713863;3473.940448163309;3485.9651403485896;3490.930181396358;3528.576570811493;3674.52231209941;180062;180523;181045;181473.18526814695;182842;54953.72523137439;55374.44625553773;55383;55432;55432;56434.717826410604;56444.71777641168;56451.71774141103;56515;56533.410650816484;14307.070040447337;14586.41654333836;14602.634934126732;14603.853961460249;14609;10003;10285.897141028494;10905.563777448971;11003.889961100287;11044.33733975964;15227.771583426258;15403.306851191723;15414.383424662889;16865.91567042157;17381.391651292142;5697.971510142423;6105.755769769248;6148.262208534915;6192.256929168529;6221.906671399933;807.5235610989427;842.6081871929459;868.383447752103;881.722257488889;883.2095274729081;25890.482190356088;27871.72128278732;27930.860345698547;28009.859950700524;28220.576691349645;958.0946006024379;959.9376040557341;960.3805545423163;963.8795150606175;965.888922773876;13943.930280348533;14503.419863205354;14746.336414861356;14884.925575372054;14924.701505970037;141661.29169354087;364044;368584;368621;523456;39996.20007599832;41208;43457.78271108624;44577.33134002992;45086.54913450889;1281.826953361303;1282.6857419932176;1285.3252042677668;1290.0582574720695;1297.7599144158362;25466;25871.223863284133;26556.601650974866;26585.601215982162;26853;38403.615963840006;39011.60988390193;39043;39045.80477097596;39140.804295978334;286575;287119;287127;287707;287782;23174.1889033883;23343.41641458977;23452.413689657897;23695.52608947846;23704.170354037527;31638.683613163576;32785.672143278265;35176.43595871149;36103.27793444169;36400.27199456049;32365;37247;38241.617583823805;38512.22975540529;39096.41355379728;37210.25579488449;37233;38022;38300;42032.36951445792;37248.62751372452;37277.4408383869;37306.25387492289;37815;38336.42495362627;31500.684993149775;34290.48564271488;34479.13802154966;34494.48258276078;34536.82731586326;25974;26006.219813405627;26104.216873493824;26131.34671633148;26237.606435903093 18:45:15 INFO - PROCESS | 13957 | |2;jquery.html;370.18743857233386;379.38350180955945;388.4639197906887;394.0424767814211;416.5459648982608;13288.269145197022;14653.413863445463;17673.20470578827;17679.469615911512;17711.114444277766;16856;17595.296188152457;17620.21165449428;18502.629947401078;18580.721289180674;3766.491523644314;4776.641751868607;4907.288443175756;4910;4913.82801601944;3833.3291673956946;3913.8434462621462;3916.921661566767;4707.670463067587;5652.830415087554;5646.378898321182;5695.0318445864095;5735.827925162252;5753.942460575404;5756.510696590794;5491.093969495068;5534.640248383842;5567.747256867213;5569.498745112939;5578.888422231533;5341.572674186055;5496.367917689477;5503.284573005523;5504.394516603171;5530.668159910378;12794.360281985864;12823.87176128236;12842;12930.224186548838;12950.805737913939;2203.118752499013;2231.2596174983537;2238.183063181943;2392.497575509145;2527.2670925431603;8988.191062804379;9229;9677.080677335642;9856.408615483095;9857.408555486694;1634.1665750467348;1715.4510556621885;1719.4497760716577;1745;1758.3230456274298;66676.66661666661;68455.9999999995;77703.61148194279;78580.60709696473;78651.99999999943;9731.610735570497;9736.805263894683;9961.601535938626;10061.245406594535;10135.655233772837;13323.13399629021;13329;13330.666733331744;13343.466261349437;13348.532801351907;7074.080369552028;7209.96395018032;7227.771278882603;7352.485326027127;7425.591592462466;6923.861522769516;6956.860862782817;7189.84962406023;7198.244184360671;7233.746818861315;4060.6548443382053;4116.1767646470225;4144.958550414457;4214.431051808028;4259.233337999128;1834.7431359609666;1895.6303520813585;1903.581831535515;1908.961820763577;1969.399333203358;814.3281792521194;839.4837175137369;840.8990921089509;848.9490630562186;869.4870026684287;17618.735718964224;18190.727139092924;18563.535911602317;18779.624407511772;18915;833;846.6951897316961;847.2586486824028;847.7456762971208;862.3360012790116;10238.385696858213;10342.844857327145;10343.27597068213;10347.586096556204;10396.740081498023;475604;481295;482415;483454;483486;79986.20013799788;83562.58218708867;99442;100895.49552252192;101793.49103254436;941.1717688434134;969.9030096990385;1013.0477351289765;1013.3565186106875;1015.5633077776479;15807.446739364066;16248.3500659977;16567;16778.986521617484;16987.065711385498;38233.4264986031;38729.806350968065;38974.41538376983;38979.2204155921;39831.80084099561;52558.47441525689;55036.72481637566;55126.173107404225;57225.71387143037;57655.1351729716;6903.689333979883;6944.965275173592;7091.397231235403;7120.287971202838;7210.495265331377;7949.5463465542625;8526.616302266537;11069.5018724156;11267.436628168723;11760.82358764602;9525.904740952501;9872.605095796087;9905.554250058909;9951;10466.529006194587;9789.118979291898;10016.198704103508;10020.899791001997;10066.949665251626;10357.378557286587;9905.108540231413;9912.553935072794;9989.750256243651;10137.493125343852;10294.536745846604;7189.209186989531;7254.383377412979;7354.4187999580345;7409.592472414069;7519.172890982097;8383.329333653415;9372.39079459833;9517.619295228113;9719.514024298614;9932.751681208028 18:45:15 INFO - PROCESS | 13957 | |3;mootools.html;1364.6868557794542;1373.306480227485;1375.2229990055619;1399.3213291553595;1400.4538230090263;6792.2868098849585;7192.532485388446;7200.495965282433;7200.711971521133;7214.134303883535;6129.969350153243;6297.842553936154;6619.900701489481;6781.932180678192;6812.863742725142;2019.4446527205062;2054;2056.393363957636;2056.876587404753;2057.6193404220194;1954.6188493243824;2052.1586149678633;2061.7525896892394;2063.907124179408;2071.1404767021745;1800.1899145384564;1856.3224423085612;1973.8322242609395;2022.4640470275315;2052.8152466278034;2057.238821635989;2057.331367305617;2060.526079001823;2065.1532871522754;2069.555045665174;1959.9608007839906;1975.140813746025;1977.8417726581838;1980.9405717828488;2042.0606521000357;7253.7098516059295;7310.597917114556;7314.853702925911;7321.084864391951;7321.231270716605;4182.2890108681595;4299.849505267332;4309.676774241944;4309.82760689572;4316.438862947797;2600.2199340197867;2699.6625421822273;2745.3136715821047;2816.1270006298114;2818.1545536339017;1010.1817527802503;1061.241212533035;1072.9892701072968;1092.180864351736;1151.1423989128152;9526.714198574055;9607.231421486335;9616.75958101039;9617.759556011086;9651;3618.565772107364;3719.888403347904;3898.4152377143087;3946.467226924386;3967.583403742623;8254.380921430917;8269.09040005599;8327.541985190872;8351.20663536963;8355.331573474108;4174.666026717855;4186.476690413699;4186.748795072305;4188;4193.496780386373;3725.1432170600915;3812.6187381262207;3831.8275677594575;3856.2865869814173;3857.9421308680394;3384.4584866421255;3387.7120444762472;3458.5849698036395;3488.162840918212;3596.3886139356373;1142.0806250967885;1165.5687395663658;1167.9240849344935;1168.3749194181241;1171.566520387462;657.3886285754198;679.7722762874394;686.0738003694972;689.0009486244965;766.0080196146005;4583.72497650142;4609.723416595015;4662.813487460531;4767.118083154627;4807.78364973577;899.9415038022507;934.1359242700474;936.4240991790136;941.6468824190929;949.4540639132526;3056.49567821307;3302.1744563859033;3308.9172770680925;3325.584301962255;3395.2530443302435;8230.259276665129;8408.201220884006;8471.237588617054;8530.104339044436;8539.530325832015;8392.4544904581;8413.70552030676;8417.242448179572;8417.663293468315;8446.83106337882;6307.463865571386;6602.537822352485;6756.763513277012;6757.425618822357;6761.628110453972;4855.344528488608;4924.4090709115135;4964.851054468371;5073.2897394365555;5094;7645.808854778675;7737.226277372218;7743.2643898831775;7881.84236315259;7934.682612695427;8018.719344822904;8029.919700802917;8033.879491807511;8089.797755055935;8116;6093.969530152498;6151.815445536641;6154.1999540059505;6222.595531290452;6224.319433752952;6688.598684078971;6732.966335168293;6734.663266836541;6736.865262694817;6739.831504212434;5902.38025007368;5972.163897054329;6039.214902062704;6124.173236613;6126.050462178369;6121.602095863755;6157.014877619559;6157.014877619559;6165.599236049642;6183.072539119168;5416.9729151353995;5506.972465137648;5514.117741161395;5522.447755224445;5527.143292789624;4238.766867822299;4248.87253382399;4266.402703621434;4302.483701955785;4391.5827996340295;4332.501762297376;4360.738355698668;4394.406755088022;4469.798859051415;4551.908961820679 18:45:15 INFO - PROCESS | 13957 | |4;prototype.html;330.4448526475523;348.372928728289;361.50654356802966;361.622104900379;369.79845983938753;4565.315202719589;4688;4733.384659994204;4783.832565860195;4814.085323788478;4641.953580464195;4648.282899331782;4652.441706995157;4708.52914708529;4731.952680473194;3863.6715879150165;3881.146147847476;3921.2549615573093;3930.390789427629;3939.0546268895546;3751.5685696144883;3831.854161669474;3841.519810023747;3854.2869569129803;3934.3705007198855;3730.403135498321;3873;3875.670568001723;3879.478339079593;3890.708196885231;3862.806859657006;3866.163572303162;3869.535655721303;3875.399313106473;3877.5540812806607;3353.9038101186757;3539.1859872229275;3544.291141771656;3554.9111272218142;3570.4822800694014;4369.584889435499;4619.399478067863;4628.282616194495;4636.658487463843;4643.442786865564;4377.212101821703;4389.473263208435;4392.209402307583;4422.668299877522;4426.756528390937;4971.751412429364;4972.254161875711;4988.634944423629;5009.12340340439;5014.84955451337;3664.5052917856015;3829.272438236754;3838.2707285615643;3846.230753849213;3869.941950870739;5183.2743415921805;5194.714325696681;5210.244514545369;5215.504527069922;5216.921746173811;3941.2117576484816;3947.5460322062754;3965.1673148638533;3981.7212795104065;3991.501062367204;3825.8660946866726;4003.7197396181987;4036.0515278909434;4037.9394309085387;4046.785964210725;4190.53904070552;4267.103908179255;4286.335617979156;4395.824167033346;4418.425604671372;5000.424951130666;5009.470217540192;5014.222795466709;5025.4974502550185;5043.2687260347775;1342.5972208337655;1348.676317683749;1351.6012776231034;1355.4480120262244;1360.7550640884538;887.5163036145187;932.2681694869494;938.0666237094135;997.670768646345;1006.0241565681278;4220.8895552223885;4226.427904608364;4239.47006624172;4240.533541310453;4250.723702959298;4944.826931057468;4960.801567937314;4974.452810190876;4982.7259500727805;4992.875178120504;4095.3808259017833;4216.894577635584;4245.724027938236;4294.677899157576;4310.181065597527;2662.427578070724;2668.93327666806;2672.9041093151714;2675.8394496330284;2678.0626780626626;4658.394408726912;4687.312567475706;4701.576858082789;4714.669973101919;4719.5458361651745;4983.6013118950395;5079.568236699848;5085.694858308513;5168.793248270103;5196.714180720097;4839.201531747292;4846.39420072491;4850.781714822841;4858.8785280367565;4874.122657921537;5116.155834287301;5131.307273518028;5135.666181698327;5136.948630513647;5138.177891537336;4866.926996095132;5024.145895197752;5067.619928505451;5077.796888124433;5085.389753229636;4839.951600484091;4847.103285892122;4847.927281090716;4849.854504364875;4861.611071114373;3649.5985441601933;3668.4687565579666;3670.9816450917574;3676.264747050547;3690.317291301118;4829.927551086666;5145.3568303962;5152.5620322271525;5167.741612919414;5174.637775355689;4639.350490931205;4882.170031094794;4943.950560494349;5002.274670172877;5017.899642007066;4921.655484116221;4978.2034874419915;4993.201087825931;5008.248762685626;5015.620704306199;4804.73573953422;4850.668492987568;4860.635452341018;4911.778969946289;4915.827946022016;4964.67729597575;4980.452150263541;4986.952739924656;4990.426100998432;5002.87492812668;4892.510748925079;4902.8774280643265;4906.190478570996;4907.141250281115;4909.62530491463 18:45:15 INFO - PROCESS | 13957 | |5;yui.html;566.0885973582534;590.477427476683;689.5242282824851;764.7935057534465;776.6815605601704;12200;13455.46178152874;13469.797953030713;13490.999999999987;13492.66268343292;13274;13298.800517992213;13350.332483375842;13353.866461335383;13429.932850335734;657.3262406033806;667.7896462614285;785.3599316557016;802.2819576479062;805.2229598437507;816.14304979771;818.6152508321079;820.4584973917187;820.8399362124388;822.6092606012156;860.1656393298522;861.9051904290554;862.9309655227567;863.5811631358786;863.6890719341033;689.0456717446373;706.9858602827966;828.8135169586855;851.7444766570004;860.6428332242112;628.7296462521114;628.9716962736642;629.0909635576594;629.116091890894;629.3391938464594;13484.797728034087;13605;13619;13622.114562553403;13636.113652612648;12965.35173241334;13006.284654344006;13043.152195107383;13221.338933053405;13270.73458530824;11683.299002059903;11763.470643821049;11927.463264153133;12130.939345303304;12147.210431322024;4118.382242663594;4135.1316223593085;4146.129312844276;4157.272477316457;4185.560516145792;60415.69792151055;61671.38328616746;61958;62665.68667156681;63661.36338636601;10141.442220677785;10358.741031474274;10422.895771042344;10473.214508911862;10535;19599.412017639494;19644.21423143087;19648.21407143698;19653.50866228327;19657.508562286057;6480.416762491304;6570.835729106715;6818.590884546943;6873.862522749517;6891.793246202522;3494.9126271843406;3585.2650206707563;3603.4054381026835;3621.2033352662897;3627.401478755976;2716.307341627872;2765.612814206013;2786.2337857089465;2787.4146429250086;2793.483205606969;473.3751448088559;476.768767147933;477.7873846138435;479.94000749906263;486.8247430924864;474.5017731382104;487.99756001219765;502.69084513024956;572.1132245020202;580.5877826742975;8496;8585;8597.527136007455;8797.428167169113;8876.644934202559;596.4035964035965;599.9190109335184;604.3291945940003;617.4720613875072;632.5098049012053;4084.305668036441;4195.139996300751;4222.155568886235;4275.957240427618;4322.113966636832;67602.32397675961;69741;70893.29106708866;72125;72311.27688723046;62637.68681156565;62716.37283627196;62877;63000;63828.68085659635;54963.72518137384;55265;56683;56837.14744278839;57780.71109644425;7728.806779830549;7952.960235198787;8042.48105305155;8253.298469629908;8525;35190.47214291839;36336.63663363332;36908;37304.94822784773;37813.29548894158;41017.79491102525;41499.7925010373;42910.57089429066;45572.08855822799;47766.52233477621;10844.620438284623;11162.441877906234;11314.660560183207;11609.3614851184;11678.824817627572;13129.935176795221;13426.597202083953;13439.932800335935;13440.663983400493;13528.93235533816;12014.519419223483;12036.082474226596;12273.195467871094;12302.81545776832;13079.476820927057;12325.322107283826;12337.753244935231;12444.81332779991;12798.552050678181;12828.935855320664;12167.695807604881;12433.689157771129;12559.560415385418;13003.219806811621;13156;9798.608055677692;9814.165795907142;9836;10238.232132589937;10351.327163734333;10458.529366178693;10901.672949811518;10921.453927303444;10999.450027498753;11017.944910275397 18:45:15 INFO - PROCESS | 13957 | __end_tp_report 18:45:15 INFO - PROCESS | 13957 | __start_cc_report 18:45:15 INFO - PROCESS | 13957 | _x_x_mozilla_cycle_collect,1337 18:45:15 INFO - PROCESS | 13957 | __end_cc_report 18:45:15 INFO - PROCESS | 13957 | __startTimestamp1484102715409__endTimestamp 18:45:15 INFO - PROCESS | 13957 | 18:45:15 INFO - PROCESS | 13957 | ------- Summary: start ------- 18:45:15 INFO - PROCESS | 13957 | Number of tests: 6 18:45:15 INFO - PROCESS | 13957 | 18:45:15 INFO - PROCESS | 13957 | [#0] dojo.html Cycles:165 Average:4725.14 Median:4866.29 stddev:501.61 (10.3%) stddev-sans-first:474.70 18:45:15 INFO - PROCESS | 13957 | Values: 2602.3 2628.8 2632.5 2634.2 2644.7 4674.5 4697.4 4812.3 4828.8 4839.5 4771.7 4773.1 4812.7 4842.9 4898.4 4344.1 4379.6 4386.7 4472.4 4540.7 4027.8 4375.0 4405.9 4433.3 4503.1 4344.9 4369.2 4470.6 4478.7 4522.5 4330.2 4358.8 4383.9 4403.6 4432.8 4346.0 4350.2 4384.1 4400.3 4403.2 4688.6 4716.8 4720.4 4725.7 4773.4 4965.2 5009.6 5059.1 5059.5 5070.0 5130.7 5179.6 5180.2 5201.9 5232.4 4842.7 4845.9 4847.2 4848.7 4897.5 5154.0 5206.0 5272.0 5281.7 5286.5 5008.2 5052.9 5054.0 5059.9 5060.2 5121.1 5127.9 5128.3 5128.6 5133.7 5068.6 5110.2 5114.6 5115.7 5123.5 5096.4 5103.4 5107.2 5109.7 5115.4 4280.5 4295.1 4312.1 4315.7 4321.4 3745.4 3747.2 3750.8 3781.5 3808.1 4475.8 4481.3 4486.6 4523.8 4526.2 4993.3 5030.5 5038.4 5088.1 5179.9 4421.5 4424.1 4445.0 4465.4 4466.9 4565.7 4573.6 4576.6 4581.8 4621.3 4666.3 4689.8 4778.3 4806.3 4815.2 5039.8 5172.0 5174.4 5204.8 5230.2 4814.9 4819.8 4826.8 4837.4 4874.6 4953.8 4959.2 5072.7 5075.9 5122.9 5045.1 5071.7 5093.1 5125.8 5162.1 4866.3 4966.7 4975.8 4981.2 5021.5 4896.0 4965.6 4965.7 4965.9 4966.2 4894.1 4895.4 4926.5 4935.5 4937.2 4993.6 5000.9 5001.1 5003.6 5019.5 4897.8 4916.4 4919.8 4943.9 4959.9 18:45:15 INFO - PROCESS | 13957 | 18:45:15 INFO - PROCESS | 13957 | [#1] ext.html Cycles:180 Average:43621.30 Median:19352.51 stddev:77048.62 (398.1%) stddev-sans-first:77196.88 18:45:15 INFO - PROCESS | 13957 | Values: 545.5 546.9 561.9 566.3 572.5 29244.4 38445.8 40412.8 40424.2 44791.0 42222.8 42672.4 42695.4 42704.8 42733.4 7576.6 7777.7 7782.6 7788.5 7797.3 7228.6 7428.4 9969.5 10240.6 10279.2 10078.3 10150.1 10150.9 10158.9 10175.1 10073.1 10137.5 10140.1 10146.8 10149.8 9911.1 9985.8 9989.3 9993.1 9995.7 39329.6 39615.0 39633.8 39639.4 39686.2 3336.7 3343.1 3354.6 3377.4 3417.4 29269.7 29792.7 29884.7 29894.1 29942.3 3473.9 3486.0 3490.9 3528.6 3674.5 180062.0 180523.0 181045.0 181473.2 182842.0 54953.7 55374.4 55383.0 55432.0 55432.0 56434.7 56444.7 56451.7 56515.0 56533.4 14307.1 14586.4 14602.6 14603.9 14609.0 10003.0 10285.9 10905.6 11003.9 11044.3 15227.8 15403.3 15414.4 16865.9 17381.4 5698.0 6105.8 6148.3 6192.3 6221.9 807.5 842.6 868.4 881.7 883.2 25890.5 27871.7 27930.9 28009.9 28220.6 958.1 959.9 960.4 963.9 965.9 13943.9 14503.4 14746.3 14884.9 14924.7 141661.3 364044.0 368584.0 368621.0 523456.0 39996.2 41208.0 43457.8 44577.3 45086.5 1281.8 1282.7 1285.3 1290.1 1297.8 25466.0 25871.2 26556.6 26585.6 26853.0 38403.6 39011.6 39043.0 39045.8 39140.8 286575.0 287119.0 287127.0 287707.0 287782.0 23174.2 23343.4 23452.4 23695.5 23704.2 31638.7 32785.7 35176.4 36103.3 36400.3 32365.0 37247.0 38241.6 38512.2 39096.4 37210.3 37233.0 38022.0 38300.0 42032.4 37248.6 37277.4 37306.3 37815.0 38336.4 31500.7 34290.5 34479.1 34494.5 34536.8 25974.0 26006.2 26104.2 26131.3 26237.6 18:45:15 INFO - PROCESS | 13957 | 18:45:15 INFO - PROCESS | 13957 | [#2] jquery.html Cycles:180 Average:27362.34 Median:482934.50 stddev:79494.26 (16.5%) stddev-sans-first:79691.42 18:45:15 INFO - PROCESS | 13957 | Values: 370.2 379.4 388.5 394.0 416.5 13288.3 14653.4 17673.2 17679.5 17711.1 16856.0 17595.3 17620.2 18502.6 18580.7 3766.5 4776.6 4907.3 4910.0 4913.8 3833.3 3913.8 3916.9 4707.7 5652.8 5646.4 5695.0 5735.8 5753.9 5756.5 5491.1 5534.6 5567.7 5569.5 5578.9 5341.6 5496.4 5503.3 5504.4 5530.7 12794.4 12823.9 12842.0 12930.2 12950.8 2203.1 2231.3 2238.2 2392.5 2527.3 8988.2 9229.0 9677.1 9856.4 9857.4 1634.2 1715.5 1719.4 1745.0 1758.3 66676.7 68456.0 77703.6 78580.6 78652.0 9731.6 9736.8 9961.6 10061.2 10135.7 13323.1 13329.0 13330.7 13343.5 13348.5 7074.1 7210.0 7227.8 7352.5 7425.6 6923.9 6956.9 7189.8 7198.2 7233.7 4060.7 4116.2 4145.0 4214.4 4259.2 1834.7 1895.6 1903.6 1909.0 1969.4 814.3 839.5 840.9 848.9 869.5 17618.7 18190.7 18563.5 18779.6 18915.0 833.0 846.7 847.3 847.7 862.3 10238.4 10342.8 10343.3 10347.6 10396.7 475604.0 481295.0 482415.0 483454.0 483486.0 79986.2 83562.6 99442.0 100895.5 101793.5 941.2 969.9 1013.0 1013.4 1015.6 15807.4 16248.4 16567.0 16779.0 16987.1 38233.4 38729.8 38974.4 38979.2 39831.8 52558.5 55036.7 55126.2 57225.7 57655.1 6903.7 6945.0 7091.4 7120.3 7210.5 7949.5 8526.6 11069.5 11267.4 11760.8 9525.9 9872.6 9905.6 9951.0 10466.5 9789.1 10016.2 10020.9 10066.9 10357.4 9905.1 9912.6 9989.8 10137.5 10294.5 7189.2 7254.4 7354.4 7409.6 7519.2 8383.3 9372.4 9517.6 9719.5 9932.8 18:45:15 INFO - PROCESS | 13957 | 18:45:15 INFO - PROCESS | 13957 | [#3] mootools.html Cycles:180 Average:4669.24 Median:4889.88 stddev:2529.47 (51.7%) stddev-sans-first:2524.37 18:45:15 INFO - PROCESS | 13957 | Values: 1364.7 1373.3 1375.2 1399.3 1400.5 6792.3 7192.5 7200.5 7200.7 7214.1 6130.0 6297.8 6619.9 6781.9 6812.9 2019.4 2054.0 2056.4 2056.9 2057.6 1954.6 2052.2 2061.8 2063.9 2071.1 1800.2 1856.3 1973.8 2022.5 2052.8 2057.2 2057.3 2060.5 2065.2 2069.6 1960.0 1975.1 1977.8 1980.9 2042.1 7253.7 7310.6 7314.9 7321.1 7321.2 4182.3 4299.8 4309.7 4309.8 4316.4 2600.2 2699.7 2745.3 2816.1 2818.2 1010.2 1061.2 1073.0 1092.2 1151.1 9526.7 9607.2 9616.8 9617.8 9651.0 3618.6 3719.9 3898.4 3946.5 3967.6 8254.4 8269.1 8327.5 8351.2 8355.3 4174.7 4186.5 4186.7 4188.0 4193.5 3725.1 3812.6 3831.8 3856.3 3857.9 3384.5 3387.7 3458.6 3488.2 3596.4 1142.1 1165.6 1167.9 1168.4 1171.6 657.4 679.8 686.1 689.0 766.0 4583.7 4609.7 4662.8 4767.1 4807.8 899.9 934.1 936.4 941.6 949.5 3056.5 3302.2 3308.9 3325.6 3395.3 8230.3 8408.2 8471.2 8530.1 8539.5 8392.5 8413.7 8417.2 8417.7 8446.8 6307.5 6602.5 6756.8 6757.4 6761.6 4855.3 4924.4 4964.9 5073.3 5094.0 7645.8 7737.2 7743.3 7881.8 7934.7 8018.7 8029.9 8033.9 8089.8 8116.0 6094.0 6151.8 6154.2 6222.6 6224.3 6688.6 6733.0 6734.7 6736.9 6739.8 5902.4 5972.2 6039.2 6124.2 6126.1 6121.6 6157.0 6157.0 6165.6 6183.1 5417.0 5507.0 5514.1 5522.4 5527.1 4238.8 4248.9 4266.4 4302.5 4391.6 4332.5 4360.7 4394.4 4469.8 4551.9 18:45:15 INFO - PROCESS | 13957 | 18:45:15 INFO - PROCESS | 13957 | [#4] prototype.html Cycles:180 Average:4179.97 Median:4655.42 stddev:1156.04 (24.8%) stddev-sans-first:1122.59 18:45:15 INFO - PROCESS | 13957 | Values: 330.4 348.4 361.5 361.6 369.8 4565.3 4688.0 4733.4 4783.8 4814.1 4642.0 4648.3 4652.4 4708.5 4732.0 3863.7 3881.1 3921.3 3930.4 3939.1 3751.6 3831.9 3841.5 3854.3 3934.4 3730.4 3873.0 3875.7 3879.5 3890.7 3862.8 3866.2 3869.5 3875.4 3877.6 3353.9 3539.2 3544.3 3554.9 3570.5 4369.6 4619.4 4628.3 4636.7 4643.4 4377.2 4389.5 4392.2 4422.7 4426.8 4971.8 4972.3 4988.6 5009.1 5014.8 3664.5 3829.3 3838.3 3846.2 3869.9 5183.3 5194.7 5210.2 5215.5 5216.9 3941.2 3947.5 3965.2 3981.7 3991.5 3825.9 4003.7 4036.1 4037.9 4046.8 4190.5 4267.1 4286.3 4395.8 4418.4 5000.4 5009.5 5014.2 5025.5 5043.3 1342.6 1348.7 1351.6 1355.4 1360.8 887.5 932.3 938.1 997.7 1006.0 4220.9 4226.4 4239.5 4240.5 4250.7 4944.8 4960.8 4974.5 4982.7 4992.9 4095.4 4216.9 4245.7 4294.7 4310.2 2662.4 2668.9 2672.9 2675.8 2678.1 4658.4 4687.3 4701.6 4714.7 4719.5 4983.6 5079.6 5085.7 5168.8 5196.7 4839.2 4846.4 4850.8 4858.9 4874.1 5116.2 5131.3 5135.7 5136.9 5138.2 4866.9 5024.1 5067.6 5077.8 5085.4 4840.0 4847.1 4847.9 4849.9 4861.6 3649.6 3668.5 3671.0 3676.3 3690.3 4829.9 5145.4 5152.6 5167.7 5174.6 4639.4 4882.2 4944.0 5002.3 5017.9 4921.7 4978.2 4993.2 5008.2 5015.6 4804.7 4850.7 4860.6 4911.8 4915.8 4964.7 4980.5 4987.0 4990.4 5002.9 4892.5 4902.9 4906.2 4907.1 4909.6 18:45:15 INFO - PROCESS | 13957 | 18:45:15 INFO - PROCESS | 13957 | [#5] yui.html Cycles:180 Average:15419.34 Median:4208.65 stddev:19254.79 (457.5%) stddev-sans-first:19276.50 18:45:15 INFO - PROCESS | 13957 | Values: 566.1 590.5 689.5 764.8 776.7 12200.0 13455.5 13469.8 13491.0 13492.7 13274.0 13298.8 13350.3 13353.9 13429.9 657.3 667.8 785.4 802.3 805.2 816.1 818.6 820.5 820.8 822.6 860.2 861.9 862.9 863.6 863.7 689.0 707.0 828.8 851.7 860.6 628.7 629.0 629.1 629.1 629.3 13484.8 13605.0 13619.0 13622.1 13636.1 12965.4 13006.3 13043.2 13221.3 13270.7 11683.3 11763.5 11927.5 12130.9 12147.2 4118.4 4135.1 4146.1 4157.3 4185.6 60415.7 61671.4 61958.0 62665.7 63661.4 10141.4 10358.7 10422.9 10473.2 10535.0 19599.4 19644.2 19648.2 19653.5 19657.5 6480.4 6570.8 6818.6 6873.9 6891.8 3494.9 3585.3 3603.4 3621.2 3627.4 2716.3 2765.6 2786.2 2787.4 2793.5 473.4 476.8 477.8 479.9 486.8 474.5 488.0 502.7 572.1 580.6 8496.0 8585.0 8597.5 8797.4 8876.6 596.4 599.9 604.3 617.5 632.5 4084.3 4195.1 4222.2 4276.0 4322.1 67602.3 69741.0 70893.3 72125.0 72311.3 62637.7 62716.4 62877.0 63000.0 63828.7 54963.7 55265.0 56683.0 56837.1 57780.7 7728.8 7953.0 8042.5 8253.3 8525.0 35190.5 36336.6 36908.0 37304.9 37813.3 41017.8 41499.8 42910.6 45572.1 47766.5 10844.6 11162.4 11314.7 11609.4 11678.8 13129.9 13426.6 13439.9 13440.7 13528.9 12014.5 12036.1 12273.2 12302.8 13079.5 12325.3 12337.8 12444.8 12798.6 12828.9 12167.7 12433.7 12559.6 13003.2 13156.0 9798.6 9814.2 9836.0 10238.2 10351.3 10458.5 10901.7 10921.5 10999.5 11017.9 18:45:15 INFO - PROCESS | 13957 | -------- Summary: end -------- 18:45:15 INFO - PROCESS | 13957 | 18:45:16 INFO - TEST-INFO | 13957: exit 0 18:45:16 INFO - TEST-OK | dromaeo_css | took 1121604ms 18:45:16 INFO - TEST-START | kraken 18:45:16 INFO - operating with platform_type : linux_ 18:45:16 INFO - Initialising browser for kraken test... 18:45:16 INFO - TEST-INFO | started process 14257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnZw9r1/profile http://localhost:59086/getInfo.html) 18:45:19 INFO - PROCESS | 14257 | __metrics Screen width/height:1600/1200 18:45:19 INFO - PROCESS | 14257 | colorDepth:24 18:45:19 INFO - PROCESS | 14257 | Browser inner width/height: 1024/697 18:45:19 INFO - PROCESS | 14257 | __metrics 18:45:20 INFO - PROCESS | 14257 | 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" 18:45:20 INFO - PROCESS | 14257 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:45:20 INFO - PROCESS | 14257 | console.error: PushService: 18:45:20 INFO - PROCESS | 14257 | stateChangeProcessEnqueue: Error transitioning state 18:45:20 INFO - PROCESS | 14257 | UnknownError 18:45:21 INFO - TEST-INFO | 14257: exit 0 18:45:21 INFO - Browser initialized. 18:45:21 INFO - Running cycle 1/1 for kraken test... 18:45:21 INFO - TEST-INFO | started process 14342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnZw9r1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:33 INFO - PROCESS | 14342 | RSS: Main: 152514560 18:45:33 INFO - PROCESS | 14342 | 18:45:36 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59086/tests/kraken/driver.html?testName=audio-beat-detection) 18:45:37 INFO - PROCESS | 14342 | RSS: Main: 206127104 18:45:37 INFO - PROCESS | 14342 | 18:45:39 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59086/tests/kraken/driver.html?testName=audio-dft) 18:45:40 INFO - PROCESS | 14342 | RSS: Main: 185466880 18:45:40 INFO - PROCESS | 14342 | 18:45:43 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59086/tests/kraken/driver.html?testName=audio-fft) 18:45:44 INFO - PROCESS | 14342 | RSS: Main: 268439552 18:45:44 INFO - PROCESS | 14342 | 18:45:46 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59086/tests/kraken/driver.html?testName=audio-oscillator) 18:45:46 INFO - PROCESS | 14342 | RSS: Main: 179535872 18:45:46 INFO - PROCESS | 14342 | 18:45:49 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59086/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:45:49 INFO - PROCESS | 14342 | RSS: Main: 182886400 18:45:49 INFO - PROCESS | 14342 | 18:45:52 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59086/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:53 INFO - PROCESS | 14342 | RSS: Main: 222654464 18:45:53 INFO - PROCESS | 14342 | 18:45:56 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59086/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:57 INFO - PROCESS | 14342 | RSS: Main: 216428544 18:45:57 INFO - PROCESS | 14342 | 18:46:00 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59086/tests/kraken/driver.html?testName=json-parse-financial) 18:46:01 INFO - PROCESS | 14342 | RSS: Main: 217350144 18:46:01 INFO - PROCESS | 14342 | 18:46:02 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59086/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:46:03 INFO - PROCESS | 14342 | RSS: Main: 181903360 18:46:03 INFO - PROCESS | 14342 | 18:46:05 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59086/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:46:05 INFO - PROCESS | 14342 | RSS: Main: 189022208 18:46:05 INFO - PROCESS | 14342 | 18:46:08 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59086/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:46:08 INFO - PROCESS | 14342 | RSS: Main: 197689344 18:46:08 INFO - PROCESS | 14342 | 18:46:11 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:46:12 INFO - PROCESS | 14342 | RSS: Main: 201469952 18:46:12 INFO - PROCESS | 14342 | 18:46:15 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:46:15 INFO - PROCESS | 14342 | RSS: Main: 202878976 18:46:15 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | Cycle 1(1): loaded http://localhost:59086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59086/tests/kraken/driver.html?testName=ai-astar) 18:46:17 INFO - PROCESS | 14342 | RSS: Main: 253980672 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | __start_tp_report 18:46:17 INFO - PROCESS | 14342 | _x_x_mozilla_page_load 18:46:17 INFO - PROCESS | 14342 | _x_x_mozilla_page_load_details 18:46:17 INFO - PROCESS | 14342 | |i|pagename|runs| 18:46:17 INFO - PROCESS | 14342 | |0;ai-astar;109;115;116;119;116;114;115;116;116;114 18:46:17 INFO - PROCESS | 14342 | |1;audio-beat-detection;152;125;122;168;129;124;123;124;142;127 18:46:17 INFO - PROCESS | 14342 | |2;audio-dft;161;161;163;162;168;161;163;162;161;161 18:46:17 INFO - PROCESS | 14342 | |3;audio-fft;75;76;76;114;77;76;76;76;91;76 18:46:17 INFO - PROCESS | 14342 | |4;audio-oscillator;84;84;124;85;85;84;101;85;84;108 18:46:17 INFO - PROCESS | 14342 | |5;imaging-gaussian-blur;117;118;117;117;117;117;119;117;118;117 18:46:17 INFO - PROCESS | 14342 | |6;imaging-darkroom;150;149;149;149;148;148;149;150;149;148 18:46:17 INFO - PROCESS | 14342 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 18:46:17 INFO - PROCESS | 14342 | |8;json-parse-financial;61;59;59;59;59;60;60;59;60;60 18:46:17 INFO - PROCESS | 14342 | |9;json-stringify-tinderbox;67;67;67;67;68;67;67;67;68;67 18:46:17 INFO - PROCESS | 14342 | |10;stanford-crypto-aes;85;87;84;92;86;85;91;84;84;84 18:46:17 INFO - PROCESS | 14342 | |11;stanford-crypto-ccm;134;146;133;132;139;132;134;132;222;132 18:46:17 INFO - PROCESS | 14342 | |12;stanford-crypto-pbkdf2;176;172;178;171;178;177;178;171;175;174 18:46:17 INFO - PROCESS | 14342 | |13;stanford-crypto-sha256-iterative;69;73;69;69;70;69;68;68;70;66 18:46:17 INFO - PROCESS | 14342 | __end_tp_report 18:46:17 INFO - PROCESS | 14342 | __start_cc_report 18:46:17 INFO - PROCESS | 14342 | _x_x_mozilla_cycle_collect,1847 18:46:17 INFO - PROCESS | 14342 | __end_cc_report 18:46:17 INFO - PROCESS | 14342 | __startTimestamp1484102777849__endTimestamp 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | ------- Summary: start ------- 18:46:17 INFO - PROCESS | 14342 | Number of tests: 14 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#0] ai-astar Cycles:10 Average:115.00 Median:116.00 stddev:2.54 (2.2%) stddev-sans-first:1.50 18:46:17 INFO - PROCESS | 14342 | Values: 109.0 115.0 116.0 119.0 116.0 114.0 115.0 116.0 116.0 114.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:128.00 stddev:15.50 (12.1%) stddev-sans-first:14.94 18:46:17 INFO - PROCESS | 14342 | Values: 152.0 125.0 122.0 168.0 129.0 124.0 123.0 124.0 142.0 127.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.16 (1.3%) stddev-sans-first:2.24 18:46:17 INFO - PROCESS | 14342 | Values: 161.0 161.0 163.0 162.0 168.0 161.0 163.0 162.0 161.0 161.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.43 (16.4%) stddev-sans-first:12.97 18:46:17 INFO - PROCESS | 14342 | Values: 75.0 76.0 76.0 114.0 77.0 76.0 76.0 76.0 91.0 76.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:84.00 stddev:13.99 (16.7%) stddev-sans-first:14.51 18:46:17 INFO - PROCESS | 14342 | Values: 84.0 84.0 124.0 85.0 85.0 84.0 101.0 85.0 84.0 108.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 18:46:17 INFO - PROCESS | 14342 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 119.0 117.0 118.0 117.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 18:46:17 INFO - PROCESS | 14342 | Values: 150.0 149.0 149.0 149.0 148.0 148.0 149.0 150.0 149.0 148.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:46:17 INFO - PROCESS | 14342 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.53 18:46:17 INFO - PROCESS | 14342 | Values: 61.0 59.0 59.0 59.0 59.0 60.0 60.0 59.0 60.0 60.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 18:46:17 INFO - PROCESS | 14342 | Values: 67.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 68.0 67.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.50 stddev:2.97 (3.5%) stddev-sans-first:3.12 18:46:17 INFO - PROCESS | 14342 | Values: 85.0 87.0 84.0 92.0 86.0 85.0 91.0 84.0 84.0 84.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:134.00 stddev:27.91 (20.8%) stddev-sans-first:29.38 18:46:17 INFO - PROCESS | 14342 | Values: 134.0 146.0 133.0 132.0 139.0 132.0 134.0 132.0 222.0 132.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.50 stddev:2.87 (1.6%) stddev-sans-first:3.02 18:46:17 INFO - PROCESS | 14342 | Values: 176.0 172.0 178.0 171.0 178.0 177.0 178.0 171.0 175.0 174.0 18:46:17 INFO - PROCESS | 14342 | 18:46:17 INFO - PROCESS | 14342 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.79 (2.6%) stddev-sans-first:1.90 18:46:17 INFO - PROCESS | 14342 | Values: 69.0 73.0 69.0 69.0 70.0 69.0 68.0 68.0 70.0 66.0 18:46:17 INFO - PROCESS | 14342 | -------- Summary: end -------- 18:46:17 INFO - PROCESS | 14342 | 18:46:18 INFO - TEST-INFO | 14342: exit 0 18:46:19 INFO - TEST-OK | kraken | took 62737ms 18:46:19 INFO - SUITE-END | took 1184s 18:46:19 INFO - Completed test suite (00:19:44) 18:46:19 INFO - javascript benchmark 18:46:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.310387747247, 2628.7896968242544, 2632.4998250332437, 2634.2492389668946, 2644.6694163229595, 4674.4624368197665, 4697.436307643079, 4812.302216178657, 4828.7585620718955, 4839.4918533553955, 4771.737554434505, 4773.06925149596, 4812.687175333601, 4842.903141937168, 4898.363212782342, 4344.109457561192, 4379.627731642814, 4386.714863533876, 4472.396226509412, 4540.727556346614, 4027.7986100694993, 4374.97812510937, 4405.86782396527, 4433.290673492242, 4503.076869241798, 4344.89137771555, 4369.235383807821, 4470.597646211857, 4478.686491945565, 4522.5025247222775, 4330.198913201068, 4358.782060896942, 4383.9342409863875, 4403.64770818337, 4432.822687092513, 4346.0, 4350.195213885441, 4384.145091707119, 4400.339949007643, 4403.229434848889, 4688.624910007191, 4716.787744551469, 4720.3863497745415, 4725.740084295362, 4773.403324584427, 4965.180745177042, 5009.599232061426, 5059.06407314648, 5059.468755780626, 5070.0, 5130.71781052042, 5179.637425380225, 5180.248863914749, 5201.895962080737, 5232.372115346145, 4842.685225460334, 4845.927311090337, 4847.175980083394, 4848.660593758403, 4897.4857639947295, 5153.974230128825, 5205.973970130125, 5271.973640131851, 5281.656692314988, 5286.524212820865, 5008.198688209942, 5052.873678158076, 5053.9747301264, 5059.8988020239385, 5060.190369540929, 5121.052605268037, 5127.9230811537855, 5128.25640282157, 5128.640995130379, 5133.666311689728, 5068.6451948363265, 5110.182370820651, 5114.565261952701, 5115.7442127893455, 5123.538881500683, 5096.388433387943, 5103.413107492612, 5107.157319042391, 5109.693418394908, 5115.360579927509, 4280.486341638961, 4295.119500502389, 4312.05134870328, 4315.697901146889, 4321.351797230441, 3745.382011968049, 3747.2130852521277, 3750.7937063461773, 3781.4516895050065, 3808.1050953026015, 4475.7985890635, 4481.305397663367, 4486.641068714495, 4523.84166554169, 4526.162659907927, 4993.27597498368, 5030.547250747451, 5038.420581633086, 5088.0587091388215, 5179.896402071938, 4421.46942366918, 4424.11517696462, 4444.955550444454, 4465.441819772528, 4466.932996005063, 4565.657575681837, 4573.611243044378, 4576.565226303496, 4581.816727330869, 4621.260598304255, 4666.323383109498, 4689.835855745033, 4778.33103365536, 4806.255030470283, 4815.2054910939305, 5039.84880453587, 5172.0, 5174.379074510932, 5204.8178313758835, 5230.241614965885, 4814.927776083291, 4819.831305904277, 4826.782794774173, 4837.443693975097, 4874.561289483963, 4953.826616068564, 4959.156943319716, 5072.695638261716, 5075.949240507548, 5122.948770512247, 5045.117104506623, 5071.670341427795, 5093.134167191661, 5125.79496820138, 5162.122439185272, 4866.29438731389, 4966.701997880139, 4975.800967961241, 4981.178105612534, 5021.472745361831, 4896.020795840775, 4965.577925876341, 4965.702057876539, 4965.925511117408, 4966.155753521838, 4894.143524883202, 4895.363602731622, 4926.531979461945, 4935.531124543163, 4937.185364414831, 4993.6254780892305, 5000.899982000413, 5001.124803159505, 5003.624728145331, 5019.472955339783, 4897.8285759998225, 4916.434610019894, 4919.7540122993, 4943.876403089952, 4959.851204463872], "value": 4692.415942919534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5144921020291, 546.8878879829634, 561.8651523634329, 566.3373852592466, 572.5248044123379, 29244.415111697752, 38445.80777096114, 40412.79793601035, 40424.19151616966, 44791.0, 42222.788886055605, 42672.35991460131, 42695.3595696064, 42704.78647606765, 42733.35899961495, 7576.621168941545, 7777.650005749755, 7782.610869456533, 7788.532688038736, 7797.298243158115, 7228.638568071602, 7428.442866784986, 9969.50152492376, 10240.590376384936, 10279.22460935547, 10078.294519383646, 10150.137238334713, 10150.898491015107, 10158.898411015869, 10175.084242418181, 10073.093421592055, 10137.493125343703, 10140.087392134743, 10146.84779728301, 10149.797004059878, 9911.10800028001, 9985.800283994353, 9989.300748947577, 9993.050660187271, 9995.650152244636, 39329.60670393288, 39615.0, 39633.801830990946, 39639.40540891889, 39686.20627587432, 3336.7497437692027, 3343.114074770188, 3354.630990591033, 3377.4089534331392, 3417.4361230396953, 29269.707302926912, 29792.702072979428, 29884.701152988408, 29894.103176904726, 29942.251443713863, 3473.940448163309, 3485.9651403485896, 3490.930181396358, 3528.576570811493, 3674.52231209941, 180062.0, 180523.0, 181045.0, 181473.18526814695, 182842.0, 54953.72523137439, 55374.44625553773, 55383.0, 55432.0, 55432.0, 56434.717826410604, 56444.71777641168, 56451.71774141103, 56515.0, 56533.410650816484, 14307.070040447337, 14586.41654333836, 14602.634934126732, 14603.853961460249, 14609.0, 10003.0, 10285.897141028494, 10905.563777448971, 11003.889961100287, 11044.33733975964, 15227.771583426258, 15403.306851191723, 15414.383424662889, 16865.91567042157, 17381.391651292142, 5697.971510142423, 6105.755769769248, 6148.262208534915, 6192.256929168529, 6221.906671399933, 807.5235610989427, 842.6081871929459, 868.383447752103, 881.722257488889, 883.2095274729081, 25890.482190356088, 27871.72128278732, 27930.860345698547, 28009.859950700524, 28220.576691349645, 958.0946006024379, 959.9376040557341, 960.3805545423163, 963.8795150606175, 965.888922773876, 13943.930280348533, 14503.419863205354, 14746.336414861356, 14884.925575372054, 14924.701505970037, 141661.29169354087, 364044.0, 368584.0, 368621.0, 523456.0, 39996.20007599832, 41208.0, 43457.78271108624, 44577.33134002992, 45086.54913450889, 1281.826953361303, 1282.6857419932176, 1285.3252042677668, 1290.0582574720695, 1297.7599144158362, 25466.0, 25871.223863284133, 26556.601650974866, 26585.601215982162, 26853.0, 38403.615963840006, 39011.60988390193, 39043.0, 39045.80477097596, 39140.804295978334, 286575.0, 287119.0, 287127.0, 287707.0, 287782.0, 23174.1889033883, 23343.41641458977, 23452.413689657897, 23695.52608947846, 23704.170354037527, 31638.683613163576, 32785.672143278265, 35176.43595871149, 36103.27793444169, 36400.27199456049, 32365.0, 37247.0, 38241.617583823805, 38512.22975540529, 39096.41355379728, 37210.25579488449, 37233.0, 38022.0, 38300.0, 42032.36951445792, 37248.62751372452, 37277.4408383869, 37306.25387492289, 37815.0, 38336.42495362627, 31500.684993149775, 34290.48564271488, 34479.13802154966, 34494.48258276078, 34536.82731586326, 25974.0, 26006.219813405627, 26104.216873493824, 26131.34671633148, 26237.606435903093], "value": 17514.293850016744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.18743857233386, 379.38350180955945, 388.4639197906887, 394.0424767814211, 416.5459648982608, 13288.269145197022, 14653.413863445463, 17673.20470578827, 17679.469615911512, 17711.114444277766, 16856.0, 17595.296188152457, 17620.21165449428, 18502.629947401078, 18580.721289180674, 3766.491523644314, 4776.641751868607, 4907.288443175756, 4910.0, 4913.82801601944, 3833.3291673956946, 3913.8434462621462, 3916.921661566767, 4707.670463067587, 5652.830415087554, 5646.378898321182, 5695.0318445864095, 5735.827925162252, 5753.942460575404, 5756.510696590794, 5491.093969495068, 5534.640248383842, 5567.747256867213, 5569.498745112939, 5578.888422231533, 5341.572674186055, 5496.367917689477, 5503.284573005523, 5504.394516603171, 5530.668159910378, 12794.360281985864, 12823.87176128236, 12842.0, 12930.224186548838, 12950.805737913939, 2203.118752499013, 2231.2596174983537, 2238.183063181943, 2392.497575509145, 2527.2670925431603, 8988.191062804379, 9229.0, 9677.080677335642, 9856.408615483095, 9857.408555486694, 1634.1665750467348, 1715.4510556621885, 1719.4497760716577, 1745.0, 1758.3230456274298, 66676.66661666661, 68455.9999999995, 77703.61148194279, 78580.60709696473, 78651.99999999943, 9731.610735570497, 9736.805263894683, 9961.601535938626, 10061.245406594535, 10135.655233772837, 13323.13399629021, 13329.0, 13330.666733331744, 13343.466261349437, 13348.532801351907, 7074.080369552028, 7209.96395018032, 7227.771278882603, 7352.485326027127, 7425.591592462466, 6923.861522769516, 6956.860862782817, 7189.84962406023, 7198.244184360671, 7233.746818861315, 4060.6548443382053, 4116.1767646470225, 4144.958550414457, 4214.431051808028, 4259.233337999128, 1834.7431359609666, 1895.6303520813585, 1903.581831535515, 1908.961820763577, 1969.399333203358, 814.3281792521194, 839.4837175137369, 840.8990921089509, 848.9490630562186, 869.4870026684287, 17618.735718964224, 18190.727139092924, 18563.535911602317, 18779.624407511772, 18915.0, 833.0, 846.6951897316961, 847.2586486824028, 847.7456762971208, 862.3360012790116, 10238.385696858213, 10342.844857327145, 10343.27597068213, 10347.586096556204, 10396.740081498023, 475604.0, 481295.0, 482415.0, 483454.0, 483486.0, 79986.20013799788, 83562.58218708867, 99442.0, 100895.49552252192, 101793.49103254436, 941.1717688434134, 969.9030096990385, 1013.0477351289765, 1013.3565186106875, 1015.5633077776479, 15807.446739364066, 16248.3500659977, 16567.0, 16778.986521617484, 16987.065711385498, 38233.4264986031, 38729.806350968065, 38974.41538376983, 38979.2204155921, 39831.80084099561, 52558.47441525689, 55036.72481637566, 55126.173107404225, 57225.71387143037, 57655.1351729716, 6903.689333979883, 6944.965275173592, 7091.397231235403, 7120.287971202838, 7210.495265331377, 7949.5463465542625, 8526.616302266537, 11069.5018724156, 11267.436628168723, 11760.82358764602, 9525.904740952501, 9872.605095796087, 9905.554250058909, 9951.0, 10466.529006194587, 9789.118979291898, 10016.198704103508, 10020.899791001997, 10066.949665251626, 10357.378557286587, 9905.108540231413, 9912.553935072794, 9989.750256243651, 10137.493125343852, 10294.536745846604, 7189.209186989531, 7254.383377412979, 7354.4187999580345, 7409.592472414069, 7519.172890982097, 8383.329333653415, 9372.39079459833, 9517.619295228113, 9719.514024298614, 9932.751681208028], "value": 8212.358776139588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.6868557794542, 1373.306480227485, 1375.2229990055619, 1399.3213291553595, 1400.4538230090263, 6792.2868098849585, 7192.532485388446, 7200.495965282433, 7200.711971521133, 7214.134303883535, 6129.969350153243, 6297.842553936154, 6619.900701489481, 6781.932180678192, 6812.863742725142, 2019.4446527205062, 2054.0, 2056.393363957636, 2056.876587404753, 2057.6193404220194, 1954.6188493243824, 2052.1586149678633, 2061.7525896892394, 2063.907124179408, 2071.1404767021745, 1800.1899145384564, 1856.3224423085612, 1973.8322242609395, 2022.4640470275315, 2052.8152466278034, 2057.238821635989, 2057.331367305617, 2060.526079001823, 2065.1532871522754, 2069.555045665174, 1959.9608007839906, 1975.140813746025, 1977.8417726581838, 1980.9405717828488, 2042.0606521000357, 7253.7098516059295, 7310.597917114556, 7314.853702925911, 7321.084864391951, 7321.231270716605, 4182.2890108681595, 4299.849505267332, 4309.676774241944, 4309.82760689572, 4316.438862947797, 2600.2199340197867, 2699.6625421822273, 2745.3136715821047, 2816.1270006298114, 2818.1545536339017, 1010.1817527802503, 1061.241212533035, 1072.9892701072968, 1092.180864351736, 1151.1423989128152, 9526.714198574055, 9607.231421486335, 9616.75958101039, 9617.759556011086, 9651.0, 3618.565772107364, 3719.888403347904, 3898.4152377143087, 3946.467226924386, 3967.583403742623, 8254.380921430917, 8269.09040005599, 8327.541985190872, 8351.20663536963, 8355.331573474108, 4174.666026717855, 4186.476690413699, 4186.748795072305, 4188.0, 4193.496780386373, 3725.1432170600915, 3812.6187381262207, 3831.8275677594575, 3856.2865869814173, 3857.9421308680394, 3384.4584866421255, 3387.7120444762472, 3458.5849698036395, 3488.162840918212, 3596.3886139356373, 1142.0806250967885, 1165.5687395663658, 1167.9240849344935, 1168.3749194181241, 1171.566520387462, 657.3886285754198, 679.7722762874394, 686.0738003694972, 689.0009486244965, 766.0080196146005, 4583.72497650142, 4609.723416595015, 4662.813487460531, 4767.118083154627, 4807.78364973577, 899.9415038022507, 934.1359242700474, 936.4240991790136, 941.6468824190929, 949.4540639132526, 3056.49567821307, 3302.1744563859033, 3308.9172770680925, 3325.584301962255, 3395.2530443302435, 8230.259276665129, 8408.201220884006, 8471.237588617054, 8530.104339044436, 8539.530325832015, 8392.4544904581, 8413.70552030676, 8417.242448179572, 8417.663293468315, 8446.83106337882, 6307.463865571386, 6602.537822352485, 6756.763513277012, 6757.425618822357, 6761.628110453972, 4855.344528488608, 4924.4090709115135, 4964.851054468371, 5073.2897394365555, 5094.0, 7645.808854778675, 7737.226277372218, 7743.2643898831775, 7881.84236315259, 7934.682612695427, 8018.719344822904, 8029.919700802917, 8033.879491807511, 8089.797755055935, 8116.0, 6093.969530152498, 6151.815445536641, 6154.1999540059505, 6222.595531290452, 6224.319433752952, 6688.598684078971, 6732.966335168293, 6734.663266836541, 6736.865262694817, 6739.831504212434, 5902.38025007368, 5972.163897054329, 6039.214902062704, 6124.173236613, 6126.050462178369, 6121.602095863755, 6157.014877619559, 6157.014877619559, 6165.599236049642, 6183.072539119168, 5416.9729151353995, 5506.972465137648, 5514.117741161395, 5522.447755224445, 5527.143292789624, 4238.766867822299, 4248.87253382399, 4266.402703621434, 4302.483701955785, 4391.5827996340295, 4332.501762297376, 4360.738355698668, 4394.406755088022, 4469.798859051415, 4551.908961820679], "value": 3822.097258793355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.4448526475523, 348.372928728289, 361.50654356802966, 361.622104900379, 369.79845983938753, 4565.315202719589, 4688.0, 4733.384659994204, 4783.832565860195, 4814.085323788478, 4641.953580464195, 4648.282899331782, 4652.441706995157, 4708.52914708529, 4731.952680473194, 3863.6715879150165, 3881.146147847476, 3921.2549615573093, 3930.390789427629, 3939.0546268895546, 3751.5685696144883, 3831.854161669474, 3841.519810023747, 3854.2869569129803, 3934.3705007198855, 3730.403135498321, 3873.0, 3875.670568001723, 3879.478339079593, 3890.708196885231, 3862.806859657006, 3866.163572303162, 3869.535655721303, 3875.399313106473, 3877.5540812806607, 3353.9038101186757, 3539.1859872229275, 3544.291141771656, 3554.9111272218142, 3570.4822800694014, 4369.584889435499, 4619.399478067863, 4628.282616194495, 4636.658487463843, 4643.442786865564, 4377.212101821703, 4389.473263208435, 4392.209402307583, 4422.668299877522, 4426.756528390937, 4971.751412429364, 4972.254161875711, 4988.634944423629, 5009.12340340439, 5014.84955451337, 3664.5052917856015, 3829.272438236754, 3838.2707285615643, 3846.230753849213, 3869.941950870739, 5183.2743415921805, 5194.714325696681, 5210.244514545369, 5215.504527069922, 5216.921746173811, 3941.2117576484816, 3947.5460322062754, 3965.1673148638533, 3981.7212795104065, 3991.501062367204, 3825.8660946866726, 4003.7197396181987, 4036.0515278909434, 4037.9394309085387, 4046.785964210725, 4190.53904070552, 4267.103908179255, 4286.335617979156, 4395.824167033346, 4418.425604671372, 5000.424951130666, 5009.470217540192, 5014.222795466709, 5025.4974502550185, 5043.2687260347775, 1342.5972208337655, 1348.676317683749, 1351.6012776231034, 1355.4480120262244, 1360.7550640884538, 887.5163036145187, 932.2681694869494, 938.0666237094135, 997.670768646345, 1006.0241565681278, 4220.8895552223885, 4226.427904608364, 4239.47006624172, 4240.533541310453, 4250.723702959298, 4944.826931057468, 4960.801567937314, 4974.452810190876, 4982.7259500727805, 4992.875178120504, 4095.3808259017833, 4216.894577635584, 4245.724027938236, 4294.677899157576, 4310.181065597527, 2662.427578070724, 2668.93327666806, 2672.9041093151714, 2675.8394496330284, 2678.0626780626626, 4658.394408726912, 4687.312567475706, 4701.576858082789, 4714.669973101919, 4719.5458361651745, 4983.6013118950395, 5079.568236699848, 5085.694858308513, 5168.793248270103, 5196.714180720097, 4839.201531747292, 4846.39420072491, 4850.781714822841, 4858.8785280367565, 4874.122657921537, 5116.155834287301, 5131.307273518028, 5135.666181698327, 5136.948630513647, 5138.177891537336, 4866.926996095132, 5024.145895197752, 5067.619928505451, 5077.796888124433, 5085.389753229636, 4839.951600484091, 4847.103285892122, 4847.927281090716, 4849.854504364875, 4861.611071114373, 3649.5985441601933, 3668.4687565579666, 3670.9816450917574, 3676.264747050547, 3690.317291301118, 4829.927551086666, 5145.3568303962, 5152.5620322271525, 5167.741612919414, 5174.637775355689, 4639.350490931205, 4882.170031094794, 4943.950560494349, 5002.274670172877, 5017.899642007066, 4921.655484116221, 4978.2034874419915, 4993.201087825931, 5008.248762685626, 5015.620704306199, 4804.73573953422, 4850.668492987568, 4860.635452341018, 4911.778969946289, 4915.827946022016, 4964.67729597575, 4980.452150263541, 4986.952739924656, 4990.426100998432, 5002.87492812668, 4892.510748925079, 4902.8774280643265, 4906.190478570996, 4907.141250281115, 4909.62530491463], "value": 3833.136800452469, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.0885973582534, 590.477427476683, 689.5242282824851, 764.7935057534465, 776.6815605601704, 12200.0, 13455.46178152874, 13469.797953030713, 13490.999999999987, 13492.66268343292, 13274.0, 13298.800517992213, 13350.332483375842, 13353.866461335383, 13429.932850335734, 657.3262406033806, 667.7896462614285, 785.3599316557016, 802.2819576479062, 805.2229598437507, 816.14304979771, 818.6152508321079, 820.4584973917187, 820.8399362124388, 822.6092606012156, 860.1656393298522, 861.9051904290554, 862.9309655227567, 863.5811631358786, 863.6890719341033, 689.0456717446373, 706.9858602827966, 828.8135169586855, 851.7444766570004, 860.6428332242112, 628.7296462521114, 628.9716962736642, 629.0909635576594, 629.116091890894, 629.3391938464594, 13484.797728034087, 13605.0, 13619.0, 13622.114562553403, 13636.113652612648, 12965.35173241334, 13006.284654344006, 13043.152195107383, 13221.338933053405, 13270.73458530824, 11683.299002059903, 11763.470643821049, 11927.463264153133, 12130.939345303304, 12147.210431322024, 4118.382242663594, 4135.1316223593085, 4146.129312844276, 4157.272477316457, 4185.560516145792, 60415.69792151055, 61671.38328616746, 61958.0, 62665.68667156681, 63661.36338636601, 10141.442220677785, 10358.741031474274, 10422.895771042344, 10473.214508911862, 10535.0, 19599.412017639494, 19644.21423143087, 19648.21407143698, 19653.50866228327, 19657.508562286057, 6480.416762491304, 6570.835729106715, 6818.590884546943, 6873.862522749517, 6891.793246202522, 3494.9126271843406, 3585.2650206707563, 3603.4054381026835, 3621.2033352662897, 3627.401478755976, 2716.307341627872, 2765.612814206013, 2786.2337857089465, 2787.4146429250086, 2793.483205606969, 473.3751448088559, 476.768767147933, 477.7873846138435, 479.94000749906263, 486.8247430924864, 474.5017731382104, 487.99756001219765, 502.69084513024956, 572.1132245020202, 580.5877826742975, 8496.0, 8585.0, 8597.527136007455, 8797.428167169113, 8876.644934202559, 596.4035964035965, 599.9190109335184, 604.3291945940003, 617.4720613875072, 632.5098049012053, 4084.305668036441, 4195.139996300751, 4222.155568886235, 4275.957240427618, 4322.113966636832, 67602.32397675961, 69741.0, 70893.29106708866, 72125.0, 72311.27688723046, 62637.68681156565, 62716.37283627196, 62877.0, 63000.0, 63828.68085659635, 54963.72518137384, 55265.0, 56683.0, 56837.14744278839, 57780.71109644425, 7728.806779830549, 7952.960235198787, 8042.48105305155, 8253.298469629908, 8525.0, 35190.47214291839, 36336.63663363332, 36908.0, 37304.94822784773, 37813.29548894158, 41017.79491102525, 41499.7925010373, 42910.57089429066, 45572.08855822799, 47766.52233477621, 10844.620438284623, 11162.441877906234, 11314.660560183207, 11609.3614851184, 11678.824817627572, 13129.935176795221, 13426.597202083953, 13439.932800335935, 13440.663983400493, 13528.93235533816, 12014.519419223483, 12036.082474226596, 12273.195467871094, 12302.81545776832, 13079.476820927057, 12325.322107283826, 12337.753244935231, 12444.81332779991, 12798.552050678181, 12828.935855320664, 12167.695807604881, 12433.689157771129, 12559.560415385418, 13003.219806811621, 13156.0, 9798.608055677692, 9814.165795907142, 9836.0, 10238.232132589937, 10351.327163734333, 10458.529366178693, 10901.672949811518, 10921.453927303444, 10999.450027498753, 11017.944910275397], "value": 6448.533821102963, "unit": "score"}], "name": "dromaeo_css", "value": 6320.7855129271475, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 116.0, 119.0, 116.0, 114.0, 115.0, 116.0, 116.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 122.0, 168.0, 129.0, 124.0, 123.0, 124.0, 142.0, 127.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 162.0, 168.0, 161.0, 163.0, 162.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 77.0, 76.0, 76.0, 76.0, 91.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 124.0, 85.0, 85.0, 84.0, 101.0, 85.0, 84.0, 108.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 150.0, 149.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 84.0, 92.0, 86.0, 85.0, 91.0, 84.0, 84.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 146.0, 133.0, 132.0, 139.0, 132.0, 134.0, 132.0, 222.0, 132.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 178.0, 171.0, 178.0, 177.0, 178.0, 171.0, 175.0, 174.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 69.0, 69.0, 70.0, 69.0, 68.0, 68.0, 70.0, 66.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1546.4999999999998, "alertThreshold": 2.0}]} 18:46:19 INFO - Return code: 0 18:46:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:46:19 INFO - # TBPL SUCCESS # 18:46:19 INFO - Running post-action listener: _resource_record_post_action 18:46:19 INFO - [mozharness: 2017-01-11 02:46:19.634084Z] Finished run-tests step (success) 18:46:19 INFO - Running post-run listener: _resource_record_post_run 18:46:19 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 384417792; Read time: 8; Write time: 277964 18:46:19 INFO - TinderboxPrint: CPU usage
13.1% 18:46:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:46:19 INFO - TinderboxPrint: I/O write bytes / time
384,417,792 / 277,964 18:46:19 INFO - TinderboxPrint: CPU idle
8,332.4 (86.9%) 18:46:19 INFO - TinderboxPrint: CPU user
1,213.2 (12.7%) 18:46:19 INFO - TinderboxPrint: Swap in / out
0 / 0 18:46:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99557376; Read time: 0; Write time: 102940 18:46:19 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 284246016; Read time: 0; Write time: 175024 18:46:20 INFO - Running post-run listener: _upload_blobber_files 18:46:20 INFO - Blob upload gear active. 18:46:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:46:20 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 18:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:46:20 INFO - (blobuploader) - INFO - Open directory for files ... 18:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:21 INFO - (blobuploader) - INFO - Done attempting. 18:46:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:46:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:24 INFO - (blobuploader) - INFO - Done attempting. 18:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:46:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:25 INFO - (blobuploader) - INFO - Done attempting. 18:46:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:46:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:46:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:26 INFO - (blobuploader) - INFO - Done attempting. 18:46:26 INFO - (blobuploader) - INFO - Iteration through files over. 18:46:26 INFO - Return code: 0 18:46:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:46:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:46:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f09c6de847313497ebd2d44a5ac5aff378d772ecf7e6af9784c22d360cad069205f90231d821eef123e321c95e83106d7a9168b203a464bb6e85b22ebb78924", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abdc4f58b212c22759c6ad7147018280e55da91e59ae8b2d3041ad92ee12e837db0e4d5534ce0f1221f6ef1f6a83ec5f1b1f7cc7c0ab74060e64b1d479c3c701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd8d45186d228ba096d6d2110d5b2d92b5c3e1db1e6403563f33f2f561135433d41df30f2a393637c07662feb40069cc0256669a768d98e51ca7f6a99e23e185", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47271deeedf45b8e503dbaa8dcfce55c6edf4346edc2db3eb23ca0bbf9461278c58ca72573004ab1227f4551a8c1d3b832d09b7848d73082ce2f672e64123a18"} 18:46:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:46:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:46:26 INFO - Contents: 18:46:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f09c6de847313497ebd2d44a5ac5aff378d772ecf7e6af9784c22d360cad069205f90231d821eef123e321c95e83106d7a9168b203a464bb6e85b22ebb78924", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abdc4f58b212c22759c6ad7147018280e55da91e59ae8b2d3041ad92ee12e837db0e4d5534ce0f1221f6ef1f6a83ec5f1b1f7cc7c0ab74060e64b1d479c3c701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd8d45186d228ba096d6d2110d5b2d92b5c3e1db1e6403563f33f2f561135433d41df30f2a393637c07662feb40069cc0256669a768d98e51ca7f6a99e23e185", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47271deeedf45b8e503dbaa8dcfce55c6edf4346edc2db3eb23ca0bbf9461278c58ca72573004ab1227f4551a8c1d3b832d09b7848d73082ce2f672e64123a18"} 18:46:26 INFO - Running post-run listener: copy_logs_to_upload_dir 18:46:26 INFO - Copying logs to upload dir... 18:46:26 INFO - mkdir: /builds/slave/test/build/upload/logs 18:46:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.155761 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-10 18:46:25.658225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 18:46:25.661663) ========= 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=923d835db2ba3686ebe126b700000192-1484101538.131696-37847782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f09c6de847313497ebd2d44a5ac5aff378d772ecf7e6af9784c22d360cad069205f90231d821eef123e321c95e83106d7a9168b203a464bb6e85b22ebb78924", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abdc4f58b212c22759c6ad7147018280e55da91e59ae8b2d3041ad92ee12e837db0e4d5534ce0f1221f6ef1f6a83ec5f1b1f7cc7c0ab74060e64b1d479c3c701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd8d45186d228ba096d6d2110d5b2d92b5c3e1db1e6403563f33f2f561135433d41df30f2a393637c07662feb40069cc0256669a768d98e51ca7f6a99e23e185", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47271deeedf45b8e503dbaa8dcfce55c6edf4346edc2db3eb23ca0bbf9461278c58ca72573004ab1227f4551a8c1d3b832d09b7848d73082ce2f672e64123a18"} build_url:https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011619 build_url: 'https://queue.taskcluster.net/v1/task/GQqIBWpfR5ylz9r8qPC_Zw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f09c6de847313497ebd2d44a5ac5aff378d772ecf7e6af9784c22d360cad069205f90231d821eef123e321c95e83106d7a9168b203a464bb6e85b22ebb78924", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abdc4f58b212c22759c6ad7147018280e55da91e59ae8b2d3041ad92ee12e837db0e4d5534ce0f1221f6ef1f6a83ec5f1b1f7cc7c0ab74060e64b1d479c3c701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd8d45186d228ba096d6d2110d5b2d92b5c3e1db1e6403563f33f2f561135433d41df30f2a393637c07662feb40069cc0256669a768d98e51ca7f6a99e23e185", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47271deeedf45b8e503dbaa8dcfce55c6edf4346edc2db3eb23ca0bbf9461278c58ca72573004ab1227f4551a8c1d3b832d09b7848d73082ce2f672e64123a18"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 18:46:25.687404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 18:46:25.687765) ========= 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=923d835db2ba3686ebe126b700000192-1484101538.131696-37847782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 18:46:25.773669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 18:46:25.774077) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 18:46:25.774441) ========= ========= Total master_lag: 0.17 =========