builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-086 starttime: 1492074733.67 results: success (0) revision: 4c78da5f6ddacce5332ead124aa734635fc83d8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 02:12:13.672158) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 02:12:13.672594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-04-13 02:12:13.672866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-04-13 02:12:16.728700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-04-13 02:12:16.729126) ========= 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=438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-13 02:12:17-- 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% 211M=0s 2017-04-13 02:12:22 (211 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=5.030895 ========= master_lag: 1.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-04-13 02:12:23.037590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 02:12:23.037959) ========= 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=438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019868 ========= master_lag: 1.27 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 02:12:24.325794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-04-13 02:12:24.326222) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4c78da5f6ddacce5332ead124aa734635fc83d8f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4c78da5f6ddacce5332ead124aa734635fc83d8f --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=438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-13 02:12:24,961 truncating revision to first 12 chars 2017-04-13 02:12:24,961 Setting DEBUG logging. 2017-04-13 02:12:24,961 attempt 1/10 2017-04-13 02:12:24,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4c78da5f6dda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-13 02:12:28,224 unpacking tar archive at: mozilla-aurora-4c78da5f6dda/testing/mozharness/ program finished with exit code 0 elapsedTime=3.564956 ========= master_lag: 0.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-04-13 02:12:28.566181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 02:12:28.566563) ========= script_repo_revision: 4c78da5f6ddacce5332ead124aa734635fc83d8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 02:12:28.566953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2017-04-13 02:12:28.567253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2017-04-13 02:12:31.010584) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2017-04-13 02:12:31.011054) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-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=438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:12:31 INFO - MultiFileLogger online at 20170413 02:12:31 in /builds/slave/test 02:12:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 02:12:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:12:31 INFO - {'append_to_log': False, 02:12:31 INFO - 'base_work_dir': '/builds/slave/test', 02:12:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 02:12:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:12:31 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 02:12:31 INFO - 'buildbot_json_path': 'buildprops.json', 02:12:31 INFO - 'config_files': ('talos/linux_config.py',), 02:12:31 INFO - 'default_actions': ('clobber', 02:12:31 INFO - 'read-buildbot-config', 02:12:31 INFO - 'download-and-extract', 02:12:31 INFO - 'populate-webroot', 02:12:31 INFO - 'create-virtualenv', 02:12:31 INFO - 'install', 02:12:31 INFO - 'run-tests'), 02:12:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:12:31 INFO - 'download_minidump_stackwalk': True, 02:12:31 INFO - 'download_symbols': 'ondemand', 02:12:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:12:31 INFO - 'tooltool.py': '/tools/tooltool.py', 02:12:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:12:31 INFO - '/tools/misc-python/virtualenv.py')}, 02:12:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:12:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:12:31 INFO - 'gecko_profile': False, 02:12:31 INFO - 'gecko_profile_interval': 0, 02:12:31 INFO - 'installer_path': 'installer.exe', 02:12:31 INFO - 'log_level': 'info', 02:12:31 INFO - 'log_name': 'talos', 02:12:31 INFO - 'log_to_console': True, 02:12:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:12:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:12:31 INFO - 'opt_config_files': (), 02:12:31 INFO - 'pip_index': False, 02:12:31 INFO - 'suite': 'dromaeojs', 02:12:31 INFO - 'system_bits': '32', 02:12:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:12:31 INFO - 'title': 'talos-linux64-ix-086', 02:12:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:12:31 INFO - 'use_talos_json': True, 02:12:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:12:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:12:31 INFO - 'work_dir': 'build'} 02:12:31 INFO - [mozharness: 2017-04-13 09:12:31.663541Z] Running clobber step. 02:12:31 INFO - Running pre-action listener: _resource_record_pre_action 02:12:31 INFO - Running main action method: clobber 02:12:31 INFO - rmtree: /builds/slave/test/build 02:12:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:12:32 INFO - Running post-action listener: _resource_record_post_action 02:12:32 INFO - [mozharness: 2017-04-13 09:12:32.611778Z] Finished clobber step (success) 02:12:32 INFO - [mozharness: 2017-04-13 09:12:32.611877Z] Running read-buildbot-config step. 02:12:32 INFO - Running pre-action listener: _resource_record_pre_action 02:12:32 INFO - Running main action method: read_buildbot_config 02:12:32 INFO - Using buildbot properties: 02:12:32 INFO - { 02:12:32 INFO - "project": "", 02:12:32 INFO - "product": "firefox", 02:12:32 INFO - "who": "nobody@mozilla.org", 02:12:32 INFO - "installer_path": "public/build/target.tar.bz2", 02:12:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:12:32 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 02:12:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 02:12:32 INFO - "stage_platform": "linux64", 02:12:32 INFO - "basedir": "/builds/slave/test", 02:12:32 INFO - "buildnumber": 130, 02:12:32 INFO - "platform": "ubuntu64_hw", 02:12:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:12:32 INFO - "slavebuilddir": "test", 02:12:32 INFO - "taskId": "P4mKF3GVTgGVdZqy9DBgGQ", 02:12:32 INFO - "branch": "mozilla-aurora", 02:12:32 INFO - "script_repo_revision": "production", 02:12:32 INFO - "revision": "4c78da5f6ddacce5332ead124aa734635fc83d8f", 02:12:32 INFO - "slavename": "talos-linux64-ix-086", 02:12:32 INFO - "repo_path": "releases/mozilla-aurora" 02:12:32 INFO - } 02:12:32 INFO - Finding installer, test and symbols from parent task. 02:12:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4mKF3GVTgGVdZqy9DBgGQ'}, attempt #1 02:12:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4mKF3GVTgGVdZqy9DBgGQ'}, attempt #1 02:12:35 INFO - Task dependencies: P1xRaJ7OQoW6ScvvhPLD9A 02:12:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A'}, attempt #1 02:12:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.tar.bz2 02:12:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/test_packages.json 02:12:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.crashreporter-symbols.zip 02:12:37 INFO - Running post-action listener: _resource_record_post_action 02:12:37 INFO - [mozharness: 2017-04-13 09:12:37.390390Z] Finished read-buildbot-config step (success) 02:12:37 INFO - [mozharness: 2017-04-13 09:12:37.390610Z] Running download-and-extract step. 02:12:37 INFO - Running pre-action listener: _resource_record_pre_action 02:12:37 INFO - Running main action method: download_and_extract 02:12:37 INFO - mkdir: /builds/slave/test/build/tests 02:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:37 INFO - trying https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.test_packages.json 02:12:37 INFO - Downloading https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:12:40 INFO - Downloaded 896 bytes. 02:12:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:12:40 INFO - Using the following test package requirements: 02:12:40 INFO - {u'common': [u'target.common.tests.zip'], 02:12:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:12:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:12:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:12:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:12:40 INFO - u'mozbase': [u'target.common.tests.zip'], 02:12:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:12:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:12:40 INFO - u'web-platform': [u'target.common.tests.zip', 02:12:40 INFO - u'target.web-platform.tests.zip'], 02:12:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:12:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:12:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.common.tests.zip 02:12:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:12:40 INFO - Fetch https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.common.tests.zip into memory 02:12:45 INFO - Expected file size: 59541567 02:12:45 INFO - Obtained file size: 59541567 02:12:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:12:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.common.tests.zip 02:12:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:12:54 INFO - Fetch https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.common.tests.zip into memory 02:13:27 INFO - Expected file size: 59541567 02:13:27 INFO - Obtained file size: 59541567 02:13:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.talos.tests.zip 02:13:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:13:38 INFO - Fetch https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.talos.tests.zip into memory 02:13:41 INFO - Expected file size: 14404424 02:13:41 INFO - Obtained file size: 14404424 02:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:41 INFO - trying https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.tar.bz2 02:13:41 INFO - Downloading https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:13:45 INFO - Downloaded 66737965 bytes. 02:13:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.tar.bz2 02:13:45 INFO - mkdir: /builds/slave/test/properties 02:13:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:13:45 INFO - Writing to file /builds/slave/test/properties/build_url 02:13:45 INFO - Contents: 02:13:45 INFO - build_url:https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.tar.bz2 02:13:45 INFO - Running post-action listener: _resource_record_post_action 02:13:45 INFO - Running post-action listener: set_extra_try_arguments 02:13:45 INFO - [mozharness: 2017-04-13 09:13:45.645410Z] Finished download-and-extract step (success) 02:13:45 INFO - [mozharness: 2017-04-13 09:13:45.645506Z] Running populate-webroot step. 02:13:45 INFO - Running pre-action listener: _resource_record_pre_action 02:13:45 INFO - Running main action method: populate_webroot 02:13:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:45 INFO - '--tppagecycles', 02:13:45 INFO - '7'], 02:13:45 INFO - 'tests': ['tsvgm']}}, 02:13:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:13:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:13:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:13:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:13:45 INFO - 'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:13:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:13:45 INFO - 'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['damp', 'tps']}, 02:13:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:13:45 INFO - 'tests': ['damp', 'tps']}, 02:13:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['dromaeo_dom']}, 02:13:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:13:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['basic_compositor_video']}, 02:13:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:13:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['a11yr', 02:13:45 INFO - 'ts_paint', 02:13:45 INFO - 'tpaint', 02:13:45 INFO - 'sessionrestore', 02:13:45 INFO - 'sessionrestore_no_auto_restore', 02:13:45 INFO - 'tabpaint']}, 02:13:45 INFO - 'other-e10s': {'tests': ['a11yr', 02:13:45 INFO - 'ts_paint', 02:13:45 INFO - 'tpaint', 02:13:45 INFO - 'sessionrestore', 02:13:45 INFO - 'sessionrestore_no_auto_restore', 02:13:45 INFO - 'tabpaint']}, 02:13:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:13:45 INFO - 'ts_paint', 02:13:45 INFO - 'tpaint', 02:13:45 INFO - 'sessionrestore', 02:13:45 INFO - 'sessionrestore_no_auto_restore', 02:13:45 INFO - 'tabpaint']}, 02:13:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:13:45 INFO - 'ts_paint', 02:13:45 INFO - 'tpaint', 02:13:45 INFO - 'sessionrestore', 02:13:45 INFO - 'sessionrestore_no_auto_restore', 02:13:45 INFO - 'tabpaint']}, 02:13:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['a11yr', 02:13:45 INFO - 'ts_paint', 02:13:45 INFO - 'tpaint', 02:13:45 INFO - 'sessionrestore', 02:13:45 INFO - 'sessionrestore_no_auto_restore', 02:13:45 INFO - 'tabpaint']}, 02:13:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['a11yr', 02:13:45 INFO - 'ts_paint', 02:13:45 INFO - 'tpaint', 02:13:45 INFO - 'sessionrestore', 02:13:45 INFO - 'sessionrestore_no_auto_restore', 02:13:45 INFO - 'tabpaint']}, 02:13:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['tsvgx', 02:13:45 INFO - 'tsvgr_opacity', 02:13:45 INFO - 'tart', 02:13:45 INFO - 'tscrollx', 02:13:45 INFO - 'cart', 02:13:45 INFO - 'tsvg_static']}, 02:13:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:13:45 INFO - 'tsvgr_opacity', 02:13:45 INFO - 'tart', 02:13:45 INFO - 'tscrollx', 02:13:45 INFO - 'cart', 02:13:45 INFO - 'tsvg_static']}, 02:13:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:13:45 INFO - 'talos_options': ['--disable-e10s'], 02:13:45 INFO - 'tests': ['tp5o']}, 02:13:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:13:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:13:45 INFO - 'talos_options': ['--disable-e10s', 02:13:45 INFO - '--xperf_path', 02:13:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:45 INFO - 'tests': ['tp5n']}, 02:13:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:13:45 INFO - 'talos_options': ['--xperf_path', 02:13:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:45 INFO - 'tests': ['tp5n']}}, 02:13:45 INFO - 'talos.zip': {'path': '', 02:13:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:45 INFO - Running post-action listener: _resource_record_post_action 02:13:45 INFO - [mozharness: 2017-04-13 09:13:45.658587Z] Finished populate-webroot step (success) 02:13:45 INFO - [mozharness: 2017-04-13 09:13:45.658676Z] Running create-virtualenv step. 02:13:45 INFO - Running pre-action listener: _resource_record_pre_action 02:13:45 INFO - Running main action method: create_virtualenv 02:13:45 INFO - Creating virtualenv /builds/slave/test/build/venv 02:13:45 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 02:13:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:13:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:45 INFO - Using real prefix '/usr' 02:13:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:13:46 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:48 INFO - Installing pip.................done. 02:13:48 INFO - Return code: 0 02:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:13:48 INFO - Reading from file tmpfile_stdout 02:13:48 INFO - Output received: 02:13:48 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) 02:13:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:13:48 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')]} 02:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:48 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')]} 02:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:52 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 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:13:52 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 02:13:52 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 02:13:52 INFO - Using env: {'DISPLAY': ':0', 02:13:52 INFO - 'HOME': '/home/cltbld', 02:13:52 INFO - 'LANG': 'en_US.UTF-8', 02:13:52 INFO - 'LANGUAGE': 'en_US:en', 02:13:52 INFO - 'LOGNAME': 'cltbld', 02:13:52 INFO - 'MAIL': '/var/mail/cltbld', 02:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:52 INFO - 'MOZ_NO_REMOTE': '1', 02:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:52 INFO - 'NO_EM_RESTART': '1', 02:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:52 INFO - 'PWD': '/builds/slave/test', 02:13:52 INFO - 'SHELL': '/bin/bash', 02:13:52 INFO - 'SHLVL': '1', 02:13:52 INFO - 'TERM': 'linux', 02:13:52 INFO - 'TMOUT': '86400', 02:13:52 INFO - 'USER': 'cltbld', 02:13:52 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:52 INFO - '_': '/tools/buildbot/bin/python'} 02:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:52 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 02:13:52 INFO - Cleaning up... 02:13:52 INFO - Return code: 0 02:13:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:13:52 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')]} 02:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:52 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')]} 02:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:54 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 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:13:54 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 02:13:54 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 02:13:54 INFO - Using env: {'DISPLAY': ':0', 02:13:54 INFO - 'HOME': '/home/cltbld', 02:13:54 INFO - 'LANG': 'en_US.UTF-8', 02:13:54 INFO - 'LANGUAGE': 'en_US:en', 02:13:54 INFO - 'LOGNAME': 'cltbld', 02:13:54 INFO - 'MAIL': '/var/mail/cltbld', 02:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:54 INFO - 'MOZ_NO_REMOTE': '1', 02:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:54 INFO - 'NO_EM_RESTART': '1', 02:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:54 INFO - 'PWD': '/builds/slave/test', 02:13:54 INFO - 'SHELL': '/bin/bash', 02:13:54 INFO - 'SHLVL': '1', 02:13:54 INFO - 'TERM': 'linux', 02:13:54 INFO - 'TMOUT': '86400', 02:13:54 INFO - 'USER': 'cltbld', 02:13:54 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:54 INFO - '_': '/tools/buildbot/bin/python'} 02:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:55 INFO - Downloading/unpacking psutil>=3.1.1 02:13:55 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 02:13:55 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 02:13:55 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 02:13:55 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 02:13:55 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 02:13:55 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 02:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:00 INFO - Installing collected packages: psutil 02:14:00 INFO - Running setup.py install for psutil 02:14:00 INFO - building 'psutil._psutil_linux' extension 02:14: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 02:14: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 02:14:00 INFO - building 'psutil._psutil_posix' extension 02:14: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 02:14: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 02:14:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:01 INFO - Successfully installed psutil 02:14:01 INFO - Cleaning up... 02:14:01 INFO - Return code: 0 02:14:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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')]} 02:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:14: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:14: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 mozsystemmonitor==0.3 02:14:03 INFO - Using env: {'DISPLAY': ':0', 02:14:03 INFO - 'HOME': '/home/cltbld', 02:14:03 INFO - 'LANG': 'en_US.UTF-8', 02:14:03 INFO - 'LANGUAGE': 'en_US:en', 02:14:03 INFO - 'LOGNAME': 'cltbld', 02:14:03 INFO - 'MAIL': '/var/mail/cltbld', 02:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:03 INFO - 'MOZ_NO_REMOTE': '1', 02:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:03 INFO - 'NO_EM_RESTART': '1', 02:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:03 INFO - 'PWD': '/builds/slave/test', 02:14:03 INFO - 'SHELL': '/bin/bash', 02:14:03 INFO - 'SHLVL': '1', 02:14:03 INFO - 'TERM': 'linux', 02:14:03 INFO - 'TMOUT': '86400', 02:14:03 INFO - 'USER': 'cltbld', 02:14:03 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:03 INFO - '_': '/tools/buildbot/bin/python'} 02:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:14: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 02:14: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 02:14: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 02:14: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 02:14: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 02:14: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 02:14:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:14:08 INFO - Installing collected packages: mozsystemmonitor 02:14:08 INFO - Running setup.py install for mozsystemmonitor 02:14:08 INFO - Successfully installed mozsystemmonitor 02:14:08 INFO - Cleaning up... 02:14:08 INFO - Return code: 0 02:14:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:14:10 INFO - Using env: {'DISPLAY': ':0', 02:14:10 INFO - 'HOME': '/home/cltbld', 02:14:10 INFO - 'LANG': 'en_US.UTF-8', 02:14:10 INFO - 'LANGUAGE': 'en_US:en', 02:14:10 INFO - 'LOGNAME': 'cltbld', 02:14:10 INFO - 'MAIL': '/var/mail/cltbld', 02:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:10 INFO - 'MOZ_NO_REMOTE': '1', 02:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:10 INFO - 'NO_EM_RESTART': '1', 02:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:10 INFO - 'PWD': '/builds/slave/test', 02:14:10 INFO - 'SHELL': '/bin/bash', 02:14:10 INFO - 'SHLVL': '1', 02:14:10 INFO - 'TERM': 'linux', 02:14:10 INFO - 'TMOUT': '86400', 02:14:10 INFO - 'USER': 'cltbld', 02:14:10 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:10 INFO - '_': '/tools/buildbot/bin/python'} 02:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:11 INFO - Downloading/unpacking jsonschema==2.5.1 02:14:11 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 02:14:11 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 02:14:11 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 02:14:11 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 02:14:11 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 02:14:11 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 02:14:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:14:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:14:16 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 02:14:16 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 02:14:16 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 02:14:16 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 02:14:16 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 02:14:16 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 02:14:16 INFO - Downloading functools32-3.2.3-2.tar.gz 02:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:14:17 INFO - warning: no files found matching '*.txt' 02:14:17 INFO - no previously-included directories found matching 'build' 02:14:17 INFO - no previously-included directories found matching 'dist' 02:14:17 INFO - no previously-included directories found matching '.git*' 02:14:17 INFO - Installing collected packages: jsonschema, functools32 02:14:17 INFO - Running setup.py install for functools32 02:14:17 INFO - warning: no files found matching '*.txt' 02:14:17 INFO - no previously-included directories found matching 'build' 02:14:17 INFO - no previously-included directories found matching 'dist' 02:14:17 INFO - no previously-included directories found matching '.git*' 02:14:17 INFO - Successfully installed jsonschema functools32 02:14:17 INFO - Cleaning up... 02:14:17 INFO - Return code: 0 02:14:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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')]} 02:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:20 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 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:14:20 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 02:14:20 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 02:14:20 INFO - Using env: {'DISPLAY': ':0', 02:14:20 INFO - 'HOME': '/home/cltbld', 02:14:20 INFO - 'LANG': 'en_US.UTF-8', 02:14:20 INFO - 'LANGUAGE': 'en_US:en', 02:14:20 INFO - 'LOGNAME': 'cltbld', 02:14:20 INFO - 'MAIL': '/var/mail/cltbld', 02:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:20 INFO - 'MOZ_NO_REMOTE': '1', 02:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:20 INFO - 'NO_EM_RESTART': '1', 02:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:20 INFO - 'PWD': '/builds/slave/test', 02:14:20 INFO - 'SHELL': '/bin/bash', 02:14:20 INFO - 'SHLVL': '1', 02:14:20 INFO - 'TERM': 'linux', 02:14:20 INFO - 'TMOUT': '86400', 02:14:20 INFO - 'USER': 'cltbld', 02:14:20 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:20 INFO - '_': '/tools/buildbot/bin/python'} 02:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:14:20 INFO - Cleaning up... 02:14:20 INFO - Return code: 0 02:14:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14:20 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')]} 02:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:20 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')]} 02:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:21 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 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:14:21 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 02:14:21 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 02:14:21 INFO - Using env: {'DISPLAY': ':0', 02:14:21 INFO - 'HOME': '/home/cltbld', 02:14:21 INFO - 'LANG': 'en_US.UTF-8', 02:14:21 INFO - 'LANGUAGE': 'en_US:en', 02:14:21 INFO - 'LOGNAME': 'cltbld', 02:14:21 INFO - 'MAIL': '/var/mail/cltbld', 02:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:21 INFO - 'MOZ_NO_REMOTE': '1', 02:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:21 INFO - 'NO_EM_RESTART': '1', 02:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:21 INFO - 'PWD': '/builds/slave/test', 02:14:21 INFO - 'SHELL': '/bin/bash', 02:14:21 INFO - 'SHLVL': '1', 02:14:21 INFO - 'TERM': 'linux', 02:14:21 INFO - 'TMOUT': '86400', 02:14:21 INFO - 'USER': 'cltbld', 02:14:21 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:21 INFO - '_': '/tools/buildbot/bin/python'} 02:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:22 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:22 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 02:14:22 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 02:14:22 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 02:14:22 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 02:14:22 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 02:14:22 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 02:14:28 INFO - Downloading blobuploader-1.2.4.tar.gz 02:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:14:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:14:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:14:29 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 02:14:29 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 02:14:29 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 02:14:29 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 02:14:29 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 02:14:29 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 02:14:29 INFO - Downloading docopt-0.6.1.tar.gz 02:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:14:29 INFO - Installing collected packages: blobuploader, requests, docopt 02:14:29 INFO - Running setup.py install for blobuploader 02:14:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:14:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:14:29 INFO - Running setup.py install for requests 02:14:29 INFO - Running setup.py install for docopt 02:14:30 INFO - Successfully installed blobuploader requests docopt 02:14:30 INFO - Cleaning up... 02:14:30 INFO - Return code: 0 02:14:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:30 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')]} 02:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:30 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')]} 02:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:31 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 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:14:31 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 02:14:31 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 02:14:31 INFO - Using env: {'DISPLAY': ':0', 02:14:31 INFO - 'HOME': '/home/cltbld', 02:14:31 INFO - 'LANG': 'en_US.UTF-8', 02:14:31 INFO - 'LANGUAGE': 'en_US:en', 02:14:31 INFO - 'LOGNAME': 'cltbld', 02:14:31 INFO - 'MAIL': '/var/mail/cltbld', 02:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:31 INFO - 'MOZ_NO_REMOTE': '1', 02:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:31 INFO - 'NO_EM_RESTART': '1', 02:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:31 INFO - 'PWD': '/builds/slave/test', 02:14:31 INFO - 'SHELL': '/bin/bash', 02:14:31 INFO - 'SHLVL': '1', 02:14:31 INFO - 'TERM': 'linux', 02:14:31 INFO - 'TMOUT': '86400', 02:14:31 INFO - 'USER': 'cltbld', 02:14:31 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:31 INFO - '_': '/tools/buildbot/bin/python'} 02:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:32 INFO - Running setup.py (path:/tmp/pip-aq2lma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:32 INFO - Running setup.py (path:/tmp/pip-zn7oyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:32 INFO - Running setup.py (path:/tmp/pip-sbYITA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:32 INFO - Running setup.py (path:/tmp/pip-5miYde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:32 INFO - Running setup.py (path:/tmp/pip-NlqT53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:32 INFO - Running setup.py (path:/tmp/pip-FhxZLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:32 INFO - Running setup.py (path:/tmp/pip-eRVaXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:32 INFO - Running setup.py (path:/tmp/pip-YgTPio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:32 INFO - Running setup.py (path:/tmp/pip-bkrCUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:32 INFO - Running setup.py (path:/tmp/pip-gjAfCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:32 INFO - Running setup.py (path:/tmp/pip-ZVJDp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:32 INFO - Running setup.py (path:/tmp/pip-yeZKSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:33 INFO - Running setup.py (path:/tmp/pip-sJz89b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:33 INFO - Running setup.py (path:/tmp/pip-Q_SviL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:33 INFO - Running setup.py (path:/tmp/pip-TyHDHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:33 INFO - Running setup.py (path:/tmp/pip-mzDc1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:33 INFO - Running setup.py (path:/tmp/pip-WCOMQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:14:33 INFO - Running setup.py install for manifestparser 02:14:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:14:33 INFO - Running setup.py install for mozcrash 02:14:33 INFO - Running setup.py install for mozdebug 02:14:33 INFO - Running setup.py install for mozdevice 02:14:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:14:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:14:33 INFO - Running setup.py install for mozfile 02:14:33 INFO - Running setup.py install for mozhttpd 02:14:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Running setup.py install for mozinfo 02:14:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Running setup.py install for mozInstall 02:14:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Running setup.py install for mozleak 02:14:34 INFO - Running setup.py install for mozlog 02:14:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Running setup.py install for moznetwork 02:14:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Running setup.py install for mozprocess 02:14:34 INFO - Running setup.py install for mozprofile 02:14:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Running setup.py install for mozrunner 02:14:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:14:34 INFO - Running setup.py install for mozscreenshot 02:14:35 INFO - Running setup.py install for moztest 02:14:35 INFO - Running setup.py install for mozversion 02:14:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:14:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:14:35 INFO - Cleaning up... 02:14:35 INFO - Return code: 0 02:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:35 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')]} 02:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:35 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')]} 02:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:38 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 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:14:38 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 02:14:38 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 02:14:38 INFO - Using env: {'DISPLAY': ':0', 02:14:38 INFO - 'HOME': '/home/cltbld', 02:14:38 INFO - 'LANG': 'en_US.UTF-8', 02:14:38 INFO - 'LANGUAGE': 'en_US:en', 02:14:38 INFO - 'LOGNAME': 'cltbld', 02:14:38 INFO - 'MAIL': '/var/mail/cltbld', 02:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:38 INFO - 'MOZ_NO_REMOTE': '1', 02:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:38 INFO - 'NO_EM_RESTART': '1', 02:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:38 INFO - 'PWD': '/builds/slave/test', 02:14:38 INFO - 'SHELL': '/bin/bash', 02:14:38 INFO - 'SHLVL': '1', 02:14:38 INFO - 'TERM': 'linux', 02:14:38 INFO - 'TMOUT': '86400', 02:14:38 INFO - 'USER': 'cltbld', 02:14:38 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:38 INFO - '_': '/tools/buildbot/bin/python'} 02:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:38 INFO - Running setup.py (path:/tmp/pip-y6zkRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:38 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)) 02:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:38 INFO - Running setup.py (path:/tmp/pip-UsSTiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:38 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)) 02:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:38 INFO - Running setup.py (path:/tmp/pip-V_RAXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:38 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)) 02:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:38 INFO - Running setup.py (path:/tmp/pip-_gB6DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:38 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)) 02:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:38 INFO - Running setup.py (path:/tmp/pip-BtxE92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:38 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)) 02:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:38 INFO - Running setup.py (path:/tmp/pip-d_pcZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:39 INFO - Running setup.py (path:/tmp/pip-Kt74Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:39 INFO - Running setup.py (path:/tmp/pip-gVTtKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:39 INFO - Running setup.py (path:/tmp/pip-Dg5XXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:39 INFO - Running setup.py (path:/tmp/pip-tHh19f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:39 INFO - Running setup.py (path:/tmp/pip-ZF0I3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:39 INFO - Running setup.py (path:/tmp/pip-j15tMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:39 INFO - Running setup.py (path:/tmp/pip-ZxNXuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:39 INFO - Running setup.py (path:/tmp/pip-oK7vau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:39 INFO - Running setup.py (path:/tmp/pip-U_JlAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:39 INFO - Running setup.py (path:/tmp/pip-u7VjS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:39 INFO - Running setup.py (path:/tmp/pip-_lorcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:39 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)) 02:14:39 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)) 02:14:39 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)) 02:14:39 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)) 02:14:39 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)) 02:14:39 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)) 02:14:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:45 INFO - Downloading blessings-1.6.tar.gz 02:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:46 INFO - Installing collected packages: blessings 02:14:46 INFO - Running setup.py install for blessings 02:14:46 INFO - Successfully installed blessings 02:14:46 INFO - Cleaning up... 02:14:46 INFO - Return code: 0 02:14:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:46 INFO - Reading from file tmpfile_stdout 02:14:46 INFO - Current package versions: 02:14:46 INFO - argparse == 1.2.1 02:14:46 INFO - blessings == 1.6 02:14:46 INFO - blobuploader == 1.2.4 02:14:46 INFO - docopt == 0.6.1 02:14:46 INFO - functools32 == 3.2.3-2 02:14:46 INFO - jsonschema == 2.5.1 02:14:46 INFO - manifestparser == 1.1 02:14:46 INFO - mozInstall == 1.12 02:14:46 INFO - mozcrash == 1.0 02:14:46 INFO - mozdebug == 0.1 02:14:46 INFO - mozdevice == 0.49 02:14:46 INFO - mozfile == 1.2 02:14:46 INFO - mozhttpd == 0.7 02:14:46 INFO - mozinfo == 0.9 02:14:46 INFO - mozleak == 0.1 02:14:46 INFO - mozlog == 3.4 02:14:46 INFO - moznetwork == 0.27 02:14:46 INFO - mozprocess == 0.25 02:14:46 INFO - mozprofile == 0.28 02:14:46 INFO - mozrunner == 6.13 02:14:46 INFO - mozscreenshot == 0.1 02:14:46 INFO - mozsystemmonitor == 0.3 02:14:46 INFO - moztest == 0.8 02:14:46 INFO - mozversion == 1.4 02:14:46 INFO - psutil == 3.1.1 02:14:46 INFO - requests == 1.2.3 02:14:46 INFO - wsgiref == 0.1.2 02:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:48 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 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:14:48 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 02:14:48 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 02:14:48 INFO - Using env: {'DISPLAY': ':0', 02:14:48 INFO - 'HOME': '/home/cltbld', 02:14:48 INFO - 'LANG': 'en_US.UTF-8', 02:14:48 INFO - 'LANGUAGE': 'en_US:en', 02:14:48 INFO - 'LOGNAME': 'cltbld', 02:14:48 INFO - 'MAIL': '/var/mail/cltbld', 02:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:48 INFO - 'MOZ_NO_REMOTE': '1', 02:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:48 INFO - 'NO_EM_RESTART': '1', 02:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:48 INFO - 'PWD': '/builds/slave/test', 02:14:48 INFO - 'SHELL': '/bin/bash', 02:14:48 INFO - 'SHLVL': '1', 02:14:48 INFO - 'TERM': 'linux', 02:14:48 INFO - 'TMOUT': '86400', 02:14:48 INFO - 'USER': 'cltbld', 02:14:48 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:48 INFO - '_': '/tools/buildbot/bin/python'} 02:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:48 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)) 02:14:48 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)) 02:14:48 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)) 02:14:48 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)) 02:14:48 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)) 02:14:48 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)) 02:14:48 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)) 02:14:48 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)) 02:14:48 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)) 02:14:48 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)) 02:14:48 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)) 02:14:48 INFO - Cleaning up... 02:14:48 INFO - Return code: 0 02:14:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:14:48 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')]} 02:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:48 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')]} 02:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:50 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 0xf131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, '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': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', '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 02:14:50 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 02:14:50 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 02:14:50 INFO - Using env: {'DISPLAY': ':0', 02:14:50 INFO - 'HOME': '/home/cltbld', 02:14:50 INFO - 'LANG': 'en_US.UTF-8', 02:14:50 INFO - 'LANGUAGE': 'en_US:en', 02:14:50 INFO - 'LOGNAME': 'cltbld', 02:14:50 INFO - 'MAIL': '/var/mail/cltbld', 02:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:50 INFO - 'MOZ_NO_REMOTE': '1', 02:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:50 INFO - 'NO_EM_RESTART': '1', 02:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:50 INFO - 'PWD': '/builds/slave/test', 02:14:50 INFO - 'SHELL': '/bin/bash', 02:14:50 INFO - 'SHLVL': '1', 02:14:50 INFO - 'TERM': 'linux', 02:14:50 INFO - 'TMOUT': '86400', 02:14:50 INFO - 'USER': 'cltbld', 02:14:50 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:50 INFO - '_': '/tools/buildbot/bin/python'} 02:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:14:50 INFO - Cleaning up... 02:14:50 INFO - Return code: 0 02:14:50 INFO - Running post-action listener: _resource_record_post_action 02:14:50 INFO - Running post-action listener: _start_resource_monitoring 02:14:50 INFO - Starting resource monitoring. 02:14:50 INFO - [mozharness: 2017-04-13 09:14:50.787014Z] Finished create-virtualenv step (success) 02:14:50 INFO - [mozharness: 2017-04-13 09:14:50.787536Z] Running install step. 02:14:50 INFO - Running pre-action listener: _resource_record_pre_action 02:14:50 INFO - Running main action method: install 02:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:50 INFO - Reading from file tmpfile_stdout 02:14:50 INFO - Detecting whether we're running mozinstall >=1.0... 02:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:14:51 INFO - Reading from file tmpfile_stdout 02:14:51 INFO - Output received: 02:14:51 INFO - Usage: mozinstall [options] installer 02:14:51 INFO - Options: 02:14:51 INFO - -h, --help show this help message and exit 02:14:51 INFO - -d DEST, --destination=DEST 02:14:51 INFO - Directory to install application into. [default: 02:14:51 INFO - "/builds/slave/test"] 02:14:51 INFO - --app=APP Application being installed. [default: firefox] 02:14:51 INFO - mkdir: /builds/slave/test/build/application 02:14:51 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'] 02:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:15:07 INFO - Reading from file tmpfile_stdout 02:15:07 INFO - Output received: 02:15:07 INFO - /builds/slave/test/build/application/firefox/firefox 02:15:07 INFO - Running post-action listener: _resource_record_post_action 02:15:07 INFO - [mozharness: 2017-04-13 09:15:07.660029Z] Finished install step (success) 02:15:07 INFO - [mozharness: 2017-04-13 09:15:07.660301Z] Running run-tests step. 02:15:07 INFO - Running pre-action listener: _resource_record_pre_action 02:15:07 INFO - Running main action method: run_tests 02:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:15:07 INFO - Python 2.7.3 02:15:07 INFO - Return code: 0 02:15:07 INFO - grabbing minidump binary from tooltool 02:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:07 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 0x11ae400>, '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 0x11af3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11af840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:15:07 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 02:15:07 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 02:15:07 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 02:15:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:15:07 INFO - Return code: 0 02:15:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:15:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:15:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:15:07 INFO - ENV: RUST_BACKTRACE is now 1 02:15:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:15:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 02:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --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 02:15:07 INFO - Using env: {'DISPLAY': ':0', 02:15:07 INFO - 'HOME': '/home/cltbld', 02:15:07 INFO - 'LANG': 'en_US.UTF-8', 02:15:07 INFO - 'LANGUAGE': 'en_US:en', 02:15:07 INFO - 'LOGNAME': 'cltbld', 02:15:07 INFO - 'MAIL': '/var/mail/cltbld', 02:15:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:15:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:07 INFO - 'MOZ_NO_REMOTE': '1', 02:15:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:07 INFO - 'NO_EM_RESTART': '1', 02:15:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:07 INFO - 'PWD': '/builds/slave/test', 02:15:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:15:07 INFO - 'RUST_BACKTRACE': '1', 02:15:07 INFO - 'SHELL': '/bin/bash', 02:15:07 INFO - 'SHLVL': '1', 02:15:07 INFO - 'TERM': 'linux', 02:15:07 INFO - 'TMOUT': '86400', 02:15:07 INFO - 'USER': 'cltbld', 02:15:07 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754', 02:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:07 INFO - '_': '/tools/buildbot/bin/python'} 02:15:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 02:15:07 INFO - mozversion application_buildid: 20170413074756 02:15:07 INFO - mozversion application_changeset: 4c78da5f6ddacce5332ead124aa734635fc83d8f 02:15:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:15:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:15:07 INFO - mozversion application_name: Firefox 02:15:07 INFO - mozversion application_remotingname: firefox-dev 02:15:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:15:07 INFO - mozversion application_vendor: Mozilla 02:15:07 INFO - mozversion application_version: 54.0a2 02:15:07 INFO - mozversion platform_buildid: 20170413074756 02:15:07 INFO - mozversion platform_changeset: 4c78da5f6ddacce5332ead124aa734635fc83d8f 02:15:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:15:07 INFO - mozversion platform_version: 54.0a2 02:15:07 INFO - using testdate: 1492074907 02:15:07 INFO - actual date: 1492074907 02:15:07 INFO - starting webserver on 'localhost:40369' 02:15:07 INFO - SUITE-START | Running 2 tests 02:15:07 INFO - TEST-START | dromaeo_css 02:15:07 INFO - operating with platform_type : linux_ 02:15:07 INFO - Initialising browser for dromaeo_css test... 02:15:07 INFO - TEST-INFO | started process 12925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR6zf1b/profile http://localhost:40369/getInfo.html) 02:15:11 INFO - PROCESS | 12925 | __metrics Screen width/height:1600/1200 02:15:11 INFO - PROCESS | 12925 | colorDepth:24 02:15:11 INFO - PROCESS | 12925 | Browser inner width/height: 1024/697 02:15:11 INFO - PROCESS | 12925 | __metrics 02:15:12 INFO - PROCESS | 12925 | 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" 02:15:12 INFO - PROCESS | 12925 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:15:13 INFO - TEST-INFO | 12925: exit 0 02:15:13 INFO - Browser initialized. 02:15:13 INFO - Running cycle 1/1 for dromaeo_css test... 02:15:13 INFO - TEST-INFO | started process 13014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR6zf1b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:25 INFO - PROCESS | 13014 | RSS: Main: 139677696 02:15:25 INFO - PROCESS | 13014 | 02:18:26 INFO - PROCESS | 13014 | Cycle 1(1): loaded http://localhost:40369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40369/tests/dromaeo/cssquery-ext.html) 02:18:27 INFO - PROCESS | 13014 | RSS: Main: 280059904 02:18:27 INFO - PROCESS | 13014 | 02:20:15 INFO - PROCESS | 13014 | ************************* 02:20:15 INFO - PROCESS | 13014 | A coding exception was thrown and uncaught in a Task. 02:20:15 INFO - PROCESS | 13014 | 02:20:15 ERROR - PROCESS | 13014 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:15 INFO - PROCESS | 13014 | Full stack: 02:20:15 INFO - PROCESS | 13014 | ************************* 02:20:15 INFO - PROCESS | 13014 | ************************* 02:20:15 INFO - PROCESS | 13014 | A coding exception was thrown and uncaught in a Task. 02:20:15 INFO - PROCESS | 13014 | 02:20:15 ERROR - PROCESS | 13014 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:15 INFO - PROCESS | 13014 | Full stack: 02:20:15 INFO - PROCESS | 13014 | ************************* 02:20:15 INFO - PROCESS | 13014 | ************************* 02:20:15 INFO - PROCESS | 13014 | A coding exception was thrown and uncaught in a Task. 02:20:15 INFO - PROCESS | 13014 | 02:20:15 ERROR - PROCESS | 13014 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:15 INFO - PROCESS | 13014 | Full stack: 02:20:15 INFO - PROCESS | 13014 | ************************* 02:20:15 INFO - PROCESS | 13014 | ************************* 02:20:15 INFO - PROCESS | 13014 | A coding exception was thrown and uncaught in a Task. 02:20:15 INFO - PROCESS | 13014 | 02:20:15 ERROR - PROCESS | 13014 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:15 INFO - PROCESS | 13014 | Full stack: 02:20:15 INFO - PROCESS | 13014 | ************************* 02:21:29 INFO - PROCESS | 13014 | Cycle 1(1): loaded http://localhost:40369/tests/dromaeo/cssquery-ext.html (next: http://localhost:40369/tests/dromaeo/cssquery-jquery.html) 02:21:30 INFO - PROCESS | 13014 | RSS: Main: 216403968 02:21:30 INFO - PROCESS | 13014 | 02:24:32 INFO - PROCESS | 13014 | Cycle 1(1): loaded http://localhost:40369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40369/tests/dromaeo/cssquery-mootools.html) 02:24:32 INFO - PROCESS | 13014 | RSS: Main: 203964416 02:24:32 INFO - PROCESS | 13014 | 02:27:34 INFO - PROCESS | 13014 | Cycle 1(1): loaded http://localhost:40369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40369/tests/dromaeo/cssquery-prototype.html) 02:27:35 INFO - PROCESS | 13014 | RSS: Main: 199299072 02:27:35 INFO - PROCESS | 13014 | 02:30:38 INFO - PROCESS | 13014 | Cycle 1(1): loaded http://localhost:40369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40369/tests/dromaeo/cssquery-yui.html) 02:30:38 INFO - PROCESS | 13014 | RSS: Main: 177459200 02:30:38 INFO - PROCESS | 13014 | 02:33:41 INFO - PROCESS | 13014 | Cycle 1(1): loaded http://localhost:40369/tests/dromaeo/cssquery-yui.html (next: http://localhost:40369/tests/dromaeo/cssquery-dojo.html) 02:33:41 INFO - PROCESS | 13014 | RSS: Main: 265973760 02:33:41 INFO - PROCESS | 13014 | 02:33:41 INFO - PROCESS | 13014 | __start_tp_report 02:33:41 INFO - PROCESS | 13014 | _x_x_mozilla_page_load 02:33:41 INFO - PROCESS | 13014 | _x_x_mozilla_page_load_details 02:33:41 INFO - PROCESS | 13014 | |i|pagename|runs| 02:33:41 INFO - PROCESS | 13014 | |0;dojo.html;3293.2260918684115;3320.2031512437025;3323.385173742857;3340.899773006811;3372.274960883411;5730.25506684131;5741.311042674884;5762.510186634136;5783.652980821148;5798.304203495586;5761.395053519373;5827.067669172933;5832.708364581775;5832.766689332421;5835.649861008332;5241.816536421226;5266.104762190418;5298.96670149321;5314.76083576238;5342.919856202141;5218.739063046852;5220.634555581111;5326.680399176043;5336.786528538853;5341.866453338659;5163.974180129113;5280.683159010452;5320.600954928396;5341.359036915575;5342.759575819097;5326.227696983954;5330.840074797762;5332.68003919766;5333.386660534049;5341.519263266306;5066.82266120684;5224.315691384652;5253.290805741214;5290.523852853224;5292.68243905363;5602.439756024406;5630.943690563083;5678.5741069419955;5709.77160913563;5719.027765279912;6123.908141377883;6126.785562505335;6153.384661533855;6163.907541386883;6175.722092505848;6213.356426872116;6225.470834979033;6234.812955611339;6256.937430625681;6261.029540421242;5596.776128954878;5609.803656872031;5721.284839395075;5732.484076433141;5750.051241545182;6327.462165715873;6331.556791024584;6331.68341582919;6337;6338;6030.33666296707;6083.8174854754425;6091.42131497507;6096.817095487142;6097.298810636834;6005.549583781234;6044.455998960115;6053.7578496860515;6069.848253793691;6188.845278868064;6113.6331820090045;6113.719560719409;6133.815985520441;6134.4172303631085;6135.509159267248;5970.49250813677;6014;6090.147379366892;6112.113743507167;6131.233595800525;4667.696599721007;4701.200795864711;4714.316424118484;4716.103940251342;4738.455077666113;4074.246264441088;4078.7552746835286;4090.386442033659;4199.748015119103;4202.789860506962;5905.143754155623;5930.436608522184;5947.583669143119;5958.046712526062;5965.403459654;6145.262568491809;6152.815415537541;6177.722002509898;6190.102435146879;6195.380461953859;5726.856828579235;5907.261592300963;5910.408959104141;5910.70446477683;5916.171735956969;5144.4855514449;5194.298769666122;5244.895102097937;5245.947540524546;5263.157894736823;6430.485561155097;6433.388828061326;6434.453071488976;6471.902921456276;6471.935280647227;6153.2000839890525;6219.160413344141;6228.56400051992;6240.095186198067;6242.625442473466;6195.628262304276;6254.781082662085;6360.4911607072245;6373.6175829450385;6485.708143133476;6129.847850912965;6132.569672417391;6135.293912123373;6144.10910417978;6146.170267013896;6240.594361366497;6255.78104766331;6257.342978987141;6260.7495700171485;6265.749370025148;5783.7397317119985;5848.678322692293;5934.495567876779;5977.940220597912;6088.360722124113;5955.225820643289;6019.488343490677;6029.065494848305;6033.577649564489;6054.939450605438;5788.450097240755;5942.762289508371;5943.613665111754;5958.880822383615;5976.402359763989;5983.700814959322;6008.789692360747;6009.098635204579;6034.39656034393;6134.2332208473945;5954.821355359346;5959.880802384015;5963.731632076654;5964.224650795369;5997.820065398045 02:33:41 INFO - PROCESS | 13014 | |1;ext.html;772.1429213572933;842.9325653947684;858.4720396955872;920.8066306075724;932.6176267730232;31805.52291715623;45501;45889.31166032512;45909;46066.53933460664;47051;47166.29250561236;47193.29210061843;47293.527064729344;47346.289805652945;5263.86840328991;5322.92015619766;9180.54097295136;9335.3465257432;9342.953285233598;10216.13162881156;10412.791744165112;10756.569737210502;10767.62313319034;10776.245662803607;10529.2103092268;10575.735606609858;10579.735506612358;10585;10587.311824731407;10490.58037678492;10494.160467162685;10506.632267870664;10518.842217366746;10536.05175534198;10606.734831629194;10659.253852230348;10663.84004239937;10671.146308295318;10677.679669609925;43645.345319820226;43746;43758.34362484565;43937.34093988593;44049.77975110136;4188.81150348235;4200.873973780792;4229.217594744982;4307.095509942916;4348.173846969065;29539.556906646416;30090.699093009007;30209.848950755324;30708.8464557678;31654.683453165402;4206.663466922639;4212.68404869636;4245.27830268855;4285.9785701071605;4456.866294011153;263363;265126;265447;265520;265787.6710616454;46502.76748616235;46671.76664116658;46700.29949550759;46717.06565868664;46731;47435;47693.284600731015;47848.760756195996;47857.521424786006;47895.28157077647;15097.24513774307;15495;15495.612609684622;15498.147601882005;15520.456784012506;10967.561297548169;11116.722081947853;13487.05590608648;13504.594862154152;13515.797263041062;13029.543965961146;13211.669708257179;13312.733745325233;13404.463821447229;13412.195268283935;5387.730613469311;5475.67145971235;5527.419620939824;5555.833325000256;5588.860278492989;1019.2814066083394;1021.2595867995792;1029.3206483720708;1033.679559336608;1034.1364960258268;28123.57814632782;29044.709552904624;29191;29216;29757.40485190284;1077.0737166037202;1099.6920862158609;1101.983470247947;1108.7560736637927;1117.0449265877558;14096.929515352564;16467.34130634785;16866.746998795028;17878.821211787978;17914.193861276275;356117;359420;359725;360449;361801;59313.703431482565;59565.10652340218;59730;59868;59914.70042649759;1487.1820498725658;1543.4906480861289;1558.3221298735086;1563.796706428157;1568.913709745952;31219;32969.835150824096;32999.835000824845;33248;33283;43840.12319753651;44120.779396102815;44320.335194972744;44430.11139777251;44508;321749;321942;322033;322725;322774;26375.868120659274;31633.367332652757;32650.673493265713;33270.83364583162;34282.828585856914;44608.77695611501;44648.33027504655;44967.77516112399;45597;46478;33898.66101338955;34570.48144277888;34829.65170348264;35001.47497787586;35023;33389.66610333963;33440.832795835864;33470;33511.49732753962;33519.49720754142;38499.2300154001;38956.415653765784;39417.40873886951;39510.40734389044;39557.40663889986;32403;32582.83708581442;32600.184995375304;32841;32922.67077329196;25063.624045639695;26432;26490.337741555843;26512.337191570365;26589.92949149195 02:33:41 INFO - PROCESS | 13014 | |2;jquery.html;438.3074741907786;462.6368300883807;474.1086756897033;478.7295178224303;482.91548978928677;19245.42263732087;20826.479338016557;20844.583108337825;20967.790322096775;21259.787402125974;21902.671459928075;22406.88796556015;22547.54904901901;22639.660405093935;22704.65943010856;5395.487428694268;6713.664316784178;6779.966100169492;6992.195897471805;7026.7189312427445;6716.3283671632935;6830.351116643936;6836.384725374715;6842.760503382383;6844.863102737967;6590.769323073693;6767.59394436333;6867.416269617089;6871.965640171792;6874;6802.08171896795;6826.283240259801;6857.211420686635;6861.656917154122;6907.861842763142;6436.903446448307;6642.036904648799;6653.567518111356;6656.234533028715;6661.067450556926;24977.62533561998;25104.372390690198;25231.495370092496;25259.873700631564;25303.62044569333;3230.91922701932;3242.1084201844446;3256.234784825564;3277.4919887417486;3306.1073510152123;15926.442574509952;16110.597235069099;16433.67132657352;16680.58298542534;16960.915195423942;2169.783021697833;2215.490437199453;2278.2140161644206;2283.223703940668;2448.3879030242438;102754.48622756838;119482.40258798651;121513.39243303816;124700;127351;21255;21294.36116916495;21443.39174561914;21979.780202198093;22180.88909555442;40205.79897100496;40529;40642.79678601647;40782.79608601938;41038;10345.793084138275;10576;10656.413897235572;10716.946415267874;10794.73013174677;8826.161514656098;8914.548499162653;8959.820803584022;9146.95426522863;9149.130832570896;8929.464232146092;9354.485503297385;9404.717858464257;9453.905460945303;9641.180499657466;3342.5487559179687;3435.4159792835276;3642.162302670348;3723.3856413691437;3871.709621778378;962.1148543340144;970.6263088710756;980.6959842448864;982.219135787051;982.5332966840837;20643.380698579065;21149.57700846005;21205.78794212038;21270.255541055987;22236.55526889453;1017.2472370445817;1020.9234307426973;1029.8815636201782;1045.8065257927308;1050.201846596592;7171.641417929082;7285.854282914312;7403.51877127985;7536.397088233038;7540.660670269741;339615;383256;685129;707089;740103;71131;104338.47830760798;114328;115681;120579.39710301568;1209.2925638501574;1324.4503531034704;1383.1770096792593;1386.9167849929036;1394.8395934467462;18812.153453094368;19351.612967740846;19481.70777438311;19521.511962201057;19583.60832783365;50967;51566.22650660318;52470.73764631152;53079.734601326745;53886.730566346916;68268.6586567064;69089;70016.29983700097;70123;71728;12484.188527745668;12507.874921250672;12840.422181002064;12916.354182291036;12961.287129207607;13763.105398149088;13834.100783449043;13853.445862165401;13971.231582263074;14208.57914208571;12596.937015314865;12715.10994230395;12723.363831808558;12791.744165116459;12832.935835320764;6098.786542470993;11493.482793274155;11590.652280431601;11747.29516229029;12059;12442.37788110609;12517.186382885084;12527.812082818582;12833.679158021125;12861.485540578273;12776;12836.229826210458;12850.228986260854;12894.613161605166;13138.934305328412;12335.074869384653;12567.245965242115;12587.307698076695;12709.4280757368;13065.738685226052 02:33:41 INFO - PROCESS | 13014 | |3;mootools.html;1519.3694616734056;1525.2602487793424;1526.3063386604417;1563.7185306644806;1577.203512226326;11004.339739615618;11676.591319303827;11684;11693.707657308561;11721.413929303544;11035.72410689731;11354.375509346983;11361.318320900731;11363.090952723784;11402.942985285083;2382.8689422081734;2419.0565679385054;2420.2376251480728;2425.320910145162;2431.987840060806;2384.4158181245534;2455.2511483997373;2476.4304210031705;2477.752224777517;2503.949921001588;2375.6436534519876;2440.511897620474;2450.6569080328677;2461.1509029384833;2475.121331927167;2294.9541009179725;2325.4186453386656;2329.534093181362;2332.88335583221;2421.1889017179265;2373.6202207646866;2391.964120538193;2401.11158871217;2402.7957623602015;2405.0620258099357;11390.202685811997;11625.534978600846;11630.360330181837;11635.76728465426;11636.94181529087;5564.527015203672;5702.714864256812;5714.457126572969;5717.828465146053;5718.399568045378;3378.763486555942;3426.640202778722;3433.9828300858335;3473.5831700195886;3491.284286721216;1285.119693010291;1308.829852119228;1313.934303284832;1327.3230652367265;1377.22875189894;14491.78262326066;14883.776743348859;16261.837381626268;16949.406770762966;17153;4372.453443319585;4520.095980803852;4648.3259927310355;4651.674382793172;4658.324542941255;10677.466126693635;10977.506012229309;12434.440450179764;13069.607911762663;13149.934250328879;5574.247476590608;5738.483536481736;5739.311282646109;5740.253767010262;5740.966626007275;5244.632875698664;5290.470952904679;5294.126469132627;5297.311349524614;5298.178782288752;3905.843766249375;3924.5879182685976;3947.5460322062754;3992.6207010333974;4004.839806407711;979.911807937289;987.7925635616457;990.1187942730975;992.2409356842022;1001.5377548778864;1049.6221360310283;1053.2995557954027;1056.1181413519644;1058.1164727452663;1065.6430095917954;6995.755148569878;7043.6830342633675;7130.821729456701;7159.498835081598;7223.133224013152;1037.7820657661975;1037.911777498921;1051.8685164354456;1059.4649701900491;1098.4507746126937;4505.864824055284;4573.176828170895;4635.304704294383;4674.298855171752;4707.176244157259;14538;15135.848641513665;15146.242687865562;15156;15162;13565.253911034988;14172.574822755334;14584.927075364767;15049.247537623294;15065.849341506444;10543.630972915911;10702.09032232269;10718.303310284806;10726.731831704114;10729.141668666489;7266.854662906818;7540.622968851645;7597.734079307198;7634;7694.07671079474;12971.481140754264;13102.934485327512;13113.737725245252;13301.933490332487;13506.189628622315;12330.445129968994;13383.263920484467;13440.193588384729;13454.798178027142;13549.390277437342;10381;10646.20153488476;10873.673789786319;10923.344599324066;10931.289466184673;10968.506417211403;11100.722481938015;11144.777104458028;11174.832377514182;11179.0497807684;9240.491772952551;9246.167844893991;9318.95340523293;9343.252539796664;9553.283503737108;9057.04900985387;9296.628134874529;9341.859872102059;9346.11211934865;9648.71053868357;8276.420650554403;8314.501129931981;8342.082370939313;8380.20388063133;8423.747287581382;6659.334066593302;6772.830679233059;6796.116504854535;6847.760328388483;6874.140732408449;6327.873442531216;6439.7424103035355;6454.1609590752905;6545.443637290884;6618.6690665467495 02:33:41 INFO - PROCESS | 13014 | |4;prototype.html;410.7946026986507;418.9727667701599;432.79442264924165;449.74364612171064;451.4559955253918;5116.925445656412;5143.81996630118;5174.637775355717;5181.766820493082;5220.138677118271;5022.321986531817;5046.167382381912;5122.231665250214;5136.38363396392;5182.481751824825;4389.868303950887;4412.735235885857;4416.425864637593;4423.734575925455;4444.666650001247;4418.337249412598;4451.666125040619;4462.241418958784;4464.308032255006;4498.685092043558;4205.390218418343;4383.531516941828;4392.275274579706;4419.381286619876;4420.3369494575745;4326.906262022638;4333.306670932667;4376.956230437702;4390.319500477415;4397.856557295095;4124.175164967019;4151.066010147722;4153.356229784388;4153.563875793028;4238.109996900655;4948.455669876311;5012.949870501285;5031.723255220962;5047.49525047496;5094.6688465249645;5048.964962182744;5069.163588007974;5075.4163271223915;5084.77118529667;5105.489451054902;5466.009812836652;5490.945090549083;5500.779968801243;5518.454832646825;5519.715769117369;4422.226110430694;4496.865094047183;4549.885278106852;4561.885952851172;4588.609968152711;5376.758045887945;5437.8368648940595;5455.345358556999;5632.662040277596;5663.801766938179;4591.268195423718;4624;4629.9582593916775;4638.512956139557;4697.459792123949;4523.625096824194;4563.794629241692;4627.5603817637275;4753.787784115028;4777;4996.950030499648;5007.599392048627;5029.220470827027;5034.590314711886;5051.166557518042;5413.918791218135;5415.642301772926;5425;5441.564674826004;5459.808906688247;1567.8197007344074;1612.4759453177764;1625.2198944506704;1639.6392793585392;1642.8849980501489;1247.4137155537064;1260.7793636113643;1266.9294446192953;1274.337344580813;1275.005495713345;5348.582625604218;5416.9729151353995;5417.4311697272005;5443.374011988592;5469.972650136803;5559.9444005560235;5585.240649195491;5618.353889302783;5619.454649971291;5624.612802014353;5209.453007434165;5379.650322729089;5388.595855310789;5412.5940554458575;5447.182922561568;2967.095036013993;2968.3321252717965;2975.1372102090586;2984.418038482475;2988.9402211956076;5546.893739505889;5862.501687356623;5865.794697185578;5906.26171728534;5909.990603194934;5681.573881958787;5725.484706376446;5755.309362876482;5775.682337471395;5781.595288329777;5731.710365167887;5756.273118064564;5774.42255774436;5813.7383817728305;5838.241028666246;5282.490816862113;5554.750036248298;5560.527355174855;5570.777168913198;5601.915971260516;5268.868278293074;5357.767713425856;5369.221462887781;5393.217983392465;5463.4536546346635;5681.971590142023;5759.366469688247;5769.307683078057;5783.797567085132;5811.767529298781;4581.839635612738;4651.744029112188;4701.531695859701;4715.78778954941;4724.8660321523275;5614.915776263278;5652.293463317085;5652.349979752381;5658.801941932013;5681.9147712783515;5417.214503896834;5444.992676354887;5451.236826844166;5508.366537848199;5530.198121272473;5189.273501709839;5413.648112872651;5419.83740487786;5490.91763623538;5504.339479262354;5393.649412788156;5407.351117865881;5411.702356370437;5426.945730542802;5442.809501667422;5284.471552844685;5408.4321146280645;5477.1510415885605;5483.464629903633;5504;5251.553617942518;5285.841424757264;5309.681419114865;5335.359756829205;5374.704391258362 02:33:41 INFO - PROCESS | 13014 | |5;yui.html;850.7830503221678;892.0276898180989;892.7321803458963;896.5920506169693;901.3955159815526;16246.675066498663;18070.909645451786;18104.728429073573;18380.356687515923;18425.170867310968;15994.120323382209;16068.437604683839;16114.033158010527;16126.435574754856;16134.193290335495;883.5538053283099;884.0584777212281;903.0743487924864;906.1799071839962;906.2432868554732;882.1972005475019;893.7408151636017;896.1576118448637;904.4754042655244;904.5477261369315;940.3135710931025;941.8163458125669;942.0814705661959;943.981120377592;944.1313991128178;920.4431319051978;924.6624981881632;926.9582868770922;927.3508544019213;928.633189889993;680.7004917836136;681.7034589953337;682.3756263019332;682.3960794696729;682.4097155960109;16201.10893900835;16446.83553164477;16563.66872662552;16934.322627095025;17124.14379281031;15262;15606.219689015617;15809.446669366633;16036;16323.26545305464;12658.367081645882;13258;13271.66820829487;13294.3352832358;13335.266560339178;3988.860389886369;4028.3353246714255;4043.191361727637;4144.896377590584;4157.792110394468;90225.54887225523;90513.09486905113;90828.54585727162;92493.53753231258;94963.52518237433;11271.718207044725;11308.773824523463;11322.773544529227;11447.198696091195;11473.54105835774;22543.323700289016;22665.660015099787;22825.657615135788;22989.310320690405;23035.88482057579;8452.1547845215;8547.230749232598;8553.486790792573;8648.43785153963;8796.34027447944;4524.954750452519;4586.862394128181;4649.465311489154;4653.511381304982;4711.929321060187;3810.599887011879;3910.648041676263;3916.5104361954754;3917.6474117329576;3920.4707364506;591.1221835574169;595.1756816808664;605.0289285696482;607.3744043635063;609.4880300547561;815.4332738746514;822.5352675738188;839.7816567692444;847.1655419411875;854.4232642966098;10919.672409827717;11479.655610331703;11749.47127379253;11778.941105294418;12080.275183489019;756.6935391166586;757.6514803190483;764.8546776112521;776.2703059124404;782.7886470652892;5393.541548968382;5412.621116521885;5421.5933804964;5492.148716948799;5502.972485137629;75253;77583.22416775873;84807.15192847993;84985.57507212424;86635.56682216674;67095.32904670891;67377.66311168413;67399;68101;70018;62984;63492;63643.681781591724;63826;64040;11558.537658493566;11803.291802491878;11902.761944761229;11947.402629868298;12201.755964880474;40709.59290407177;41415.7929210352;41746.37380439357;42065.369019465346;42955.7852210737;46270;46621;47669;47799.52200477951;48972.51027489822;13412.530561430693;13669.453221871014;13785.862141378459;13824.239666818421;13922.095063821225;15737.213139343216;15862.60343491422;15872.206389680701;15976.20118994069;16357.182140893146;14801.629959250675;15080.170590617621;15403.460878869186;15609.375624974873;16126.2743176555;14035.666611671875;14900.32948517341;15676.294566744296;15854.524364269091;16199.676006479569;14087.647808804863;14687.92656036713;14843.628909277355;15569.84430155684;15907.602309941882;10798.244122911636;10905.781884362426;11621;12025.158238923192;12491.312977785945;12757.48970041188;12776.425060872469;12901.806472903101;13111.73776524445;13168.539101131415 02:33:41 INFO - PROCESS | 13014 | __end_tp_report 02:33:41 INFO - PROCESS | 13014 | __start_cc_report 02:33:41 INFO - PROCESS | 13014 | _x_x_mozilla_cycle_collect,1378 02:33:41 INFO - PROCESS | 13014 | __end_cc_report 02:33:41 INFO - PROCESS | 13014 | __startTimestamp1492076021537__endTimestamp 02:33:41 INFO - PROCESS | 13014 | 02:33:41 INFO - PROCESS | 13014 | ------- Summary: start ------- 02:33:41 INFO - PROCESS | 13014 | Number of tests: 6 02:33:41 INFO - PROCESS | 13014 | 02:33:41 INFO - PROCESS | 13014 | [#0] dojo.html Cycles:165 Average:5729.07 Median:5958.88 stddev:656.78 (11.0%) stddev-sans-first:630.38 02:33:41 INFO - PROCESS | 13014 | Values: 3293.2 3320.2 3323.4 3340.9 3372.3 5730.3 5741.3 5762.5 5783.7 5798.3 5761.4 5827.1 5832.7 5832.8 5835.6 5241.8 5266.1 5299.0 5314.8 5342.9 5218.7 5220.6 5326.7 5336.8 5341.9 5164.0 5280.7 5320.6 5341.4 5342.8 5326.2 5330.8 5332.7 5333.4 5341.5 5066.8 5224.3 5253.3 5290.5 5292.7 5602.4 5630.9 5678.6 5709.8 5719.0 6123.9 6126.8 6153.4 6163.9 6175.7 6213.4 6225.5 6234.8 6256.9 6261.0 5596.8 5609.8 5721.3 5732.5 5750.1 6327.5 6331.6 6331.7 6337.0 6338.0 6030.3 6083.8 6091.4 6096.8 6097.3 6005.5 6044.5 6053.8 6069.8 6188.8 6113.6 6113.7 6133.8 6134.4 6135.5 5970.5 6014.0 6090.1 6112.1 6131.2 4667.7 4701.2 4714.3 4716.1 4738.5 4074.2 4078.8 4090.4 4199.7 4202.8 5905.1 5930.4 5947.6 5958.0 5965.4 6145.3 6152.8 6177.7 6190.1 6195.4 5726.9 5907.3 5910.4 5910.7 5916.2 5144.5 5194.3 5244.9 5245.9 5263.2 6430.5 6433.4 6434.5 6471.9 6471.9 6153.2 6219.2 6228.6 6240.1 6242.6 6195.6 6254.8 6360.5 6373.6 6485.7 6129.8 6132.6 6135.3 6144.1 6146.2 6240.6 6255.8 6257.3 6260.7 6265.7 5783.7 5848.7 5934.5 5977.9 6088.4 5955.2 6019.5 6029.1 6033.6 6054.9 5788.5 5942.8 5943.6 5958.9 5976.4 5983.7 6008.8 6009.1 6034.4 6134.2 5954.8 5959.9 5963.7 5964.2 5997.8 02:33:41 INFO - PROCESS | 13014 | 02:33:41 INFO - PROCESS | 13014 | [#1] ext.html Cycles:180 Average:48361.45 Median:32984.84 stddev:83247.71 (252.4%) stddev-sans-first:83404.56 02:33:41 INFO - PROCESS | 13014 | Values: 772.1 842.9 858.5 920.8 932.6 31805.5 45501.0 45889.3 45909.0 46066.5 47051.0 47166.3 47193.3 47293.5 47346.3 5263.9 5322.9 9180.5 9335.3 9343.0 10216.1 10412.8 10756.6 10767.6 10776.2 10529.2 10575.7 10579.7 10585.0 10587.3 10490.6 10494.2 10506.6 10518.8 10536.1 10606.7 10659.3 10663.8 10671.1 10677.7 43645.3 43746.0 43758.3 43937.3 44049.8 4188.8 4200.9 4229.2 4307.1 4348.2 29539.6 30090.7 30209.8 30708.8 31654.7 4206.7 4212.7 4245.3 4286.0 4456.9 263363.0 265126.0 265447.0 265520.0 265787.7 46502.8 46671.8 46700.3 46717.1 46731.0 47435.0 47693.3 47848.8 47857.5 47895.3 15097.2 15495.0 15495.6 15498.1 15520.5 10967.6 11116.7 13487.1 13504.6 13515.8 13029.5 13211.7 13312.7 13404.5 13412.2 5387.7 5475.7 5527.4 5555.8 5588.9 1019.3 1021.3 1029.3 1033.7 1034.1 28123.6 29044.7 29191.0 29216.0 29757.4 1077.1 1099.7 1102.0 1108.8 1117.0 14096.9 16467.3 16866.7 17878.8 17914.2 356117.0 359420.0 359725.0 360449.0 361801.0 59313.7 59565.1 59730.0 59868.0 59914.7 1487.2 1543.5 1558.3 1563.8 1568.9 31219.0 32969.8 32999.8 33248.0 33283.0 43840.1 44120.8 44320.3 44430.1 44508.0 321749.0 321942.0 322033.0 322725.0 322774.0 26375.9 31633.4 32650.7 33270.8 34282.8 44608.8 44648.3 44967.8 45597.0 46478.0 33898.7 34570.5 34829.7 35001.5 35023.0 33389.7 33440.8 33470.0 33511.5 33519.5 38499.2 38956.4 39417.4 39510.4 39557.4 32403.0 32582.8 32600.2 32841.0 32922.7 25063.6 26432.0 26490.3 26512.3 26589.9 02:33:41 INFO - PROCESS | 13014 | 02:33:41 INFO - PROCESS | 13014 | [#2] jquery.html Cycles:180 Average:35455.48 Median:2280.72 stddev:98933.14 (4337.8%) stddev-sans-first:99175.73 02:33:41 INFO - PROCESS | 13014 | Values: 438.3 462.6 474.1 478.7 482.9 19245.4 20826.5 20844.6 20967.8 21259.8 21902.7 22406.9 22547.5 22639.7 22704.7 5395.5 6713.7 6780.0 6992.2 7026.7 6716.3 6830.4 6836.4 6842.8 6844.9 6590.8 6767.6 6867.4 6872.0 6874.0 6802.1 6826.3 6857.2 6861.7 6907.9 6436.9 6642.0 6653.6 6656.2 6661.1 24977.6 25104.4 25231.5 25259.9 25303.6 3230.9 3242.1 3256.2 3277.5 3306.1 15926.4 16110.6 16433.7 16680.6 16960.9 2169.8 2215.5 2278.2 2283.2 2448.4 102754.5 119482.4 121513.4 124700.0 127351.0 21255.0 21294.4 21443.4 21979.8 22180.9 40205.8 40529.0 40642.8 40782.8 41038.0 10345.8 10576.0 10656.4 10716.9 10794.7 8826.2 8914.5 8959.8 9147.0 9149.1 8929.5 9354.5 9404.7 9453.9 9641.2 3342.5 3435.4 3642.2 3723.4 3871.7 962.1 970.6 980.7 982.2 982.5 20643.4 21149.6 21205.8 21270.3 22236.6 1017.2 1020.9 1029.9 1045.8 1050.2 7171.6 7285.9 7403.5 7536.4 7540.7 339615.0 383256.0 685129.0 707089.0 740103.0 71131.0 104338.5 114328.0 115681.0 120579.4 1209.3 1324.5 1383.2 1386.9 1394.8 18812.2 19351.6 19481.7 19521.5 19583.6 50967.0 51566.2 52470.7 53079.7 53886.7 68268.7 69089.0 70016.3 70123.0 71728.0 12484.2 12507.9 12840.4 12916.4 12961.3 13763.1 13834.1 13853.4 13971.2 14208.6 12596.9 12715.1 12723.4 12791.7 12832.9 6098.8 11493.5 11590.7 11747.3 12059.0 12442.4 12517.2 12527.8 12833.7 12861.5 12776.0 12836.2 12850.2 12894.6 13138.9 12335.1 12567.2 12587.3 12709.4 13065.7 02:33:41 INFO - PROCESS | 13014 | 02:33:41 INFO - PROCESS | 13014 | [#3] mootools.html Cycles:180 Average:7143.87 Median:2401.95 stddev:4540.58 (189.0%) stddev-sans-first:4533.65 02:33:41 INFO - PROCESS | 13014 | Values: 1519.4 1525.3 1526.3 1563.7 1577.2 11004.3 11676.6 11684.0 11693.7 11721.4 11035.7 11354.4 11361.3 11363.1 11402.9 2382.9 2419.1 2420.2 2425.3 2432.0 2384.4 2455.3 2476.4 2477.8 2503.9 2375.6 2440.5 2450.7 2461.2 2475.1 2295.0 2325.4 2329.5 2332.9 2421.2 2373.6 2392.0 2401.1 2402.8 2405.1 11390.2 11625.5 11630.4 11635.8 11636.9 5564.5 5702.7 5714.5 5717.8 5718.4 3378.8 3426.6 3434.0 3473.6 3491.3 1285.1 1308.8 1313.9 1327.3 1377.2 14491.8 14883.8 16261.8 16949.4 17153.0 4372.5 4520.1 4648.3 4651.7 4658.3 10677.5 10977.5 12434.4 13069.6 13149.9 5574.2 5738.5 5739.3 5740.3 5741.0 5244.6 5290.5 5294.1 5297.3 5298.2 3905.8 3924.6 3947.5 3992.6 4004.8 979.9 987.8 990.1 992.2 1001.5 1049.6 1053.3 1056.1 1058.1 1065.6 6995.8 7043.7 7130.8 7159.5 7223.1 1037.8 1037.9 1051.9 1059.5 1098.5 4505.9 4573.2 4635.3 4674.3 4707.2 14538.0 15135.8 15146.2 15156.0 15162.0 13565.3 14172.6 14584.9 15049.2 15065.8 10543.6 10702.1 10718.3 10726.7 10729.1 7266.9 7540.6 7597.7 7634.0 7694.1 12971.5 13102.9 13113.7 13301.9 13506.2 12330.4 13383.3 13440.2 13454.8 13549.4 10381.0 10646.2 10873.7 10923.3 10931.3 10968.5 11100.7 11144.8 11174.8 11179.0 9240.5 9246.2 9319.0 9343.3 9553.3 9057.0 9296.6 9341.9 9346.1 9648.7 8276.4 8314.5 8342.1 8380.2 8423.7 6659.3 6772.8 6796.1 6847.8 6874.1 6327.9 6439.7 6454.2 6545.4 6618.7 02:33:41 INFO - PROCESS | 13014 | 02:33:41 INFO - PROCESS | 13014 | [#4] prototype.html Cycles:180 Average:4762.55 Median:5214.80 stddev:1258.09 (24.1%) stddev-sans-first:1218.49 02:33:41 INFO - PROCESS | 13014 | Values: 410.8 419.0 432.8 449.7 451.5 5116.9 5143.8 5174.6 5181.8 5220.1 5022.3 5046.2 5122.2 5136.4 5182.5 4389.9 4412.7 4416.4 4423.7 4444.7 4418.3 4451.7 4462.2 4464.3 4498.7 4205.4 4383.5 4392.3 4419.4 4420.3 4326.9 4333.3 4377.0 4390.3 4397.9 4124.2 4151.1 4153.4 4153.6 4238.1 4948.5 5012.9 5031.7 5047.5 5094.7 5049.0 5069.2 5075.4 5084.8 5105.5 5466.0 5490.9 5500.8 5518.5 5519.7 4422.2 4496.9 4549.9 4561.9 4588.6 5376.8 5437.8 5455.3 5632.7 5663.8 4591.3 4624.0 4630.0 4638.5 4697.5 4523.6 4563.8 4627.6 4753.8 4777.0 4997.0 5007.6 5029.2 5034.6 5051.2 5413.9 5415.6 5425.0 5441.6 5459.8 1567.8 1612.5 1625.2 1639.6 1642.9 1247.4 1260.8 1266.9 1274.3 1275.0 5348.6 5417.0 5417.4 5443.4 5470.0 5559.9 5585.2 5618.4 5619.5 5624.6 5209.5 5379.7 5388.6 5412.6 5447.2 2967.1 2968.3 2975.1 2984.4 2988.9 5546.9 5862.5 5865.8 5906.3 5910.0 5681.6 5725.5 5755.3 5775.7 5781.6 5731.7 5756.3 5774.4 5813.7 5838.2 5282.5 5554.8 5560.5 5570.8 5601.9 5268.9 5357.8 5369.2 5393.2 5463.5 5682.0 5759.4 5769.3 5783.8 5811.8 4581.8 4651.7 4701.5 4715.8 4724.9 5614.9 5652.3 5652.3 5658.8 5681.9 5417.2 5445.0 5451.2 5508.4 5530.2 5189.3 5413.6 5419.8 5490.9 5504.3 5393.6 5407.4 5411.7 5426.9 5442.8 5284.5 5408.4 5477.2 5483.5 5504.0 5251.6 5285.8 5309.7 5335.4 5374.7 02:33:41 INFO - PROCESS | 13014 | 02:33:41 INFO - PROCESS | 13014 | [#5] yui.html Cycles:180 Average:18492.81 Median:4151.34 stddev:23231.55 (559.6%) stddev-sans-first:23258.95 02:33:41 INFO - PROCESS | 13014 | Values: 850.8 892.0 892.7 896.6 901.4 16246.7 18070.9 18104.7 18380.4 18425.2 15994.1 16068.4 16114.0 16126.4 16134.2 883.6 884.1 903.1 906.2 906.2 882.2 893.7 896.2 904.5 904.5 940.3 941.8 942.1 944.0 944.1 920.4 924.7 927.0 927.4 928.6 680.7 681.7 682.4 682.4 682.4 16201.1 16446.8 16563.7 16934.3 17124.1 15262.0 15606.2 15809.4 16036.0 16323.3 12658.4 13258.0 13271.7 13294.3 13335.3 3988.9 4028.3 4043.2 4144.9 4157.8 90225.5 90513.1 90828.5 92493.5 94963.5 11271.7 11308.8 11322.8 11447.2 11473.5 22543.3 22665.7 22825.7 22989.3 23035.9 8452.2 8547.2 8553.5 8648.4 8796.3 4525.0 4586.9 4649.5 4653.5 4711.9 3810.6 3910.6 3916.5 3917.6 3920.5 591.1 595.2 605.0 607.4 609.5 815.4 822.5 839.8 847.2 854.4 10919.7 11479.7 11749.5 11778.9 12080.3 756.7 757.7 764.9 776.3 782.8 5393.5 5412.6 5421.6 5492.1 5503.0 75253.0 77583.2 84807.2 84985.6 86635.6 67095.3 67377.7 67399.0 68101.0 70018.0 62984.0 63492.0 63643.7 63826.0 64040.0 11558.5 11803.3 11902.8 11947.4 12201.8 40709.6 41415.8 41746.4 42065.4 42955.8 46270.0 46621.0 47669.0 47799.5 48972.5 13412.5 13669.5 13785.9 13824.2 13922.1 15737.2 15862.6 15872.2 15976.2 16357.2 14801.6 15080.2 15403.5 15609.4 16126.3 14035.7 14900.3 15676.3 15854.5 16199.7 14087.6 14687.9 14843.6 15569.8 15907.6 10798.2 10905.8 11621.0 12025.2 12491.3 12757.5 12776.4 12901.8 13111.7 13168.5 02:33:41 INFO - PROCESS | 13014 | -------- Summary: end -------- 02:33:41 INFO - PROCESS | 13014 | 02:33:42 INFO - TEST-INFO | 13014: exit 0 02:33:42 INFO - TEST-OK | dromaeo_css | took 1114346ms 02:33:42 INFO - TEST-START | kraken 02:33:42 INFO - operating with platform_type : linux_ 02:33:42 INFO - Initialising browser for kraken test... 02:33:42 INFO - TEST-INFO | started process 13336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNA0ldR/profile http://localhost:40369/getInfo.html) 02:33:45 INFO - PROCESS | 13336 | __metrics Screen width/height:1600/1200 02:33:45 INFO - PROCESS | 13336 | colorDepth:24 02:33:45 INFO - PROCESS | 13336 | Browser inner width/height: 1024/697 02:33:45 INFO - PROCESS | 13336 | __metrics 02:33:46 INFO - PROCESS | 13336 | 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" 02:33:46 INFO - PROCESS | 13336 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:47 INFO - TEST-INFO | 13336: exit 0 02:33:47 INFO - Browser initialized. 02:33:47 INFO - Running cycle 1/1 for kraken test... 02:33:47 INFO - TEST-INFO | started process 13429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNA0ldR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:59 INFO - PROCESS | 13429 | RSS: Main: 140304384 02:33:59 INFO - PROCESS | 13429 | 02:34:01 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40369/tests/kraken/driver.html?testName=audio-beat-detection) 02:34:02 INFO - PROCESS | 13429 | RSS: Main: 182853632 02:34:02 INFO - PROCESS | 13429 | 02:34:05 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40369/tests/kraken/driver.html?testName=audio-dft) 02:34:05 INFO - PROCESS | 13429 | RSS: Main: 173875200 02:34:05 INFO - PROCESS | 13429 | 02:34:08 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40369/tests/kraken/driver.html?testName=audio-fft) 02:34:09 INFO - PROCESS | 13429 | RSS: Main: 265478144 02:34:09 INFO - PROCESS | 13429 | 02:34:11 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40369/tests/kraken/driver.html?testName=audio-oscillator) 02:34:11 INFO - PROCESS | 13429 | RSS: Main: 171479040 02:34:11 INFO - PROCESS | 13429 | 02:34:14 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:34:14 INFO - PROCESS | 13429 | RSS: Main: 174465024 02:34:14 INFO - PROCESS | 13429 | 02:34:17 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40369/tests/kraken/driver.html?testName=imaging-darkroom) 02:34:18 INFO - PROCESS | 13429 | RSS: Main: 212586496 02:34:18 INFO - PROCESS | 13429 | 02:34:21 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40369/tests/kraken/driver.html?testName=imaging-desaturate) 02:34:22 INFO - PROCESS | 13429 | RSS: Main: 211189760 02:34:22 INFO - PROCESS | 13429 | 02:34:24 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40369/tests/kraken/driver.html?testName=json-parse-financial) 02:34:25 INFO - PROCESS | 13429 | RSS: Main: 210264064 02:34:25 INFO - PROCESS | 13429 | 02:34:27 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:34:27 INFO - PROCESS | 13429 | RSS: Main: 173150208 02:34:27 INFO - PROCESS | 13429 | 02:34:29 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40369/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:34:29 INFO - PROCESS | 13429 | RSS: Main: 179445760 02:34:29 INFO - PROCESS | 13429 | 02:34:32 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:34:32 INFO - PROCESS | 13429 | RSS: Main: 184762368 02:34:32 INFO - PROCESS | 13429 | 02:34:35 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:34:35 INFO - PROCESS | 13429 | RSS: Main: 181850112 02:34:35 INFO - PROCESS | 13429 | 02:34:38 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:34:39 INFO - PROCESS | 13429 | RSS: Main: 184254464 02:34:39 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | Cycle 1(1): loaded http://localhost:40369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40369/tests/kraken/driver.html?testName=ai-astar) 02:34:40 INFO - PROCESS | 13429 | RSS: Main: 237744128 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | __start_tp_report 02:34:40 INFO - PROCESS | 13429 | _x_x_mozilla_page_load 02:34:40 INFO - PROCESS | 13429 | _x_x_mozilla_page_load_details 02:34:40 INFO - PROCESS | 13429 | |i|pagename|runs| 02:34:40 INFO - PROCESS | 13429 | |0;ai-astar;103;113;112;114;115;113;113;114;113;113 02:34:40 INFO - PROCESS | 13429 | |1;audio-beat-detection;141;116;115;156;124;116;116;115;134;120 02:34:40 INFO - PROCESS | 13429 | |2;audio-dft;162;162;160;161;162;164;161;160;161;161 02:34:40 INFO - PROCESS | 13429 | |3;audio-fft;75;75;76;100;76;76;75;77;92;75 02:34:40 INFO - PROCESS | 13429 | |4;audio-oscillator;83;82;109;81;81;81;95;81;82;101 02:34:40 INFO - PROCESS | 13429 | |5;imaging-gaussian-blur;113;113;113;113;112;113;112;113;112;113 02:34:40 INFO - PROCESS | 13429 | |6;imaging-darkroom;147;146;148;146;147;146;147;147;146;147 02:34:40 INFO - PROCESS | 13429 | |7;imaging-desaturate;95;94;94;94;94;93;94;94;94;94 02:34:40 INFO - PROCESS | 13429 | |8;json-parse-financial;56;54;57;55;54;54;55;55;54;55 02:34:40 INFO - PROCESS | 13429 | |9;json-stringify-tinderbox;52;52;52;52;53;51;52;53;53;54 02:34:40 INFO - PROCESS | 13429 | |10;stanford-crypto-aes;80;90;83;86;77;83;80;81;79;107 02:34:40 INFO - PROCESS | 13429 | |11;stanford-crypto-ccm;122;119;121;128;119;121;119;128;133;123 02:34:40 INFO - PROCESS | 13429 | |12;stanford-crypto-pbkdf2;167;159;161;159;160;158;155;159;163;160 02:34:40 INFO - PROCESS | 13429 | |13;stanford-crypto-sha256-iterative;61;61;61;60;61;60;59;59;60;63 02:34:40 INFO - PROCESS | 13429 | __end_tp_report 02:34:40 INFO - PROCESS | 13429 | __start_cc_report 02:34:40 INFO - PROCESS | 13429 | _x_x_mozilla_cycle_collect,1650 02:34:40 INFO - PROCESS | 13429 | __end_cc_report 02:34:40 INFO - PROCESS | 13429 | __startTimestamp1492076080981__endTimestamp 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | ------- Summary: start ------- 02:34:40 INFO - PROCESS | 13429 | Number of tests: 14 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.37 (3.0%) stddev-sans-first:0.87 02:34:40 INFO - PROCESS | 13429 | Values: 103.0 113.0 112.0 114.0 115.0 113.0 113.0 114.0 113.0 113.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:122.00 stddev:14.01 (11.5%) stddev-sans-first:13.66 02:34:40 INFO - PROCESS | 13429 | Values: 141.0 116.0 115.0 156.0 124.0 116.0 116.0 115.0 134.0 120.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 02:34:40 INFO - PROCESS | 13429 | Values: 162.0 162.0 160.0 161.0 162.0 164.0 161.0 160.0 161.0 161.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#3] audio-fft Cycles:10 Average:79.70 Median:76.00 stddev:8.82 (11.6%) stddev-sans-first:9.19 02:34:40 INFO - PROCESS | 13429 | Values: 75.0 75.0 76.0 100.0 76.0 76.0 75.0 77.0 92.0 75.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:81.50 stddev:10.28 (12.6%) stddev-sans-first:10.76 02:34:40 INFO - PROCESS | 13429 | Values: 83.0 82.0 109.0 81.0 81.0 81.0 95.0 81.0 82.0 101.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:34:40 INFO - PROCESS | 13429 | Values: 113.0 113.0 113.0 113.0 112.0 113.0 112.0 113.0 112.0 113.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 02:34:40 INFO - PROCESS | 13429 | Values: 147.0 146.0 148.0 146.0 147.0 146.0 147.0 147.0 146.0 147.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 02:34:40 INFO - PROCESS | 13429 | Values: 95.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:0.97 02:34:40 INFO - PROCESS | 13429 | Values: 56.0 54.0 57.0 55.0 54.0 54.0 55.0 55.0 54.0 55.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#9] json-stringify-tinderbox Cycles:10 Average:52.40 Median:52.50 stddev:0.84 (1.6%) stddev-sans-first:0.88 02:34:40 INFO - PROCESS | 13429 | Values: 52.0 52.0 52.0 52.0 53.0 51.0 52.0 53.0 53.0 54.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:82.00 stddev:8.71 (10.6%) stddev-sans-first:9.08 02:34:40 INFO - PROCESS | 13429 | Values: 80.0 90.0 83.0 86.0 77.0 83.0 80.0 81.0 79.0 107.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:122.50 stddev:4.79 (3.9%) stddev-sans-first:5.05 02:34:40 INFO - PROCESS | 13429 | Values: 122.0 119.0 121.0 128.0 119.0 121.0 119.0 128.0 133.0 123.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:3.18 (2.0%) stddev-sans-first:2.18 02:34:40 INFO - PROCESS | 13429 | Values: 167.0 159.0 161.0 159.0 160.0 158.0 155.0 159.0 163.0 160.0 02:34:40 INFO - PROCESS | 13429 | 02:34:40 INFO - PROCESS | 13429 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:61.00 stddev:1.18 (1.9%) stddev-sans-first:1.24 02:34:40 INFO - PROCESS | 13429 | Values: 61.0 61.0 61.0 60.0 61.0 60.0 59.0 59.0 60.0 63.0 02:34:40 INFO - PROCESS | 13429 | -------- Summary: end -------- 02:34:40 INFO - PROCESS | 13429 | 02:34:42 INFO - TEST-INFO | 13429: exit 0 02:34:42 INFO - TEST-OK | kraken | took 59958ms 02:34:42 INFO - SUITE-END | took 1174s 02:34:42 INFO - Completed test suite (00:19:34) 02:34:42 INFO - javascript benchmark 02:34:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7843.307040677949, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.2260918684115, 3320.2031512437025, 3323.385173742857, 3340.899773006811, 3372.274960883411, 5730.25506684131, 5741.311042674884, 5762.510186634136, 5783.652980821148, 5798.304203495586, 5761.395053519373, 5827.067669172933, 5832.708364581775, 5832.766689332421, 5835.649861008332, 5241.816536421226, 5266.104762190418, 5298.96670149321, 5314.76083576238, 5342.919856202141, 5218.739063046852, 5220.634555581111, 5326.680399176043, 5336.786528538853, 5341.866453338659, 5163.974180129113, 5280.683159010452, 5320.600954928396, 5341.359036915575, 5342.759575819097, 5326.227696983954, 5330.840074797762, 5332.68003919766, 5333.386660534049, 5341.519263266306, 5066.82266120684, 5224.315691384652, 5253.290805741214, 5290.523852853224, 5292.68243905363, 5602.439756024406, 5630.943690563083, 5678.5741069419955, 5709.77160913563, 5719.027765279912, 6123.908141377883, 6126.785562505335, 6153.384661533855, 6163.907541386883, 6175.722092505848, 6213.356426872116, 6225.470834979033, 6234.812955611339, 6256.937430625681, 6261.029540421242, 5596.776128954878, 5609.803656872031, 5721.284839395075, 5732.484076433141, 5750.051241545182, 6327.462165715873, 6331.556791024584, 6331.68341582919, 6337.0, 6338.0, 6030.33666296707, 6083.8174854754425, 6091.42131497507, 6096.817095487142, 6097.298810636834, 6005.549583781234, 6044.455998960115, 6053.7578496860515, 6069.848253793691, 6188.845278868064, 6113.6331820090045, 6113.719560719409, 6133.815985520441, 6134.4172303631085, 6135.509159267248, 5970.49250813677, 6014.0, 6090.147379366892, 6112.113743507167, 6131.233595800525, 4667.696599721007, 4701.200795864711, 4714.316424118484, 4716.103940251342, 4738.455077666113, 4074.246264441088, 4078.7552746835286, 4090.386442033659, 4199.748015119103, 4202.789860506962, 5905.143754155623, 5930.436608522184, 5947.583669143119, 5958.046712526062, 5965.403459654, 6145.262568491809, 6152.815415537541, 6177.722002509898, 6190.102435146879, 6195.380461953859, 5726.856828579235, 5907.261592300963, 5910.408959104141, 5910.70446477683, 5916.171735956969, 5144.4855514449, 5194.298769666122, 5244.895102097937, 5245.947540524546, 5263.157894736823, 6430.485561155097, 6433.388828061326, 6434.453071488976, 6471.902921456276, 6471.935280647227, 6153.2000839890525, 6219.160413344141, 6228.56400051992, 6240.095186198067, 6242.625442473466, 6195.628262304276, 6254.781082662085, 6360.4911607072245, 6373.6175829450385, 6485.708143133476, 6129.847850912965, 6132.569672417391, 6135.293912123373, 6144.10910417978, 6146.170267013896, 6240.594361366497, 6255.78104766331, 6257.342978987141, 6260.7495700171485, 6265.749370025148, 5783.7397317119985, 5848.678322692293, 5934.495567876779, 5977.940220597912, 6088.360722124113, 5955.225820643289, 6019.488343490677, 6029.065494848305, 6033.577649564489, 6054.939450605438, 5788.450097240755, 5942.762289508371, 5943.613665111754, 5958.880822383615, 5976.402359763989, 5983.700814959322, 6008.789692360747, 6009.098635204579, 6034.39656034393, 6134.2332208473945, 5954.821355359346, 5959.880802384015, 5963.731632076654, 5964.224650795369, 5997.820065398045], "value": 5684.090367909334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.1429213572933, 842.9325653947684, 858.4720396955872, 920.8066306075724, 932.6176267730232, 31805.52291715623, 45501.0, 45889.31166032512, 45909.0, 46066.53933460664, 47051.0, 47166.29250561236, 47193.29210061843, 47293.527064729344, 47346.289805652945, 5263.86840328991, 5322.92015619766, 9180.54097295136, 9335.3465257432, 9342.953285233598, 10216.13162881156, 10412.791744165112, 10756.569737210502, 10767.62313319034, 10776.245662803607, 10529.2103092268, 10575.735606609858, 10579.735506612358, 10585.0, 10587.311824731407, 10490.58037678492, 10494.160467162685, 10506.632267870664, 10518.842217366746, 10536.05175534198, 10606.734831629194, 10659.253852230348, 10663.84004239937, 10671.146308295318, 10677.679669609925, 43645.345319820226, 43746.0, 43758.34362484565, 43937.34093988593, 44049.77975110136, 4188.81150348235, 4200.873973780792, 4229.217594744982, 4307.095509942916, 4348.173846969065, 29539.556906646416, 30090.699093009007, 30209.848950755324, 30708.8464557678, 31654.683453165402, 4206.663466922639, 4212.68404869636, 4245.27830268855, 4285.9785701071605, 4456.866294011153, 263363.0, 265126.0, 265447.0, 265520.0, 265787.6710616454, 46502.76748616235, 46671.76664116658, 46700.29949550759, 46717.06565868664, 46731.0, 47435.0, 47693.284600731015, 47848.760756195996, 47857.521424786006, 47895.28157077647, 15097.24513774307, 15495.0, 15495.612609684622, 15498.147601882005, 15520.456784012506, 10967.561297548169, 11116.722081947853, 13487.05590608648, 13504.594862154152, 13515.797263041062, 13029.543965961146, 13211.669708257179, 13312.733745325233, 13404.463821447229, 13412.195268283935, 5387.730613469311, 5475.67145971235, 5527.419620939824, 5555.833325000256, 5588.860278492989, 1019.2814066083394, 1021.2595867995792, 1029.3206483720708, 1033.679559336608, 1034.1364960258268, 28123.57814632782, 29044.709552904624, 29191.0, 29216.0, 29757.40485190284, 1077.0737166037202, 1099.6920862158609, 1101.983470247947, 1108.7560736637927, 1117.0449265877558, 14096.929515352564, 16467.34130634785, 16866.746998795028, 17878.821211787978, 17914.193861276275, 356117.0, 359420.0, 359725.0, 360449.0, 361801.0, 59313.703431482565, 59565.10652340218, 59730.0, 59868.0, 59914.70042649759, 1487.1820498725658, 1543.4906480861289, 1558.3221298735086, 1563.796706428157, 1568.913709745952, 31219.0, 32969.835150824096, 32999.835000824845, 33248.0, 33283.0, 43840.12319753651, 44120.779396102815, 44320.335194972744, 44430.11139777251, 44508.0, 321749.0, 321942.0, 322033.0, 322725.0, 322774.0, 26375.868120659274, 31633.367332652757, 32650.673493265713, 33270.83364583162, 34282.828585856914, 44608.77695611501, 44648.33027504655, 44967.77516112399, 45597.0, 46478.0, 33898.66101338955, 34570.48144277888, 34829.65170348264, 35001.47497787586, 35023.0, 33389.66610333963, 33440.832795835864, 33470.0, 33511.49732753962, 33519.49720754142, 38499.2300154001, 38956.415653765784, 39417.40873886951, 39510.40734389044, 39557.40663889986, 32403.0, 32582.83708581442, 32600.184995375304, 32841.0, 32922.67077329196, 25063.624045639695, 26432.0, 26490.337741555843, 26512.337191570365, 26589.92949149195], "value": 19215.084104938836, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.3074741907786, 462.6368300883807, 474.1086756897033, 478.7295178224303, 482.91548978928677, 19245.42263732087, 20826.479338016557, 20844.583108337825, 20967.790322096775, 21259.787402125974, 21902.671459928075, 22406.88796556015, 22547.54904901901, 22639.660405093935, 22704.65943010856, 5395.487428694268, 6713.664316784178, 6779.966100169492, 6992.195897471805, 7026.7189312427445, 6716.3283671632935, 6830.351116643936, 6836.384725374715, 6842.760503382383, 6844.863102737967, 6590.769323073693, 6767.59394436333, 6867.416269617089, 6871.965640171792, 6874.0, 6802.08171896795, 6826.283240259801, 6857.211420686635, 6861.656917154122, 6907.861842763142, 6436.903446448307, 6642.036904648799, 6653.567518111356, 6656.234533028715, 6661.067450556926, 24977.62533561998, 25104.372390690198, 25231.495370092496, 25259.873700631564, 25303.62044569333, 3230.91922701932, 3242.1084201844446, 3256.234784825564, 3277.4919887417486, 3306.1073510152123, 15926.442574509952, 16110.597235069099, 16433.67132657352, 16680.58298542534, 16960.915195423942, 2169.783021697833, 2215.490437199453, 2278.2140161644206, 2283.223703940668, 2448.3879030242438, 102754.48622756838, 119482.40258798651, 121513.39243303816, 124700.0, 127351.0, 21255.0, 21294.36116916495, 21443.39174561914, 21979.780202198093, 22180.88909555442, 40205.79897100496, 40529.0, 40642.79678601647, 40782.79608601938, 41038.0, 10345.793084138275, 10576.0, 10656.413897235572, 10716.946415267874, 10794.73013174677, 8826.161514656098, 8914.548499162653, 8959.820803584022, 9146.95426522863, 9149.130832570896, 8929.464232146092, 9354.485503297385, 9404.717858464257, 9453.905460945303, 9641.180499657466, 3342.5487559179687, 3435.4159792835276, 3642.162302670348, 3723.3856413691437, 3871.709621778378, 962.1148543340144, 970.6263088710756, 980.6959842448864, 982.219135787051, 982.5332966840837, 20643.380698579065, 21149.57700846005, 21205.78794212038, 21270.255541055987, 22236.55526889453, 1017.2472370445817, 1020.9234307426973, 1029.8815636201782, 1045.8065257927308, 1050.201846596592, 7171.641417929082, 7285.854282914312, 7403.51877127985, 7536.397088233038, 7540.660670269741, 339615.0, 383256.0, 685129.0, 707089.0, 740103.0, 71131.0, 104338.47830760798, 114328.0, 115681.0, 120579.39710301568, 1209.2925638501574, 1324.4503531034704, 1383.1770096792593, 1386.9167849929036, 1394.8395934467462, 18812.153453094368, 19351.612967740846, 19481.70777438311, 19521.511962201057, 19583.60832783365, 50967.0, 51566.22650660318, 52470.73764631152, 53079.734601326745, 53886.730566346916, 68268.6586567064, 69089.0, 70016.29983700097, 70123.0, 71728.0, 12484.188527745668, 12507.874921250672, 12840.422181002064, 12916.354182291036, 12961.287129207607, 13763.105398149088, 13834.100783449043, 13853.445862165401, 13971.231582263074, 14208.57914208571, 12596.937015314865, 12715.10994230395, 12723.363831808558, 12791.744165116459, 12832.935835320764, 6098.786542470993, 11493.482793274155, 11590.652280431601, 11747.29516229029, 12059.0, 12442.37788110609, 12517.186382885084, 12527.812082818582, 12833.679158021125, 12861.485540578273, 12776.0, 12836.229826210458, 12850.228986260854, 12894.613161605166, 13138.934305328412, 12335.074869384653, 12567.245965242115, 12587.307698076695, 12709.4280757368, 13065.738685226052], "value": 11468.816356237929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.3694616734056, 1525.2602487793424, 1526.3063386604417, 1563.7185306644806, 1577.203512226326, 11004.339739615618, 11676.591319303827, 11684.0, 11693.707657308561, 11721.413929303544, 11035.72410689731, 11354.375509346983, 11361.318320900731, 11363.090952723784, 11402.942985285083, 2382.8689422081734, 2419.0565679385054, 2420.2376251480728, 2425.320910145162, 2431.987840060806, 2384.4158181245534, 2455.2511483997373, 2476.4304210031705, 2477.752224777517, 2503.949921001588, 2375.6436534519876, 2440.511897620474, 2450.6569080328677, 2461.1509029384833, 2475.121331927167, 2294.9541009179725, 2325.4186453386656, 2329.534093181362, 2332.88335583221, 2421.1889017179265, 2373.6202207646866, 2391.964120538193, 2401.11158871217, 2402.7957623602015, 2405.0620258099357, 11390.202685811997, 11625.534978600846, 11630.360330181837, 11635.76728465426, 11636.94181529087, 5564.527015203672, 5702.714864256812, 5714.457126572969, 5717.828465146053, 5718.399568045378, 3378.763486555942, 3426.640202778722, 3433.9828300858335, 3473.5831700195886, 3491.284286721216, 1285.119693010291, 1308.829852119228, 1313.934303284832, 1327.3230652367265, 1377.22875189894, 14491.78262326066, 14883.776743348859, 16261.837381626268, 16949.406770762966, 17153.0, 4372.453443319585, 4520.095980803852, 4648.3259927310355, 4651.674382793172, 4658.324542941255, 10677.466126693635, 10977.506012229309, 12434.440450179764, 13069.607911762663, 13149.934250328879, 5574.247476590608, 5738.483536481736, 5739.311282646109, 5740.253767010262, 5740.966626007275, 5244.632875698664, 5290.470952904679, 5294.126469132627, 5297.311349524614, 5298.178782288752, 3905.843766249375, 3924.5879182685976, 3947.5460322062754, 3992.6207010333974, 4004.839806407711, 979.911807937289, 987.7925635616457, 990.1187942730975, 992.2409356842022, 1001.5377548778864, 1049.6221360310283, 1053.2995557954027, 1056.1181413519644, 1058.1164727452663, 1065.6430095917954, 6995.755148569878, 7043.6830342633675, 7130.821729456701, 7159.498835081598, 7223.133224013152, 1037.7820657661975, 1037.911777498921, 1051.8685164354456, 1059.4649701900491, 1098.4507746126937, 4505.864824055284, 4573.176828170895, 4635.304704294383, 4674.298855171752, 4707.176244157259, 14538.0, 15135.848641513665, 15146.242687865562, 15156.0, 15162.0, 13565.253911034988, 14172.574822755334, 14584.927075364767, 15049.247537623294, 15065.849341506444, 10543.630972915911, 10702.09032232269, 10718.303310284806, 10726.731831704114, 10729.141668666489, 7266.854662906818, 7540.622968851645, 7597.734079307198, 7634.0, 7694.07671079474, 12971.481140754264, 13102.934485327512, 13113.737725245252, 13301.933490332487, 13506.189628622315, 12330.445129968994, 13383.263920484467, 13440.193588384729, 13454.798178027142, 13549.390277437342, 10381.0, 10646.20153488476, 10873.673789786319, 10923.344599324066, 10931.289466184673, 10968.506417211403, 11100.722481938015, 11144.777104458028, 11174.832377514182, 11179.0497807684, 9240.491772952551, 9246.167844893991, 9318.95340523293, 9343.252539796664, 9553.283503737108, 9057.04900985387, 9296.628134874529, 9341.859872102059, 9346.11211934865, 9648.71053868357, 8276.420650554403, 8314.501129931981, 8342.082370939313, 8380.20388063133, 8423.747287581382, 6659.334066593302, 6772.830679233059, 6796.116504854535, 6847.760328388483, 6874.140732408449, 6327.873442531216, 6439.7424103035355, 6454.1609590752905, 6545.443637290884, 6618.6690665467495], "value": 5391.770071791826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.7946026986507, 418.9727667701599, 432.79442264924165, 449.74364612171064, 451.4559955253918, 5116.925445656412, 5143.81996630118, 5174.637775355717, 5181.766820493082, 5220.138677118271, 5022.321986531817, 5046.167382381912, 5122.231665250214, 5136.38363396392, 5182.481751824825, 4389.868303950887, 4412.735235885857, 4416.425864637593, 4423.734575925455, 4444.666650001247, 4418.337249412598, 4451.666125040619, 4462.241418958784, 4464.308032255006, 4498.685092043558, 4205.390218418343, 4383.531516941828, 4392.275274579706, 4419.381286619876, 4420.3369494575745, 4326.906262022638, 4333.306670932667, 4376.956230437702, 4390.319500477415, 4397.856557295095, 4124.175164967019, 4151.066010147722, 4153.356229784388, 4153.563875793028, 4238.109996900655, 4948.455669876311, 5012.949870501285, 5031.723255220962, 5047.49525047496, 5094.6688465249645, 5048.964962182744, 5069.163588007974, 5075.4163271223915, 5084.77118529667, 5105.489451054902, 5466.009812836652, 5490.945090549083, 5500.779968801243, 5518.454832646825, 5519.715769117369, 4422.226110430694, 4496.865094047183, 4549.885278106852, 4561.885952851172, 4588.609968152711, 5376.758045887945, 5437.8368648940595, 5455.345358556999, 5632.662040277596, 5663.801766938179, 4591.268195423718, 4624.0, 4629.9582593916775, 4638.512956139557, 4697.459792123949, 4523.625096824194, 4563.794629241692, 4627.5603817637275, 4753.787784115028, 4777.0, 4996.950030499648, 5007.599392048627, 5029.220470827027, 5034.590314711886, 5051.166557518042, 5413.918791218135, 5415.642301772926, 5425.0, 5441.564674826004, 5459.808906688247, 1567.8197007344074, 1612.4759453177764, 1625.2198944506704, 1639.6392793585392, 1642.8849980501489, 1247.4137155537064, 1260.7793636113643, 1266.9294446192953, 1274.337344580813, 1275.005495713345, 5348.582625604218, 5416.9729151353995, 5417.4311697272005, 5443.374011988592, 5469.972650136803, 5559.9444005560235, 5585.240649195491, 5618.353889302783, 5619.454649971291, 5624.612802014353, 5209.453007434165, 5379.650322729089, 5388.595855310789, 5412.5940554458575, 5447.182922561568, 2967.095036013993, 2968.3321252717965, 2975.1372102090586, 2984.418038482475, 2988.9402211956076, 5546.893739505889, 5862.501687356623, 5865.794697185578, 5906.26171728534, 5909.990603194934, 5681.573881958787, 5725.484706376446, 5755.309362876482, 5775.682337471395, 5781.595288329777, 5731.710365167887, 5756.273118064564, 5774.42255774436, 5813.7383817728305, 5838.241028666246, 5282.490816862113, 5554.750036248298, 5560.527355174855, 5570.777168913198, 5601.915971260516, 5268.868278293074, 5357.767713425856, 5369.221462887781, 5393.217983392465, 5463.4536546346635, 5681.971590142023, 5759.366469688247, 5769.307683078057, 5783.797567085132, 5811.767529298781, 4581.839635612738, 4651.744029112188, 4701.531695859701, 4715.78778954941, 4724.8660321523275, 5614.915776263278, 5652.293463317085, 5652.349979752381, 5658.801941932013, 5681.9147712783515, 5417.214503896834, 5444.992676354887, 5451.236826844166, 5508.366537848199, 5530.198121272473, 5189.273501709839, 5413.648112872651, 5419.83740487786, 5490.91763623538, 5504.339479262354, 5393.649412788156, 5407.351117865881, 5411.702356370437, 5426.945730542802, 5442.809501667422, 5284.471552844685, 5408.4321146280645, 5477.1510415885605, 5483.464629903633, 5504.0, 5251.553617942518, 5285.841424757264, 5309.681419114865, 5335.359756829205, 5374.704391258362], "value": 4400.761087915309, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.7830503221678, 892.0276898180989, 892.7321803458963, 896.5920506169693, 901.3955159815526, 16246.675066498663, 18070.909645451786, 18104.728429073573, 18380.356687515923, 18425.170867310968, 15994.120323382209, 16068.437604683839, 16114.033158010527, 16126.435574754856, 16134.193290335495, 883.5538053283099, 884.0584777212281, 903.0743487924864, 906.1799071839962, 906.2432868554732, 882.1972005475019, 893.7408151636017, 896.1576118448637, 904.4754042655244, 904.5477261369315, 940.3135710931025, 941.8163458125669, 942.0814705661959, 943.981120377592, 944.1313991128178, 920.4431319051978, 924.6624981881632, 926.9582868770922, 927.3508544019213, 928.633189889993, 680.7004917836136, 681.7034589953337, 682.3756263019332, 682.3960794696729, 682.4097155960109, 16201.10893900835, 16446.83553164477, 16563.66872662552, 16934.322627095025, 17124.14379281031, 15262.0, 15606.219689015617, 15809.446669366633, 16036.0, 16323.26545305464, 12658.367081645882, 13258.0, 13271.66820829487, 13294.3352832358, 13335.266560339178, 3988.860389886369, 4028.3353246714255, 4043.191361727637, 4144.896377590584, 4157.792110394468, 90225.54887225523, 90513.09486905113, 90828.54585727162, 92493.53753231258, 94963.52518237433, 11271.718207044725, 11308.773824523463, 11322.773544529227, 11447.198696091195, 11473.54105835774, 22543.323700289016, 22665.660015099787, 22825.657615135788, 22989.310320690405, 23035.88482057579, 8452.1547845215, 8547.230749232598, 8553.486790792573, 8648.43785153963, 8796.34027447944, 4524.954750452519, 4586.862394128181, 4649.465311489154, 4653.511381304982, 4711.929321060187, 3810.599887011879, 3910.648041676263, 3916.5104361954754, 3917.6474117329576, 3920.4707364506, 591.1221835574169, 595.1756816808664, 605.0289285696482, 607.3744043635063, 609.4880300547561, 815.4332738746514, 822.5352675738188, 839.7816567692444, 847.1655419411875, 854.4232642966098, 10919.672409827717, 11479.655610331703, 11749.47127379253, 11778.941105294418, 12080.275183489019, 756.6935391166586, 757.6514803190483, 764.8546776112521, 776.2703059124404, 782.7886470652892, 5393.541548968382, 5412.621116521885, 5421.5933804964, 5492.148716948799, 5502.972485137629, 75253.0, 77583.22416775873, 84807.15192847993, 84985.57507212424, 86635.56682216674, 67095.32904670891, 67377.66311168413, 67399.0, 68101.0, 70018.0, 62984.0, 63492.0, 63643.681781591724, 63826.0, 64040.0, 11558.537658493566, 11803.291802491878, 11902.761944761229, 11947.402629868298, 12201.755964880474, 40709.59290407177, 41415.7929210352, 41746.37380439357, 42065.369019465346, 42955.7852210737, 46270.0, 46621.0, 47669.0, 47799.52200477951, 48972.51027489822, 13412.530561430693, 13669.453221871014, 13785.862141378459, 13824.239666818421, 13922.095063821225, 15737.213139343216, 15862.60343491422, 15872.206389680701, 15976.20118994069, 16357.182140893146, 14801.629959250675, 15080.170590617621, 15403.460878869186, 15609.375624974873, 16126.2743176555, 14035.666611671875, 14900.32948517341, 15676.294566744296, 15854.524364269091, 16199.676006479569, 14087.647808804863, 14687.92656036713, 14843.628909277355, 15569.84430155684, 15907.602309941882, 10798.244122911636, 10905.781884362426, 11621.0, 12025.158238923192, 12491.312977785945, 12757.48970041188, 12776.425060872469, 12901.806472903101, 13111.73776524445, 13168.539101131415], "value": 7832.041147089457, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 114.0, 115.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 115.0, 156.0, 124.0, 116.0, 116.0, 115.0, 134.0, 120.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 162.0, 164.0, 161.0, 160.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 100.0, 76.0, 76.0, 75.0, 77.0, 92.0, 75.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 109.0, 81.0, 81.0, 81.0, 95.0, 81.0, 82.0, 101.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 57.0, 55.0, 54.0, 54.0, 55.0, 55.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 53.0, 51.0, 52.0, 53.0, 53.0, 54.0], "value": 52.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 90.0, 83.0, 86.0, 77.0, 83.0, 80.0, 81.0, 79.0, 107.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 121.0, 128.0, 119.0, 121.0, 119.0, 128.0, 133.0, 123.0], "value": 123.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 159.0, 161.0, 159.0, 160.0, 158.0, 155.0, 159.0, 163.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 59.0, 59.0, 60.0, 63.0], "value": 60.5, "unit": "score"}]}]} 02:34:42 INFO - Return code: 0 02:34:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:34:42 ERROR - # TBPL SUCCESS # 02:34:42 INFO - Running post-action listener: _resource_record_post_action 02:34:42 INFO - [mozharness: 2017-04-13 09:34:42.817143Z] Finished run-tests step (success) 02:34:42 INFO - Running post-run listener: _resource_record_post_run 02:34:42 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 256688128; Read time: 20; Write time: 140036 02:34:42 INFO - TinderboxPrint: CPU usage
13.1% 02:34:42 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 20 02:34:42 INFO - TinderboxPrint: I/O write bytes / time
256,688,128 / 140,036 02:34:42 INFO - TinderboxPrint: CPU idle
8,262.3 (86.8%) 02:34:42 INFO - TinderboxPrint: CPU user
1,203.8 (12.7%) 02:34:42 INFO - TinderboxPrint: Swap in / out
0 / 0 02:34:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 3018752; Read time: 0; Write time: 108 02:34:42 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249462784; Read time: 20; Write time: 138816 02:34:43 INFO - Running post-run listener: _upload_blobber_files 02:34:43 INFO - Blob upload gear active. 02:34:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:34:43 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 02:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:34:43 INFO - (blobuploader) - INFO - Open directory for files ... 02:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:34:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:47 INFO - (blobuploader) - INFO - Done attempting. 02:34:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:34:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:48 INFO - (blobuploader) - INFO - Done attempting. 02:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:49 INFO - (blobuploader) - INFO - Done attempting. 02:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:50 INFO - (blobuploader) - INFO - Done attempting. 02:34:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:34:50 INFO - Return code: 0 02:34:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:34:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:34:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b0d7832ad0780db765ee3434eb66fd40496b0dac471e9666396a3db0f7b6cddc554b236e4b720e9598d9812132837f532ca57d6f767103427b09849491dc496e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1fd2d0de063934027d871b884a2623637c9a6e6ab281f972577bf429218db08cfc1f2e202087125bdb4b880a7ddfa06532a01d62adb60c5b1d81680387613c77", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/068ec38ee5c6983918ac0284aedce7b092e6d22bf99963785a4bdb1684e87445a94e11b24d315dff67c05a738444955bb6177c421508e45e3e4b0725c965d670", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a20b7f2dd533ca60831236573c931d9fc7a34784964d4cbd9a9e2637ede5eb88256463f57fc360fb1af91b80b2772521e5760920805f44556b7e0c276134b8c5"} 02:34:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:34:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:34:50 INFO - Contents: 02:34:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b0d7832ad0780db765ee3434eb66fd40496b0dac471e9666396a3db0f7b6cddc554b236e4b720e9598d9812132837f532ca57d6f767103427b09849491dc496e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1fd2d0de063934027d871b884a2623637c9a6e6ab281f972577bf429218db08cfc1f2e202087125bdb4b880a7ddfa06532a01d62adb60c5b1d81680387613c77", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/068ec38ee5c6983918ac0284aedce7b092e6d22bf99963785a4bdb1684e87445a94e11b24d315dff67c05a738444955bb6177c421508e45e3e4b0725c965d670", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a20b7f2dd533ca60831236573c931d9fc7a34784964d4cbd9a9e2637ede5eb88256463f57fc360fb1af91b80b2772521e5760920805f44556b7e0c276134b8c5"} 02:34:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:34:50 INFO - Copying logs to upload dir... 02:34:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:34:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1339.121018 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2017-04-13 02:34:50.442140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 02:34:50.446470) ========= 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=438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b0d7832ad0780db765ee3434eb66fd40496b0dac471e9666396a3db0f7b6cddc554b236e4b720e9598d9812132837f532ca57d6f767103427b09849491dc496e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1fd2d0de063934027d871b884a2623637c9a6e6ab281f972577bf429218db08cfc1f2e202087125bdb4b880a7ddfa06532a01d62adb60c5b1d81680387613c77", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/068ec38ee5c6983918ac0284aedce7b092e6d22bf99963785a4bdb1684e87445a94e11b24d315dff67c05a738444955bb6177c421508e45e3e4b0725c965d670", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a20b7f2dd533ca60831236573c931d9fc7a34784964d4cbd9a9e2637ede5eb88256463f57fc360fb1af91b80b2772521e5760920805f44556b7e0c276134b8c5"} build_url:https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/P1xRaJ7OQoW6ScvvhPLD9A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b0d7832ad0780db765ee3434eb66fd40496b0dac471e9666396a3db0f7b6cddc554b236e4b720e9598d9812132837f532ca57d6f767103427b09849491dc496e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1fd2d0de063934027d871b884a2623637c9a6e6ab281f972577bf429218db08cfc1f2e202087125bdb4b880a7ddfa06532a01d62adb60c5b1d81680387613c77", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/068ec38ee5c6983918ac0284aedce7b092e6d22bf99963785a4bdb1684e87445a94e11b24d315dff67c05a738444955bb6177c421508e45e3e4b0725c965d670", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a20b7f2dd533ca60831236573c931d9fc7a34784964d4cbd9a9e2637ede5eb88256463f57fc360fb1af91b80b2772521e5760920805f44556b7e0c276134b8c5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 02:34:50.482783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 02:34:50.483156) ========= 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=438111f3d31ce799eff2119d000001bc-1492074718.570496-69647754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 02:34:50.586607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 02:34:50.590033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 02:34:50.590529) ========= ========= Total master_lag: 3.65 =========