builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-085 starttime: 1490661256.01 results: success (0) revision: a8bb5c8e0e80e87e21ad63997f8881991b5347cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:16.008694) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:16.009216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:16.009502) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:16.024780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:16.025192) ========= 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=5c37b704b588aaa989324530000001d0-1490661255.384742-728312733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-27 17:34:16-- 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% 88.0M=0s 2017-03-27 17:34:16 (88.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:16.135914) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:16.136533) ========= 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=5c37b704b588aaa989324530000001d0-1490661255.384742-728312733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:16.187133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 17:34:16.187502) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8bb5c8e0e80e87e21ad63997f8881991b5347cf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev a8bb5c8e0e80e87e21ad63997f8881991b5347cf --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=5c37b704b588aaa989324530000001d0-1490661255.384742-728312733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-27 17:34:16,225 truncating revision to first 12 chars 2017-03-27 17:34:16,225 Setting DEBUG logging. 2017-03-27 17:34:16,225 attempt 1/10 2017-03-27 17:34:16,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8bb5c8e0e80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 17:34:17,107 unpacking tar archive at: mozilla-central-a8bb5c8e0e80/testing/mozharness/ program finished with exit code 0 elapsedTime=1.242952 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 17:34:17.444038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:17.444437) ========= script_repo_revision: a8bb5c8e0e80e87e21ad63997f8881991b5347cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:17.444823) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:17.445112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 17:34:17.454771) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-27 17:34:17.455317) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1490661255.384742-728312733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:34:17 INFO - MultiFileLogger online at 20170327 17:34:17 in /builds/slave/test 17:34:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:34:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:17 INFO - {'append_to_log': False, 17:34:17 INFO - 'base_work_dir': '/builds/slave/test', 17:34:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:34:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:17 INFO - 'branch': 'Firefox-Non-PGO', 17:34:17 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:17 INFO - 'config_files': ('talos/linux_config.py',), 17:34:17 INFO - 'default_actions': ('clobber', 17:34:17 INFO - 'read-buildbot-config', 17:34:17 INFO - 'download-and-extract', 17:34:17 INFO - 'populate-webroot', 17:34:17 INFO - 'create-virtualenv', 17:34:17 INFO - 'install', 17:34:17 INFO - 'run-tests'), 17:34:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:17 INFO - 'download_minidump_stackwalk': True, 17:34:17 INFO - 'download_symbols': 'ondemand', 17:34:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:34:17 INFO - 'tooltool.py': '/tools/tooltool.py', 17:34:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:34:17 INFO - '/tools/misc-python/virtualenv.py')}, 17:34:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:17 INFO - 'gecko_profile': False, 17:34:17 INFO - 'gecko_profile_interval': 0, 17:34:17 INFO - 'installer_path': 'installer.exe', 17:34:17 INFO - 'log_level': 'info', 17:34:17 INFO - 'log_name': 'talos', 17:34:17 INFO - 'log_to_console': True, 17:34:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:34:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:34:17 INFO - 'opt_config_files': (), 17:34:17 INFO - 'pip_index': False, 17:34:17 INFO - 'suite': 'dromaeojs', 17:34:17 INFO - 'system_bits': '32', 17:34:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:17 INFO - 'title': 'talos-linux64-ix-085', 17:34:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:17 INFO - 'use_talos_json': True, 17:34:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:17 INFO - 'work_dir': 'build'} 17:34:17 INFO - [mozharness: 2017-03-28 00:34:17.581813Z] Running clobber step. 17:34:17 INFO - Running pre-action listener: _resource_record_pre_action 17:34:17 INFO - Running main action method: clobber 17:34:17 INFO - rmtree: /builds/slave/test/build 17:34:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:18 INFO - Running post-action listener: _resource_record_post_action 17:34:18 INFO - [mozharness: 2017-03-28 00:34:18.507864Z] Finished clobber step (success) 17:34:18 INFO - [mozharness: 2017-03-28 00:34:18.507963Z] Running read-buildbot-config step. 17:34:18 INFO - Running pre-action listener: _resource_record_pre_action 17:34:18 INFO - Running main action method: read_buildbot_config 17:34:18 INFO - Using buildbot properties: 17:34:18 INFO - { 17:34:18 INFO - "project": "", 17:34:18 INFO - "product": "firefox", 17:34:18 INFO - "who": "kwierso@gmail.com", 17:34:18 INFO - "installer_path": "public/build/target.tar.bz2", 17:34:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:34:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:34:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:34:18 INFO - "stage_platform": "linux64", 17:34:18 INFO - "basedir": "/builds/slave/test", 17:34:18 INFO - "buildnumber": 1036, 17:34:18 INFO - "platform": "ubuntu64_hw", 17:34:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:34:18 INFO - "slavebuilddir": "test", 17:34:18 INFO - "taskId": "GWPp_wAcSf-7wK81tcXmDg", 17:34:18 INFO - "branch": "mozilla-central", 17:34:18 INFO - "script_repo_revision": "production", 17:34:18 INFO - "revision": "a8bb5c8e0e80e87e21ad63997f8881991b5347cf", 17:34:18 INFO - "slavename": "talos-linux64-ix-085", 17:34:18 INFO - "repo_path": "mozilla-central" 17:34:18 INFO - } 17:34:18 INFO - Finding installer, test and symbols from parent task. 17:34:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GWPp_wAcSf-7wK81tcXmDg'}, attempt #1 17:34:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GWPp_wAcSf-7wK81tcXmDg'}, attempt #1 17:34:19 INFO - Task dependencies: OQMN3lYuTBSIu5XSGmkpfw 17:34:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw'}, attempt #1 17:34:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.tar.bz2 17:34:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/test_packages.json 17:34:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.crashreporter-symbols.zip 17:34:19 INFO - Running post-action listener: _resource_record_post_action 17:34:19 INFO - [mozharness: 2017-03-28 00:34:19.898050Z] Finished read-buildbot-config step (success) 17:34:19 INFO - [mozharness: 2017-03-28 00:34:19.898268Z] Running download-and-extract step. 17:34:19 INFO - Running pre-action listener: _resource_record_pre_action 17:34:19 INFO - Running main action method: download_and_extract 17:34:19 INFO - mkdir: /builds/slave/test/build/tests 17:34:19 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')]} 17:34:19 INFO - trying https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.test_packages.json 17:34:19 INFO - Downloading https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:34:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:34:20 INFO - Downloaded 986 bytes. 17:34:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:34:20 INFO - Using the following test package requirements: 17:34:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:34:20 INFO - u'common': [u'target.common.tests.zip'], 17:34:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:34:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:34:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:34:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:34:20 INFO - u'mozbase': [u'target.common.tests.zip'], 17:34:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:34:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:34:20 INFO - u'web-platform': [u'target.common.tests.zip', 17:34:20 INFO - u'target.web-platform.tests.zip'], 17:34:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:34:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:34:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.common.tests.zip 17:34:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:34:20 INFO - Fetch https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.common.tests.zip into memory 17:34:21 INFO - Expected file size: 58135342 17:34:21 INFO - Obtained file size: 58135342 17:34:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:34:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.common.tests.zip 17:34:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:34:31 INFO - Fetch https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.common.tests.zip into memory 17:34:32 INFO - Expected file size: 58135342 17:34:32 INFO - Obtained file size: 58135342 17:34:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.talos.tests.zip 17:34:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:34:43 INFO - Fetch https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.talos.tests.zip into memory 17:34:43 INFO - Expected file size: 14404171 17:34:43 INFO - Obtained file size: 14404171 17:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:44 INFO - trying https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.tar.bz2 17:34:44 INFO - Downloading https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:34:45 INFO - Downloaded 62582906 bytes. 17:34:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.tar.bz2 17:34:45 INFO - mkdir: /builds/slave/test/properties 17:34:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:45 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:45 INFO - Contents: 17:34:45 INFO - build_url:https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.tar.bz2 17:34:45 INFO - Running post-action listener: _resource_record_post_action 17:34:45 INFO - Running post-action listener: set_extra_try_arguments 17:34:45 INFO - [mozharness: 2017-03-28 00:34:45.234168Z] Finished download-and-extract step (success) 17:34:45 INFO - [mozharness: 2017-03-28 00:34:45.234265Z] Running populate-webroot step. 17:34:45 INFO - Running pre-action listener: _resource_record_pre_action 17:34:45 INFO - Running main action method: populate_webroot 17:34:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:45 INFO - '--tppagecycles', 17:34:45 INFO - '7'], 17:34:45 INFO - 'tests': ['tsvgm']}}, 17:34:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:34:45 INFO - 'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:34:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:34:45 INFO - 'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['damp', 'tps']}, 17:34:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:34:45 INFO - 'tests': ['damp', 'tps']}, 17:34:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['dromaeo_dom']}, 17:34:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['basic_compositor_video']}, 17:34:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:34:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['a11yr', 17:34:45 INFO - 'ts_paint', 17:34:45 INFO - 'tpaint', 17:34:45 INFO - 'sessionrestore', 17:34:45 INFO - 'sessionrestore_no_auto_restore', 17:34:45 INFO - 'tabpaint']}, 17:34:45 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:45 INFO - 'ts_paint', 17:34:45 INFO - 'tpaint', 17:34:45 INFO - 'sessionrestore', 17:34:45 INFO - 'sessionrestore_no_auto_restore', 17:34:45 INFO - 'tabpaint']}, 17:34:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:45 INFO - 'ts_paint', 17:34:45 INFO - 'tpaint', 17:34:45 INFO - 'sessionrestore', 17:34:45 INFO - 'sessionrestore_no_auto_restore', 17:34:45 INFO - 'tabpaint']}, 17:34:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:45 INFO - 'ts_paint', 17:34:45 INFO - 'tpaint', 17:34:45 INFO - 'sessionrestore', 17:34:45 INFO - 'sessionrestore_no_auto_restore', 17:34:45 INFO - 'tabpaint']}, 17:34:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['a11yr', 17:34:45 INFO - 'ts_paint', 17:34:45 INFO - 'tpaint', 17:34:45 INFO - 'sessionrestore', 17:34:45 INFO - 'sessionrestore_no_auto_restore', 17:34:45 INFO - 'tabpaint']}, 17:34:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['a11yr', 17:34:45 INFO - 'ts_paint', 17:34:45 INFO - 'tpaint', 17:34:45 INFO - 'sessionrestore', 17:34:45 INFO - 'sessionrestore_no_auto_restore', 17:34:45 INFO - 'tabpaint']}, 17:34:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['tsvgx', 17:34:45 INFO - 'tsvgr_opacity', 17:34:45 INFO - 'tart', 17:34:45 INFO - 'tscrollx', 17:34:45 INFO - 'cart', 17:34:45 INFO - 'tsvg_static']}, 17:34:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:45 INFO - 'tsvgr_opacity', 17:34:45 INFO - 'tart', 17:34:45 INFO - 'tscrollx', 17:34:45 INFO - 'cart', 17:34:45 INFO - 'tsvg_static']}, 17:34:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:34:45 INFO - 'talos_options': ['--disable-e10s'], 17:34:45 INFO - 'tests': ['tp5o']}, 17:34:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:34:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:34:45 INFO - 'talos_options': ['--disable-e10s', 17:34:45 INFO - '--xperf_path', 17:34:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:45 INFO - 'tests': ['tp5n']}, 17:34:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:34:45 INFO - 'talos_options': ['--xperf_path', 17:34:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:45 INFO - 'tests': ['tp5n']}}, 17:34:45 INFO - 'talos.zip': {'path': '', 17:34:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:45 INFO - Running post-action listener: _resource_record_post_action 17:34:45 INFO - [mozharness: 2017-03-28 00:34:45.247450Z] Finished populate-webroot step (success) 17:34:45 INFO - [mozharness: 2017-03-28 00:34:45.247539Z] Running create-virtualenv step. 17:34:45 INFO - Running pre-action listener: _resource_record_pre_action 17:34:45 INFO - Running main action method: create_virtualenv 17:34:45 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34: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 17:34:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:45 INFO - Using real prefix '/usr' 17:34:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:45 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:47 INFO - Installing pip.................done. 17:34:47 INFO - Return code: 0 17:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:34:48 INFO - Reading from file tmpfile_stdout 17:34:48 INFO - Output received: 17:34: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) 17:34:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:48 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 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:34:48 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 17:34:48 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 17:34:48 INFO - Using env: {'DISPLAY': ':0', 17:34:48 INFO - 'HOME': '/home/cltbld', 17:34:48 INFO - 'LANG': 'en_US.UTF-8', 17:34:48 INFO - 'LANGUAGE': 'en_US:en', 17:34:48 INFO - 'LOGNAME': 'cltbld', 17:34:48 INFO - 'MAIL': '/var/mail/cltbld', 17:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:48 INFO - 'MOZ_NO_REMOTE': '1', 17:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:48 INFO - 'NO_EM_RESTART': '1', 17:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:48 INFO - 'PWD': '/builds/slave/test', 17:34:48 INFO - 'SHELL': '/bin/bash', 17:34:48 INFO - 'SHLVL': '1', 17:34:48 INFO - 'TERM': 'linux', 17:34:48 INFO - 'TMOUT': '86400', 17:34:48 INFO - 'USER': 'cltbld', 17:34:48 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:48 INFO - '_': '/tools/buildbot/bin/python'} 17:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:48 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 17:34:48 INFO - Cleaning up... 17:34:48 INFO - Return code: 0 17:34:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:48 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 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:34:48 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 17:34:48 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 17:34:48 INFO - Using env: {'DISPLAY': ':0', 17:34:48 INFO - 'HOME': '/home/cltbld', 17:34:48 INFO - 'LANG': 'en_US.UTF-8', 17:34:48 INFO - 'LANGUAGE': 'en_US:en', 17:34:48 INFO - 'LOGNAME': 'cltbld', 17:34:48 INFO - 'MAIL': '/var/mail/cltbld', 17:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:48 INFO - 'MOZ_NO_REMOTE': '1', 17:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:48 INFO - 'NO_EM_RESTART': '1', 17:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:48 INFO - 'PWD': '/builds/slave/test', 17:34:48 INFO - 'SHELL': '/bin/bash', 17:34:48 INFO - 'SHLVL': '1', 17:34:48 INFO - 'TERM': 'linux', 17:34:48 INFO - 'TMOUT': '86400', 17:34:48 INFO - 'USER': 'cltbld', 17:34:48 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:48 INFO - '_': '/tools/buildbot/bin/python'} 17:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:48 INFO - Downloading/unpacking psutil>=3.1.1 17:34:48 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 17:34:48 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 17:34:48 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 17:34:48 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 17:34:48 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 17:34:48 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 17:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:50 INFO - Installing collected packages: psutil 17:34:50 INFO - Running setup.py install for psutil 17:34:50 INFO - building 'psutil._psutil_linux' extension 17:34:50 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 17:34:50 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 17:34:50 INFO - building 'psutil._psutil_posix' extension 17:34:50 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 17:34:50 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 17:34:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:51 INFO - Successfully installed psutil 17:34:51 INFO - Cleaning up... 17:34:51 INFO - Return code: 0 17:34:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34:51 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')]} 17:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:51 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')]} 17:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:51 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 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:34:51 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 17:34:51 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 17:34:51 INFO - Using env: {'DISPLAY': ':0', 17:34:51 INFO - 'HOME': '/home/cltbld', 17:34:51 INFO - 'LANG': 'en_US.UTF-8', 17:34:51 INFO - 'LANGUAGE': 'en_US:en', 17:34:51 INFO - 'LOGNAME': 'cltbld', 17:34:51 INFO - 'MAIL': '/var/mail/cltbld', 17:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:51 INFO - 'MOZ_NO_REMOTE': '1', 17:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:51 INFO - 'NO_EM_RESTART': '1', 17:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:51 INFO - 'PWD': '/builds/slave/test', 17:34:51 INFO - 'SHELL': '/bin/bash', 17:34:51 INFO - 'SHLVL': '1', 17:34:51 INFO - 'TERM': 'linux', 17:34:51 INFO - 'TMOUT': '86400', 17:34:51 INFO - 'USER': 'cltbld', 17:34:51 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:51 INFO - '_': '/tools/buildbot/bin/python'} 17:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:34:53 INFO - Installing collected packages: mozsystemmonitor 17:34:53 INFO - Running setup.py install for mozsystemmonitor 17:34:53 INFO - Successfully installed mozsystemmonitor 17:34:53 INFO - Cleaning up... 17:34:53 INFO - Return code: 0 17:34:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:34:53 INFO - Using env: {'DISPLAY': ':0', 17:34:53 INFO - 'HOME': '/home/cltbld', 17:34:53 INFO - 'LANG': 'en_US.UTF-8', 17:34:53 INFO - 'LANGUAGE': 'en_US:en', 17:34:53 INFO - 'LOGNAME': 'cltbld', 17:34:53 INFO - 'MAIL': '/var/mail/cltbld', 17:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:53 INFO - 'MOZ_NO_REMOTE': '1', 17:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:53 INFO - 'NO_EM_RESTART': '1', 17:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:53 INFO - 'PWD': '/builds/slave/test', 17:34:53 INFO - 'SHELL': '/bin/bash', 17:34:53 INFO - 'SHLVL': '1', 17:34:53 INFO - 'TERM': 'linux', 17:34:53 INFO - 'TMOUT': '86400', 17:34:53 INFO - 'USER': 'cltbld', 17:34:53 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:53 INFO - '_': '/tools/buildbot/bin/python'} 17:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:53 INFO - Downloading/unpacking jsonschema==2.5.1 17:34:53 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 17:34:53 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 17:34:53 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 17:34:53 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 17:34:53 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 17:34:53 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 17:34:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:56 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:34:56 INFO - warning: no files found matching '*.txt' 17:34:56 INFO - no previously-included directories found matching 'build' 17:34:56 INFO - no previously-included directories found matching 'dist' 17:34:56 INFO - no previously-included directories found matching '.git*' 17:34:56 INFO - Installing collected packages: jsonschema, functools32 17:34:56 INFO - Running setup.py install for functools32 17:34:56 INFO - warning: no files found matching '*.txt' 17:34:56 INFO - no previously-included directories found matching 'build' 17:34:56 INFO - no previously-included directories found matching 'dist' 17:34:56 INFO - no previously-included directories found matching '.git*' 17:34:56 INFO - Successfully installed jsonschema functools32 17:34:56 INFO - Cleaning up... 17:34:56 INFO - Return code: 0 17:34:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:34:56 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')]} 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 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')]} 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 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 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:34:56 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 17:34:56 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 17:34:56 INFO - Using env: {'DISPLAY': ':0', 17:34:56 INFO - 'HOME': '/home/cltbld', 17:34:56 INFO - 'LANG': 'en_US.UTF-8', 17:34:56 INFO - 'LANGUAGE': 'en_US:en', 17:34:56 INFO - 'LOGNAME': 'cltbld', 17:34:56 INFO - 'MAIL': '/var/mail/cltbld', 17:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:56 INFO - 'MOZ_NO_REMOTE': '1', 17:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:56 INFO - 'NO_EM_RESTART': '1', 17:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:56 INFO - 'PWD': '/builds/slave/test', 17:34:56 INFO - 'SHELL': '/bin/bash', 17:34:56 INFO - 'SHLVL': '1', 17:34:56 INFO - 'TERM': 'linux', 17:34:56 INFO - 'TMOUT': '86400', 17:34:56 INFO - 'USER': 'cltbld', 17:34:56 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:56 INFO - '_': '/tools/buildbot/bin/python'} 17:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:34:56 INFO - Cleaning up... 17:34:56 INFO - Return code: 0 17:34:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:34:56 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')]} 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 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')]} 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 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 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:34:56 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 17:34:56 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 17:34:56 INFO - Using env: {'DISPLAY': ':0', 17:34:56 INFO - 'HOME': '/home/cltbld', 17:34:56 INFO - 'LANG': 'en_US.UTF-8', 17:34:56 INFO - 'LANGUAGE': 'en_US:en', 17:34:56 INFO - 'LOGNAME': 'cltbld', 17:34:56 INFO - 'MAIL': '/var/mail/cltbld', 17:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:56 INFO - 'MOZ_NO_REMOTE': '1', 17:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:56 INFO - 'NO_EM_RESTART': '1', 17:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:56 INFO - 'PWD': '/builds/slave/test', 17:34:56 INFO - 'SHELL': '/bin/bash', 17:34:56 INFO - 'SHLVL': '1', 17:34:56 INFO - 'TERM': 'linux', 17:34:56 INFO - 'TMOUT': '86400', 17:34:56 INFO - 'USER': 'cltbld', 17:34:56 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:56 INFO - '_': '/tools/buildbot/bin/python'} 17:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:34:56 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 17:34:56 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 17:34:56 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 17:34:56 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 17:34:56 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 17:34:56 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 17:34:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:34:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:34:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 INFO - Downloading docopt-0.6.1.tar.gz 17:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:34:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:34:59 INFO - Running setup.py install for blobuploader 17:34:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:34:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:34:59 INFO - Running setup.py install for requests 17:35:00 INFO - Running setup.py install for docopt 17:35:00 INFO - Successfully installed blobuploader requests docopt 17:35:00 INFO - Cleaning up... 17:35:00 INFO - Return code: 0 17:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:00 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')]} 17:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:00 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')]} 17:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:00 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 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:35:00 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 17:35:00 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 17:35:00 INFO - Using env: {'DISPLAY': ':0', 17:35:00 INFO - 'HOME': '/home/cltbld', 17:35:00 INFO - 'LANG': 'en_US.UTF-8', 17:35:00 INFO - 'LANGUAGE': 'en_US:en', 17:35:00 INFO - 'LOGNAME': 'cltbld', 17:35:00 INFO - 'MAIL': '/var/mail/cltbld', 17:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:00 INFO - 'MOZ_NO_REMOTE': '1', 17:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:00 INFO - 'NO_EM_RESTART': '1', 17:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:00 INFO - 'PWD': '/builds/slave/test', 17:35:00 INFO - 'SHELL': '/bin/bash', 17:35:00 INFO - 'SHLVL': '1', 17:35:00 INFO - 'TERM': 'linux', 17:35:00 INFO - 'TMOUT': '86400', 17:35:00 INFO - 'USER': 'cltbld', 17:35:00 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:00 INFO - '_': '/tools/buildbot/bin/python'} 17:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:00 INFO - Running setup.py (path:/tmp/pip-kH8YIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:00 INFO - Running setup.py (path:/tmp/pip-Mnb8CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:00 INFO - Running setup.py (path:/tmp/pip-Zau6fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:00 INFO - Running setup.py (path:/tmp/pip-_KM9lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:00 INFO - Running setup.py (path:/tmp/pip-Ptybdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:00 INFO - Running setup.py (path:/tmp/pip-GxgMXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:00 INFO - Running setup.py (path:/tmp/pip-YxguJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:00 INFO - Running setup.py (path:/tmp/pip-N1Kfet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:00 INFO - Running setup.py (path:/tmp/pip-8pzxlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:01 INFO - Running setup.py (path:/tmp/pip-M5C80k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:01 INFO - Running setup.py (path:/tmp/pip-dQSVwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:01 INFO - Running setup.py (path:/tmp/pip-qQDk7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:01 INFO - Running setup.py (path:/tmp/pip-sxaA1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:01 INFO - Running setup.py (path:/tmp/pip-13uQYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:01 INFO - Running setup.py (path:/tmp/pip-4MI8Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:01 INFO - Running setup.py (path:/tmp/pip-HWe50s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:01 INFO - Running setup.py (path:/tmp/pip-fDmiFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:01 INFO - Running setup.py install for manifestparser 17:35:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:01 INFO - Running setup.py install for mozcrash 17:35:01 INFO - Running setup.py install for mozdebug 17:35:01 INFO - Running setup.py install for mozdevice 17:35:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Running setup.py install for mozfile 17:35:02 INFO - Running setup.py install for mozhttpd 17:35:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Running setup.py install for mozinfo 17:35:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Running setup.py install for mozInstall 17:35:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Running setup.py install for mozleak 17:35:02 INFO - Running setup.py install for mozlog 17:35:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Running setup.py install for moznetwork 17:35:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Running setup.py install for mozprocess 17:35:02 INFO - Running setup.py install for mozprofile 17:35:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:02 INFO - Running setup.py install for mozrunner 17:35:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:03 INFO - Running setup.py install for mozscreenshot 17:35:03 INFO - Running setup.py install for moztest 17:35:03 INFO - Running setup.py install for mozversion 17:35:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:03 INFO - Cleaning up... 17:35:03 INFO - Return code: 0 17:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:03 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 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:35:03 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 17:35:03 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 17:35:03 INFO - Using env: {'DISPLAY': ':0', 17:35:03 INFO - 'HOME': '/home/cltbld', 17:35:03 INFO - 'LANG': 'en_US.UTF-8', 17:35:03 INFO - 'LANGUAGE': 'en_US:en', 17:35:03 INFO - 'LOGNAME': 'cltbld', 17:35:03 INFO - 'MAIL': '/var/mail/cltbld', 17:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:03 INFO - 'MOZ_NO_REMOTE': '1', 17:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:03 INFO - 'NO_EM_RESTART': '1', 17:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:03 INFO - 'PWD': '/builds/slave/test', 17:35:03 INFO - 'SHELL': '/bin/bash', 17:35:03 INFO - 'SHLVL': '1', 17:35:03 INFO - 'TERM': 'linux', 17:35:03 INFO - 'TMOUT': '86400', 17:35:03 INFO - 'USER': 'cltbld', 17:35:03 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:03 INFO - '_': '/tools/buildbot/bin/python'} 17:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:03 INFO - Running setup.py (path:/tmp/pip-g1488P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:03 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)) 17:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:03 INFO - Running setup.py (path:/tmp/pip-yH9qvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:03 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)) 17:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:03 INFO - Running setup.py (path:/tmp/pip-_eiZNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:03 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)) 17:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:03 INFO - Running setup.py (path:/tmp/pip-8XA2fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:03 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)) 17:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:03 INFO - Running setup.py (path:/tmp/pip-NIF9kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:04 INFO - Running setup.py (path:/tmp/pip-R2IMkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:04 INFO - Running setup.py (path:/tmp/pip-z1l8ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:04 INFO - Running setup.py (path:/tmp/pip-afgCyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:04 INFO - Running setup.py (path:/tmp/pip-OitfsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:04 INFO - Running setup.py (path:/tmp/pip-RqszqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:04 INFO - Running setup.py (path:/tmp/pip-0JtkIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:04 INFO - Running setup.py (path:/tmp/pip-sS6zJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:04 INFO - Running setup.py (path:/tmp/pip-o2k8_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:04 INFO - Running setup.py (path:/tmp/pip-WsJUdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:04 INFO - Running setup.py (path:/tmp/pip-R8Oz5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:04 INFO - Running setup.py (path:/tmp/pip-iIjmQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:04 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)) 17:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:04 INFO - Running setup.py (path:/tmp/pip-rz79UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 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)) 17:35:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:04 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 17:35:04 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 17:35:04 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 17:35:04 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 17:35:04 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 17:35:04 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 17:35:06 INFO - Downloading blessings-1.6.tar.gz 17:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:06 INFO - Installing collected packages: blessings 17:35:06 INFO - Running setup.py install for blessings 17:35:07 INFO - Successfully installed blessings 17:35:07 INFO - Cleaning up... 17:35:07 INFO - Return code: 0 17:35:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:07 INFO - Reading from file tmpfile_stdout 17:35:07 INFO - Current package versions: 17:35:07 INFO - argparse == 1.2.1 17:35:07 INFO - blessings == 1.6 17:35:07 INFO - blobuploader == 1.2.4 17:35:07 INFO - docopt == 0.6.1 17:35:07 INFO - functools32 == 3.2.3-2 17:35:07 INFO - jsonschema == 2.5.1 17:35:07 INFO - manifestparser == 1.1 17:35:07 INFO - mozInstall == 1.12 17:35:07 INFO - mozcrash == 1.0 17:35:07 INFO - mozdebug == 0.1 17:35:07 INFO - mozdevice == 0.49 17:35:07 INFO - mozfile == 1.2 17:35:07 INFO - mozhttpd == 0.7 17:35:07 INFO - mozinfo == 0.9 17:35:07 INFO - mozleak == 0.1 17:35:07 INFO - mozlog == 3.4 17:35:07 INFO - moznetwork == 0.27 17:35:07 INFO - mozprocess == 0.25 17:35:07 INFO - mozprofile == 0.28 17:35:07 INFO - mozrunner == 6.13 17:35:07 INFO - mozscreenshot == 0.1 17:35:07 INFO - mozsystemmonitor == 0.3 17:35:07 INFO - moztest == 0.8 17:35:07 INFO - mozversion == 1.4 17:35:07 INFO - psutil == 3.1.1 17:35:07 INFO - requests == 1.2.3 17:35:07 INFO - wsgiref == 0.1.2 17:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35: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')]} 17:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35: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')]} 17:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:07 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 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:35:07 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 17:35:07 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 17:35:07 INFO - Using env: {'DISPLAY': ':0', 17:35:07 INFO - 'HOME': '/home/cltbld', 17:35:07 INFO - 'LANG': 'en_US.UTF-8', 17:35:07 INFO - 'LANGUAGE': 'en_US:en', 17:35:07 INFO - 'LOGNAME': 'cltbld', 17:35:07 INFO - 'MAIL': '/var/mail/cltbld', 17:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:07 INFO - 'MOZ_NO_REMOTE': '1', 17:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:07 INFO - 'NO_EM_RESTART': '1', 17:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:07 INFO - 'PWD': '/builds/slave/test', 17:35:07 INFO - 'SHELL': '/bin/bash', 17:35:07 INFO - 'SHLVL': '1', 17:35:07 INFO - 'TERM': 'linux', 17:35:07 INFO - 'TMOUT': '86400', 17:35:07 INFO - 'USER': 'cltbld', 17:35:07 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:07 INFO - '_': '/tools/buildbot/bin/python'} 17:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:07 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)) 17:35:07 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)) 17:35:07 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)) 17:35:07 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)) 17:35:07 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)) 17:35:07 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)) 17:35:07 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)) 17:35:07 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)) 17:35:07 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)) 17:35:07 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)) 17:35:07 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)) 17:35:07 INFO - Cleaning up... 17:35:07 INFO - Return code: 0 17:35:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35: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')]} 17:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35: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')]} 17:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, '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': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', '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 17:35:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:35:07 INFO - Using env: {'DISPLAY': ':0', 17:35:07 INFO - 'HOME': '/home/cltbld', 17:35:07 INFO - 'LANG': 'en_US.UTF-8', 17:35:07 INFO - 'LANGUAGE': 'en_US:en', 17:35:07 INFO - 'LOGNAME': 'cltbld', 17:35:07 INFO - 'MAIL': '/var/mail/cltbld', 17:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:07 INFO - 'MOZ_NO_REMOTE': '1', 17:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:07 INFO - 'NO_EM_RESTART': '1', 17:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:07 INFO - 'PWD': '/builds/slave/test', 17:35:07 INFO - 'SHELL': '/bin/bash', 17:35:07 INFO - 'SHLVL': '1', 17:35:07 INFO - 'TERM': 'linux', 17:35:07 INFO - 'TMOUT': '86400', 17:35:07 INFO - 'USER': 'cltbld', 17:35:07 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:07 INFO - '_': '/tools/buildbot/bin/python'} 17:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:07 INFO - Cleaning up... 17:35:07 INFO - Return code: 0 17:35:07 INFO - Running post-action listener: _resource_record_post_action 17:35:07 INFO - Running post-action listener: _start_resource_monitoring 17:35:07 INFO - Starting resource monitoring. 17:35:07 INFO - [mozharness: 2017-03-28 00:35:07.879907Z] Finished create-virtualenv step (success) 17:35:07 INFO - [mozharness: 2017-03-28 00:35:07.880376Z] Running install step. 17:35:07 INFO - Running pre-action listener: _resource_record_pre_action 17:35:07 INFO - Running main action method: install 17:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:08 INFO - Reading from file tmpfile_stdout 17:35:08 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:08 INFO - Reading from file tmpfile_stdout 17:35:08 INFO - Output received: 17:35:08 INFO - Usage: mozinstall [options] installer 17:35:08 INFO - Options: 17:35:08 INFO - -h, --help show this help message and exit 17:35:08 INFO - -d DEST, --destination=DEST 17:35:08 INFO - Directory to install application into. [default: 17:35:08 INFO - "/builds/slave/test"] 17:35:08 INFO - --app=APP Application being installed. [default: firefox] 17:35:08 INFO - mkdir: /builds/slave/test/build/application 17:35:08 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'] 17:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:35:23 INFO - Reading from file tmpfile_stdout 17:35:23 INFO - Output received: 17:35:23 INFO - /builds/slave/test/build/application/firefox/firefox 17:35:23 INFO - Running post-action listener: _resource_record_post_action 17:35:23 INFO - [mozharness: 2017-03-28 00:35:23.840313Z] Finished install step (success) 17:35:23 INFO - [mozharness: 2017-03-28 00:35:23.840461Z] Running run-tests step. 17:35:23 INFO - Running pre-action listener: _resource_record_pre_action 17:35:23 INFO - Running main action method: run_tests 17:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:23 INFO - Python 2.7.3 17:35:23 INFO - Return code: 0 17:35:23 INFO - grabbing minidump binary from tooltool 17:35:23 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')]} 17:35:23 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 0x2548290>, '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 0x2548b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:23 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 17:35:23 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 17:35:23 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 17:35:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:23 INFO - Return code: 0 17:35:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:35:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:23 INFO - ENV: RUST_BACKTRACE is now 1 17:35:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:35:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 17:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 17:35:23 INFO - Using env: {'DISPLAY': ':0', 17:35:23 INFO - 'HOME': '/home/cltbld', 17:35:23 INFO - 'LANG': 'en_US.UTF-8', 17:35:23 INFO - 'LANGUAGE': 'en_US:en', 17:35:23 INFO - 'LOGNAME': 'cltbld', 17:35:23 INFO - 'MAIL': '/var/mail/cltbld', 17:35:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:23 INFO - 'MOZ_NO_REMOTE': '1', 17:35:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:23 INFO - 'NO_EM_RESTART': '1', 17:35:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:23 INFO - 'PWD': '/builds/slave/test', 17:35:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:23 INFO - 'RUST_BACKTRACE': '1', 17:35:23 INFO - 'SHELL': '/bin/bash', 17:35:23 INFO - 'SHLVL': '1', 17:35:23 INFO - 'TERM': 'linux', 17:35:23 INFO - 'TMOUT': '86400', 17:35:23 INFO - 'USER': 'cltbld', 17:35:23 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1490661255.384742-728312733', 17:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:23 INFO - '_': '/tools/buildbot/bin/python'} 17:35:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 17:35:24 INFO - mozversion application_buildid: 20170328000339 17:35:24 INFO - mozversion application_changeset: a8bb5c8e0e80e87e21ad63997f8881991b5347cf 17:35:24 INFO - mozversion application_display_name: Nightly 17:35:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:24 INFO - mozversion application_name: Firefox 17:35:24 INFO - mozversion application_remotingname: firefox 17:35:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:35:24 INFO - mozversion application_vendor: Mozilla 17:35:24 INFO - mozversion application_version: 55.0a1 17:35:24 INFO - mozversion platform_buildid: 20170328000339 17:35:24 INFO - mozversion platform_changeset: a8bb5c8e0e80e87e21ad63997f8881991b5347cf 17:35:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:35:24 INFO - mozversion platform_version: 55.0a1 17:35:24 INFO - using testdate: 1490661324 17:35:24 INFO - actual date: 1490661324 17:35:24 INFO - starting webserver on 'localhost:50336' 17:35:24 INFO - SUITE-START | Running 2 tests 17:35:24 INFO - TEST-START | dromaeo_css 17:35:24 INFO - operating with platform_type : linux_ 17:35:24 INFO - Initialising browser for dromaeo_css test... 17:35:24 INFO - TEST-INFO | started process 7386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGiEvxJ/profile http://localhost:50336/getInfo.html) 17:35:28 INFO - PID 7386 | __metrics Screen width/height:1600/1200 17:35:28 INFO - PID 7386 | colorDepth:24 17:35:28 INFO - PID 7386 | Browser inner width/height: 1024/697 17:35:28 INFO - PID 7386 | __metrics 17:35:29 ERROR - PID 7386 | 1490661329536 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:35:29 INFO - PID 7386 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:35:29 INFO - PID 7386 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:35:30 INFO - TEST-INFO | 7386: exit 0 17:35:30 INFO - Browser initialized. 17:35:30 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:30 INFO - TEST-INFO | started process 7477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGiEvxJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:42 INFO - PID 7477 | RSS: Main: 149590016 17:35:42 INFO - PID 7477 | 17:38:49 INFO - PID 7477 | Cycle 1(1): loaded http://localhost:50336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50336/tests/dromaeo/cssquery-ext.html) 17:38:50 INFO - PID 7477 | RSS: Main: 288669696 17:38:50 INFO - PID 7477 | 17:40:32 INFO - PID 7477 | ************************* 17:40:32 INFO - PID 7477 | A coding exception was thrown and uncaught in a Task. 17:40:32 INFO - PID 7477 | 17:40:32 ERROR - PID 7477 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:32 INFO - PID 7477 | Full stack: 17:40:32 INFO - PID 7477 | ************************* 17:40:32 INFO - PID 7477 | ************************* 17:40:32 INFO - PID 7477 | A coding exception was thrown and uncaught in a Task. 17:40:32 INFO - PID 7477 | 17:40:32 ERROR - PID 7477 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:32 INFO - PID 7477 | Full stack: 17:40:32 INFO - PID 7477 | ************************* 17:40:32 INFO - PID 7477 | ************************* 17:40:32 INFO - PID 7477 | A coding exception was thrown and uncaught in a Task. 17:40:32 INFO - PID 7477 | 17:40:32 ERROR - PID 7477 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:32 INFO - PID 7477 | Full stack: 17:40:32 INFO - PID 7477 | ************************* 17:40:32 INFO - PID 7477 | ************************* 17:40:32 INFO - PID 7477 | A coding exception was thrown and uncaught in a Task. 17:40:32 INFO - PID 7477 | 17:40:32 ERROR - PID 7477 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:32 INFO - PID 7477 | Full stack: 17:40:32 INFO - PID 7477 | ************************* 17:41:53 INFO - PID 7477 | Cycle 1(1): loaded http://localhost:50336/tests/dromaeo/cssquery-ext.html (next: http://localhost:50336/tests/dromaeo/cssquery-jquery.html) 17:41:54 INFO - PID 7477 | RSS: Main: 233885696 17:41:54 INFO - PID 7477 | 17:44:56 INFO - PID 7477 | Cycle 1(1): loaded http://localhost:50336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50336/tests/dromaeo/cssquery-mootools.html) 17:44:56 INFO - PID 7477 | RSS: Main: 240140288 17:44:56 INFO - PID 7477 | 17:47:59 INFO - PID 7477 | Cycle 1(1): loaded http://localhost:50336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50336/tests/dromaeo/cssquery-prototype.html) 17:47:59 INFO - PID 7477 | RSS: Main: 180387840 17:47:59 INFO - PID 7477 | 17:51:02 INFO - PID 7477 | Cycle 1(1): loaded http://localhost:50336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50336/tests/dromaeo/cssquery-yui.html) 17:51:03 INFO - PID 7477 | RSS: Main: 185278464 17:51:03 INFO - PID 7477 | 17:54:06 INFO - PID 7477 | Cycle 1(1): loaded http://localhost:50336/tests/dromaeo/cssquery-yui.html (next: http://localhost:50336/tests/dromaeo/cssquery-dojo.html) 17:54:07 INFO - PID 7477 | RSS: Main: 279805952 17:54:07 INFO - PID 7477 | 17:54:07 INFO - PID 7477 | __start_tp_report 17:54:07 INFO - PID 7477 | _x_x_mozilla_page_load 17:54:07 INFO - PID 7477 | _x_x_mozilla_page_load_details 17:54:07 INFO - PID 7477 | |i|pagename|runs| 17:54:07 INFO - PID 7477 | |0;dojo.html;2660.388110734531;2674.7860171186308;2709.227870057034;2712.6609173853267;2720.3199200199942;5010.348654674887;5034.09386310464;5156.407013193484;5164.793408263669;5222.060029194743;5087.6693014954;5105.846824595259;5146.871328216796;5151.639385243035;5176.404713457953;4612.331211974279;4639.327297541854;4665.88335291617;4758.833440829571;4820.228763397857;4768.880777980561;4806.110869489138;4812.061647978628;4814;4819.373481447407;4548;4586.587207151339;4601.12578610063;4632.8146874125;4735.029318989599;4698.882527936795;4705.623550116016;4705.647076469244;4763.666543341968;4764.523547645208;4645.744484053375;4675.976620116878;4687.9765601171775;4700.576948074656;4727.243641017455;4931.80272789088;4974.751262436864;5133.974330128325;5143.048536020848;5196.714180720059;5377.7580008899695;5395.190721391783;5396.946030539683;5399.595030372738;5408.107662235727;5417.918731219035;5420.566354691615;5423.5932305076885;5426.728663566845;5433.8369848904595;5001.624878134082;5043.546080852704;5049.267856160836;5051.545360917535;5112.897742045138;5648.6893220872425;5693.032184528557;5704.429557044263;5746.741396637161;5764.884702306014;5181.274621552986;5227.660202086852;5236.266922630834;5434.212039254286;5453.345598528202;5508.118701007819;5511.476409741068;5512.200730893998;5516.338039435213;5558.916616250759;5449.809256675997;5452.482014208644;5456.181572764117;5458.699771512605;5487.807926722626;5275.868103297372;5340.385855626575;5354.866128346823;5357.491038351351;5358.866028349323;4601.401817763669;4612.262038073892;4620.214563524209;4631.791569379386;4660.04469083837;3972.443857859902;3982.143839074613;3985.242803867314;4008.9799551002056;4027.436158937751;4755.5482229188865;4770.427548694179;4771.117343291502;4772;4813.326134341195;5351.09031464652;5367.946320536823;5376.542993845567;5555.833325000256;5578.637388569811;4713.2458806590785;4713.269443236304;4716.033213191287;4742.430908291027;4744.620430365562;4933.112039832865;4938.8518344449;4944.48082951285;4949.059678661043;4997.225430058346;5001.1498045331655;5183.66306190104;5188.533032027136;5193.896122077613;5241.816536421359;5374.704391258519;5440.6735595864375;5456.427075157051;5461.42655021233;5481.314835645544;5244.370675518962;5253.028189784902;5253.343332083489;5254.15933450646;5258.737063146904;5449.700266485382;5451.046066938349;5452.591055670761;5452.836414907559;5505.119180931032;5494.642848214853;5535.6955367455175;5541.722913854372;5543.473370029841;5545.805896793754;5209.869753256199;5266.052110620125;5266.683998960075;5360.303160589098;5371.382291036581;5404.243405923095;5405.648632838853;5413.864653383697;5448.700321482356;5450.209719590558;5314.893702125859;5329.227262046904;5332.6000549958135;5338.839834804807;5385.542228910586;5216.321878155815;5218.869528261824;5369.624126311277;5403.081476149143;5419.566434685295;5138.8972220556125;5207.583393328448;5239.842804715865;5258.263843061898;5262.052830490548 17:54:07 INFO - PID 7477 | |1;ext.html;622.3962756126556;680.805970298465;699.3111784891883;1059.5973530058577;1070.9571617135316;25827.612585811203;31438.68561314386;32087.518687219712;32238.516422253626;32313.67686323136;36363.4545481818;37225;37282.62717372825;37295;37322.626773732256;5674.09214525676;5779.971100144515;7381.409487241035;7531.472796904219;7543.471956963015;7212.386947109502;7397.409556945256;7435.665395057208;7440.776776696708;7445.181030086686;7427.628618569077;7524.473286869921;7528.397728181732;7528.736494222703;7529.736459223928;7418.517796343247;7466.402687784964;7476.775696729107;7482.812929676747;7484.438667099962;7289.161746399179;7290.489665723401;7292.19785823559;7380.9261907381315;7577.446623442181;34041.31917361663;34172.82913585441;34224.48663270053;34274.48588271178;34335.656643433496;2552.234329701082;2565.653636759051;2573.6654234949524;2601.4666993266337;2658.5480468320434;21697.34907952748;21776.564468710694;21992.120315187374;22034.33896983093;23278;2937.8677959491874;2964.9110526684235;2979.731824135838;2981.329200929795;2988.865501052458;136615;136640.31679841637;136846.3157684215;137056;137270.31364843211;40741.1851762969;40741.59258407378;40847.59152408497;40879.38680919789;40958.180836383704;42724;42725.35911961323;42727;42743.78628106902;42774.358384624255;12826.743465130832;13122.14706044104;13123.868761312264;13147.539836105881;13152.473901044043;8301.543415112226;8405.327573794082;10458.790824183474;10461.790764184674;10482.423466709251;11271.943640281746;11414.714632134097;11448.084153267719;12782.744345113046;12846;5277.445868183862;5509.741006187444;5512.594288456418;5563.749631266603;5582.2925880947705;856.7215654912178;882.3162049411629;890.0787684746257;901.733988473402;920.5903372998952;19733.210671572975;20575.691364629543;21361.14555417766;21494.677579836316;21834.454138646663;977.4868194198103;979.1236843025453;981.74474636595;984.6209209454412;1005.3615953869199;10921.781564368668;10989;11141.777164456666;11168.106551475863;11217.3830439325;232671;233048;234122;234725;234745;42055.7897210512;42278.788606056776;42336.78831605822;42378.364324535156;42491.36262956058;1174.9647510574696;1195.4142470189545;1199.4662375242933;1202.7173614200656;1244.8195011723249;19739.901300493406;19808;20588;20853.582928341653;20960.266390676865;30107.096787096423;30165.09504714862;30184.5472317911;30198.245043874078;30204.395912082076;205392;206985;207049;207176;208127;28250;28280.575791363557;28835.56746648844;28908.566371504025;29148.125556233346;27411.725882740917;28670.713292866803;28857.278568035126;32279.35441291208;34108.488372673935;24902.37744056413;26939;27617.585736213572;28103.156905292875;29088.98188563475;27693.75526172452;27812.443751124458;28143.296417588906;28651.997180098595;28736.856315718287;30267.69732302649;30472.238194045327;30547.847260764443;30575.694243057285;30766.846165769028;27262.318442039108;27463.450730985667;27546;27732;27913.58129628098;20530.281440149523;21579;21733.673994890407;21844;21850 17:54:07 INFO - PID 7477 | |2;jquery.html;427.5211762825636;428.78053829207363;430.20197533575225;443.73819446526545;449.914516241914;16643.50069497914;17288.82711172888;17994.280228790867;18013.7297940531;19020.9048954755;18585.256589736393;18764.53088672784;19317.710234346498;19464.610707785836;19470.805291947076;5606.887862242753;5781.19063331134;5820.941790582104;5840.445157710011;5845.386234445396;5654.236678048473;5758;5794.68129252891;5797.478226959573;5801.100829371454;5704.543636509069;5709.31488221414;5712.742926568314;5715.399883012286;5783.074708046714;5557.277553917965;5718.542516598683;5723.570732195081;5750.568707346944;5792;5307.150855863082;5312.1766126250495;5313.548348390392;5314.096603577363;5320.122179840322;22736.65895011576;22972.310830675106;22995.77004229953;23246.883765581064;23350.18274360389;1548.0866288889608;1548.9389768008837;1549.4654344251214;1602.8717702583765;1605.6146524833955;13330.466781328832;13737.931310343385;14423.639409014753;14669.853301466956;15115.622109447242;1637.6151604372963;1691.8646508279307;1692.5176324747388;1694.1783235130952;1709.7264437690035;86745.13254867433;93657;93675;95917;96397;11146.219764616399;11186;11382.260153090023;11464.31214127155;11539.423028848523;16228.269727862275;16235.837641623433;16266.918665406598;16273.51179464618;16276.75584866228;7548.924510754932;7736.497127686683;7750.496217745828;7879.960600196962;7937.7618671438795;7052.400545953651;7061.611611361322;7225;7256;7259.963700181465;7150.856982860314;7266.7093316266755;7275.4179665626625;7297.197308296083;7323.267673232741;2074.8358752901945;2093.2464312847364;2107.6943843142967;2115.978840211609;2374.655674927126;834.6828205282076;852.7015544559355;861.2033868671454;870.8432482153147;878.9033206347297;16885.662286754196;16963.236654350585;17452;17692.469225923243;18058.187381567863;865.5931712095305;867.0938868882033;890.5903284489078;895.9059298773665;896.8834051573384;8879.822403551892;8962.73111806647;9544.379615324982;9583.760405989766;9648.996530173546;425851;428212;454760;454949;456310;85603;85951.57024214839;86404.56797716097;86977;87233;1070.6252811516063;1078.983815242772;1091.2688498705886;1102.4873433853297;1108.2242430298822;14824.703505930036;15919.840801591836;17329.82670173282;17497.637818894797;17852.55368615795;42547.744050049965;43089.35365969576;43303;43820.34269485896;44550.10899782051;50450;50797.492025080755;50963;51003.74498127485;51138.488615113376;7454.701811927463;7494.850102998019;7610.162882083077;7739.961300193463;8057.798555035936;11263.66209013731;12022.699432514257;12965.416556254802;13261.80107298372;13335.533256335983;10296.588136474456;10404.271700980858;10461.424621645578;10664.573417063231;10778.191635627516;9842.950785246028;10046.69859904204;10050.547725352231;10076.143527800219;10100.444475553915;10331.32846364984;10489.213309002009;10882.782344353227;10894.727631809268;11022.944885275523;8339.679174194567;8399.076101628938;8572.228499434832;8651.783705407415;8668.609912553824;9597.856032159383;9602.279829012992;9664.245689978323;9814.214862810815;9935.403875767477 17:54:07 INFO - PID 7477 | |3;mootools.html;1077.3589714120096;1208.2327721896595;1237.566851601939;1243.5709680160342;1251.5556977273075;8169.632366543505;9601.759956001104;9689.515524223787;9788.119069283763;9825.312228144032;9558.330916835825;9666.661666841663;9968.451735154582;9970.202383809295;9975.351602145856;1863.9906800465978;2188.9890550547307;2246.9101235950543;2248.8313376496744;2249.1228420915772;1885.5097674604565;1893.4982229709137;1907.2371051579341;1911.9904400477978;2159.0392275437434;2164.9242276520326;2175.4887601413657;2176.1404245323088;2182.9890850545726;2184.9016794244217;2073.6371135051304;2102.9789702102935;2107.7892210778955;2110.3352443980175;2115.947101322464;2102.2221777942104;2150.602138604363;2163.7836216378396;2186.431527802767;2189.2665956904457;9721.56252968611;9840.95079524605;9930.702078937644;9947.104760571583;9948.104670579683;5416.268803711488;5634.154876768476;5639.577031722596;5644.294463192101;5648.830535083913;2901.2891841498968;2935.4129174165037;3099.612548431446;3118.8908388206532;3121.9687803121906;953.2659851913987;979.3193730357405;980.0493521284343;987.6000219910948;988.1156365053309;14605.415783368759;14610.342534585969;14651.560453186421;14669.926650366786;14672.559823205322;4965.1807451770055;5258.211268309784;5281.471852814765;5288.101022826128;5296.285001524745;12232.75534489323;12235.265884046985;12242.81635775464;12244.755104897853;12248.693782655504;5582.692951887604;5721.685307308138;5726.198332233491;5726.9713651431475;5749.913751293734;5002.624803139779;5053;5160.870978225499;5188.11801993662;5204.453532379046;3788.1287303919703;3878.3019056569524;4108.342665173617;4110.938335924963;4192.790360481964;1311.9737605247842;1318.5504873874506;1320.6764342735898;1343.4894739998933;1365.3992243412868;563.4426829503157;659.9373059559334;675.1088563096763;681.7613835157754;690.2303931116769;5342.332208473941;5480.232767412565;5675.120356344773;5740.684262365527;5793.391693872167;805.7341077444429;807.6244546286006;810.7162493127358;830.3772170871846;844.8014716541608;3594.514740509998;3644.799536025491;3668.413053911361;3674.81625918703;3741.0834345585504;12630;12949.741005180033;13232.470701172038;13233.93383033098;13264.535741249203;12033.63899083029;13199.604011879659;13224.669383265495;13228.669283267995;13248.536301229604;9179.58691858868;9470.052994700613;9476;9476.95261523688;9480.762980925532;5875.3243377010485;5882.823515294548;5916.970415147896;5963.403659634002;6081.209442772411;11413.258138220988;11593.130515211224;11712.765744685228;11747.412629368668;11867.58463453775;11476.483558240066;11735.589254376056;11742.412879356169;11830.467628956545;11844.70388240301;8048.879266810885;8201.384896132695;8325.084240733393;8329.95835020821;8341.41610087288;9208.861867071866;9214.861777073214;9289.303302252223;9308.627654893999;9410.52947352616;7659.617019148909;7688.730894418669;7695.384369250559;7725.111612164673;7817.37461003107;7419.591922444318;7480.4015678746655;7500.512466689648;7510.812229694301;7558.546487210785;6806.455483561403;6907.75822846218;6968.860622787414;6969.756058537927;6972.477064220102;5204.453532379046;5218.8956220876125;5264.894702106013;5275.920861187008;5309.628326017141;5362.785488580569;5427.402985671652;5494.203340515683;5554.833354999357;5589.357223919302 17:54:07 INFO - PID 7477 | |4;prototype.html;379.9088218827482;387.25840016368653;391.0477986103837;396.58556808135495;397.88063580925717;5095.490450954907;5142.305788718522;5186.429492755803;5196;5232.2151677248385;4838.637102217339;5126.487351264872;5126.538611524962;5134.512221338976;5147.459516750743;4017.774578753472;4053.5949802166174;4054.3918412238254;4068.735532190413;4078.89802754932;4040.878538767156;4041.9595804042024;4049.2711311963835;4071.246819338417;4072.228580567448;4043;4043.555208927016;4045.9885028742815;4049.5343035550845;4051.5340735815316;3960.4851369321946;4152.190322887023;4154.750714957082;4170.103427763015;4171.937420938689;3739.2521495700967;3769.4722738816586;3773.6792372648356;3779.036345731821;3789.3747531657245;5110;5120.334356533664;5134.64057515974;5135.764468384894;5142.717150556718;4687.203175460146;4830.613550915953;4839.2983017462275;4840.370751802243;4853.320535125085;5484.670919744828;5500.862478438071;5509.146082357241;5528.9723551382385;5540.529055030327;4148.211839750437;4152.896177595554;4157.605027522381;4159.9376009359885;4160.355144952507;5603.971980140073;5750.2237197978575;5803.47768700819;5808;5825.970870145665;4297.763623000765;4309.698321117492;4311.267084595626;4312.54718254585;4320.481542214954;4369.104333611602;4383.539728328544;4383.561643835655;4401.471823381215;4403.185410699031;4575.496695363508;4795.520447955177;4848.684835485682;4855.174620314555;4870.220764677634;5507.0637991541535;5510.228568000483;5514.779408823602;5537.36320323168;5538.169274608841;1495.424261659269;1515.9696806064037;1521.5815650695927;1525.2221367102636;1525.4660868695867;1088.8530048443517;1103.8840921703106;1107.9889201108047;1113.9443027848738;1118.222835129577;4824.300476430898;4830;4853.854384368475;4858.416989961227;4878.8780280492565;5683.943160568424;5684.715764211773;5688.829335119953;5700.315962084576;5701;4643.141018911512;4799.928001079987;4806.615470762331;4835.6131509479155;4854.611631069506;2986.148947549938;3009.337945651953;3014.291641464254;3014.427258820817;3017.7887547871437;5299.417064122943;5325.440828713007;5329.1206950852675;5341.919871201935;5346.224797404355;5538.335399752055;5645.5201307888465;5708.457696518907;5774.769009239583;5811.215485909433;5191.454897235812;5295.4969277918535;5330.866728331745;5338.225957236179;5372.62391632582;5694.914576281276;5701.857453563694;5709.400512946081;5709.800156994485;5714;5454.626879039729;5506.146547285177;5584.776608935597;5610.429079857647;5611.4568493664565;5284.471552844685;5292.470752924677;5301.867453313698;5306.416294207557;5317.361916569882;4256.59562341577;4262.360645903139;4264.91470170601;4265.91468170641;4266.573342665709;5437.619366644297;5634.802781902614;5637.2107904894165;5664.716764161858;5706.28671416073;5432.755526001419;5447.863803404946;5469;5469.507744303032;5493.725313734377;5318.601104917069;5446.645968012067;5466.234727138124;5476;5512.39363670004;5386.218998245311;5395.811146610007;5401.945980540144;5405;5424.891502170013;5457.399686034612;5482.890342193214;5496.148097044965;5503.862403439946;5515.641483303572;5128.743562821769;5370.167624018283;5373.623846330719;5390.164524498709;5400.487863398254 17:54:07 INFO - PID 7477 | |5;yui.html;678.8642271545692;703.8697840899432;704.200732168988;704.5878161275654;708.844054308052;13041;13640;13702.931485342559;13716.862831371696;13726.519571814988;12448.43982020809;14846;15362.308696108674;15664.451744188955;15682.529524114267;844.3667249562828;853.8761879527481;867.3624885708999;869.5782545465444;870.0255713600776;853.9530325832077;875.0199776250608;875.0330884372772;875.129246399833;875.4528419737663;906.2478143141177;916.2578311567618;916.8028873792133;917.7843206846386;917.7843206846386;907.8910530736321;907.9409838360485;908.3459908865606;914.4284821986258;915.7573243090586;663.4427081251772;664.7573635623011;666.1805978646244;666.6333516565918;666.6866572710818;13640.727185456335;13996.510122145675;14604.34280457382;14792.482263120846;14862.479813206486;12967.805482917764;14419.639509012359;14425.422983080769;14512;14516.346764395628;10731;10732.141428685687;10762.569497220102;10785.5685772569;10961.506732197071;2660.1088635307196;2689.542777727791;2707.810453268272;2718.1981315511775;2734.111413790506;63696.68151659259;63835.68082159606;64029;64785.67607161981;65167.674161628885;10146.847797283046;10148.695539133838;10362.689119326433;10379.429131397847;10742.785144297226;20746.896265518575;21150.576988460143;21174;21377.893110534347;21391.57216855654;6554.508411869129;6585.86828263432;6623.470122390294;6704.094947182166;6725.092112564839;3508.3509550733197;3540.150363912642;3559.394902866519;3610.711143108545;3617.855285788539;3682.815859207029;3733.2346868891814;3743.5694895086867;3754.249150169977;3812.8093595320124;627.1439485102893;628.6668065925068;635.329727137874;638.1894993358409;639.9523016918013;539.2208259065612;541.3152362261742;552.8811305569321;561.7359840874782;572.2903599536545;8251.381146414044;8528.464876322198;8551.444156129832;8720.738377848675;9016.729498115066;506.4024451147607;513.2378418049194;526.0662324374266;526.4945652173956;534.2707204665603;3807.8286477108595;3876.1860009398342;3934.6655534279907;3968.940465893014;4019.2765302245293;60170.39829601735;60426.395736042075;62028;62201;63541;54784.17823732647;55075;55645.72177139169;55858.720706396205;56144.438555613924;48357;48521.272180917316;49102.50897491051;49162.754186229555;49504.25743613848;7632.694692212472;7732.420068494998;7794.727184548514;7976;8068.112507624274;25515;25899.741002589733;26210.73789262083;26618.334541636614;26959.652017399443;32548.51177232391;32805;32960.83519582387;33095.33809323848;33663.326733465685;9902.455364954996;10100.49497525106;10257.33327333721;10304.587816487556;10371.844422333821;10645.787084258427;10900.563977440814;10954.178436617445;11433.485493152662;11563;9539.614667743324;9917.851232231378;9928.453935033642;9940.602375904882;10259;9715.902840971783;10001.199904007517;10247.897521024694;10457.26799124054;10492.422916739653;9415.670451534163;9735.26985476078;9942.502874856084;10195.694129176136;10293.84559231597;7203.351698347174;7246.130464344313;7423.740169094056;7488.475806693479;7550.8867366990635;7456.701731930662;7734.613269336398;8140.389470789596;8320.12638672955;8451.070382258069 17:54:07 INFO - PID 7477 | __end_tp_report 17:54:07 INFO - PID 7477 | __start_cc_report 17:54:07 INFO - PID 7477 | _x_x_mozilla_cycle_collect,1523 17:54:07 INFO - PID 7477 | __end_cc_report 17:54:07 INFO - PID 7477 | __startTimestamp1490662447031__endTimestamp 17:54:07 INFO - PID 7477 | 17:54:07 INFO - PID 7477 | ------- Summary: start ------- 17:54:07 INFO - PID 7477 | Number of tests: 6 17:54:07 INFO - PID 7477 | 17:54:07 INFO - PID 7477 | [#0] dojo.html Cycles:165 Average:5053.08 Median:5216.32 stddev:555.44 (10.6%) stddev-sans-first:524.47 17:54:07 INFO - PID 7477 | Values: 2660.4 2674.8 2709.2 2712.7 2720.3 5010.3 5034.1 5156.4 5164.8 5222.1 5087.7 5105.8 5146.9 5151.6 5176.4 4612.3 4639.3 4665.9 4758.8 4820.2 4768.9 4806.1 4812.1 4814.0 4819.4 4548.0 4586.6 4601.1 4632.8 4735.0 4698.9 4705.6 4705.6 4763.7 4764.5 4645.7 4676.0 4688.0 4700.6 4727.2 4931.8 4974.8 5134.0 5143.0 5196.7 5377.8 5395.2 5396.9 5399.6 5408.1 5417.9 5420.6 5423.6 5426.7 5433.8 5001.6 5043.5 5049.3 5051.5 5112.9 5648.7 5693.0 5704.4 5746.7 5764.9 5181.3 5227.7 5236.3 5434.2 5453.3 5508.1 5511.5 5512.2 5516.3 5558.9 5449.8 5452.5 5456.2 5458.7 5487.8 5275.9 5340.4 5354.9 5357.5 5358.9 4601.4 4612.3 4620.2 4631.8 4660.0 3972.4 3982.1 3985.2 4009.0 4027.4 4755.5 4770.4 4771.1 4772.0 4813.3 5351.1 5367.9 5376.5 5555.8 5578.6 4713.2 4713.3 4716.0 4742.4 4744.6 4933.1 4938.9 4944.5 4949.1 4997.2 5001.1 5183.7 5188.5 5193.9 5241.8 5374.7 5440.7 5456.4 5461.4 5481.3 5244.4 5253.0 5253.3 5254.2 5258.7 5449.7 5451.0 5452.6 5452.8 5505.1 5494.6 5535.7 5541.7 5543.5 5545.8 5209.9 5266.1 5266.7 5360.3 5371.4 5404.2 5405.6 5413.9 5448.7 5450.2 5314.9 5329.2 5332.6 5338.8 5385.5 5216.3 5218.9 5369.6 5403.1 5419.6 5138.9 5207.6 5239.8 5258.3 5262.1 17:54:07 INFO - PID 7477 | 17:54:07 INFO - PID 7477 | [#1] ext.html Cycles:180 Average:33074.61 Median:2951.39 stddev:51299.64 (1738.2%) stddev-sans-first:51385.68 17:54:07 INFO - PID 7477 | Values: 622.4 680.8 699.3 1059.6 1071.0 25827.6 31438.7 32087.5 32238.5 32313.7 36363.5 37225.0 37282.6 37295.0 37322.6 5674.1 5780.0 7381.4 7531.5 7543.5 7212.4 7397.4 7435.7 7440.8 7445.2 7427.6 7524.5 7528.4 7528.7 7529.7 7418.5 7466.4 7476.8 7482.8 7484.4 7289.2 7290.5 7292.2 7380.9 7577.4 34041.3 34172.8 34224.5 34274.5 34335.7 2552.2 2565.7 2573.7 2601.5 2658.5 21697.3 21776.6 21992.1 22034.3 23278.0 2937.9 2964.9 2979.7 2981.3 2988.9 136615.0 136640.3 136846.3 137056.0 137270.3 40741.2 40741.6 40847.6 40879.4 40958.2 42724.0 42725.4 42727.0 42743.8 42774.4 12826.7 13122.1 13123.9 13147.5 13152.5 8301.5 8405.3 10458.8 10461.8 10482.4 11271.9 11414.7 11448.1 12782.7 12846.0 5277.4 5509.7 5512.6 5563.7 5582.3 856.7 882.3 890.1 901.7 920.6 19733.2 20575.7 21361.1 21494.7 21834.5 977.5 979.1 981.7 984.6 1005.4 10921.8 10989.0 11141.8 11168.1 11217.4 232671.0 233048.0 234122.0 234725.0 234745.0 42055.8 42278.8 42336.8 42378.4 42491.4 1175.0 1195.4 1199.5 1202.7 1244.8 19739.9 19808.0 20588.0 20853.6 20960.3 30107.1 30165.1 30184.5 30198.2 30204.4 205392.0 206985.0 207049.0 207176.0 208127.0 28250.0 28280.6 28835.6 28908.6 29148.1 27411.7 28670.7 28857.3 32279.4 34108.5 24902.4 26939.0 27617.6 28103.2 29089.0 27693.8 27812.4 28143.3 28652.0 28736.9 30267.7 30472.2 30547.8 30575.7 30766.8 27262.3 27463.5 27546.0 27732.0 27913.6 20530.3 21579.0 21733.7 21844.0 21850.0 17:54:07 INFO - PID 7477 | 17:54:07 INFO - PID 7477 | [#2] jquery.html Cycles:180 Average:27562.16 Median:227604.96 stddev:73649.27 (32.4%) stddev-sans-first:73827.69 17:54:07 INFO - PID 7477 | Values: 427.5 428.8 430.2 443.7 449.9 16643.5 17288.8 17994.3 18013.7 19020.9 18585.3 18764.5 19317.7 19464.6 19470.8 5606.9 5781.2 5820.9 5840.4 5845.4 5654.2 5758.0 5794.7 5797.5 5801.1 5704.5 5709.3 5712.7 5715.4 5783.1 5557.3 5718.5 5723.6 5750.6 5792.0 5307.2 5312.2 5313.5 5314.1 5320.1 22736.7 22972.3 22995.8 23246.9 23350.2 1548.1 1548.9 1549.5 1602.9 1605.6 13330.5 13737.9 14423.6 14669.9 15115.6 1637.6 1691.9 1692.5 1694.2 1709.7 86745.1 93657.0 93675.0 95917.0 96397.0 11146.2 11186.0 11382.3 11464.3 11539.4 16228.3 16235.8 16266.9 16273.5 16276.8 7548.9 7736.5 7750.5 7880.0 7937.8 7052.4 7061.6 7225.0 7256.0 7260.0 7150.9 7266.7 7275.4 7297.2 7323.3 2074.8 2093.2 2107.7 2116.0 2374.7 834.7 852.7 861.2 870.8 878.9 16885.7 16963.2 17452.0 17692.5 18058.2 865.6 867.1 890.6 895.9 896.9 8879.8 8962.7 9544.4 9583.8 9649.0 425851.0 428212.0 454760.0 454949.0 456310.0 85603.0 85951.6 86404.6 86977.0 87233.0 1070.6 1079.0 1091.3 1102.5 1108.2 14824.7 15919.8 17329.8 17497.6 17852.6 42547.7 43089.4 43303.0 43820.3 44550.1 50450.0 50797.5 50963.0 51003.7 51138.5 7454.7 7494.9 7610.2 7740.0 8057.8 11263.7 12022.7 12965.4 13261.8 13335.5 10296.6 10404.3 10461.4 10664.6 10778.2 9843.0 10046.7 10050.5 10076.1 10100.4 10331.3 10489.2 10882.8 10894.7 11022.9 8339.7 8399.1 8572.2 8651.8 8668.6 9597.9 9602.3 9664.2 9814.2 9935.4 17:54:07 INFO - PID 7477 | 17:54:07 INFO - PID 7477 | [#3] mootools.html Cycles:180 Average:6242.06 Median:5278.70 stddev:4000.43 (75.8%) stddev-sans-first:3992.82 17:54:07 INFO - PID 7477 | Values: 1077.4 1208.2 1237.6 1243.6 1251.6 8169.6 9601.8 9689.5 9788.1 9825.3 9558.3 9666.7 9968.5 9970.2 9975.4 1864.0 2189.0 2246.9 2248.8 2249.1 1885.5 1893.5 1907.2 1912.0 2159.0 2164.9 2175.5 2176.1 2183.0 2184.9 2073.6 2103.0 2107.8 2110.3 2115.9 2102.2 2150.6 2163.8 2186.4 2189.3 9721.6 9841.0 9930.7 9947.1 9948.1 5416.3 5634.2 5639.6 5644.3 5648.8 2901.3 2935.4 3099.6 3118.9 3122.0 953.3 979.3 980.0 987.6 988.1 14605.4 14610.3 14651.6 14669.9 14672.6 4965.2 5258.2 5281.5 5288.1 5296.3 12232.8 12235.3 12242.8 12244.8 12248.7 5582.7 5721.7 5726.2 5727.0 5749.9 5002.6 5053.0 5160.9 5188.1 5204.5 3788.1 3878.3 4108.3 4110.9 4192.8 1312.0 1318.6 1320.7 1343.5 1365.4 563.4 659.9 675.1 681.8 690.2 5342.3 5480.2 5675.1 5740.7 5793.4 805.7 807.6 810.7 830.4 844.8 3594.5 3644.8 3668.4 3674.8 3741.1 12630.0 12949.7 13232.5 13233.9 13264.5 12033.6 13199.6 13224.7 13228.7 13248.5 9179.6 9470.1 9476.0 9477.0 9480.8 5875.3 5882.8 5917.0 5963.4 6081.2 11413.3 11593.1 11712.8 11747.4 11867.6 11476.5 11735.6 11742.4 11830.5 11844.7 8048.9 8201.4 8325.1 8330.0 8341.4 9208.9 9214.9 9289.3 9308.6 9410.5 7659.6 7688.7 7695.4 7725.1 7817.4 7419.6 7480.4 7500.5 7510.8 7558.5 6806.5 6907.8 6968.9 6969.8 6972.5 5204.5 5218.9 5264.9 5275.9 5309.6 5362.8 5427.4 5494.2 5554.8 5589.4 17:54:07 INFO - PID 7477 | 17:54:07 INFO - PID 7477 | [#4] prototype.html Cycles:180 Average:4608.95 Median:5127.64 stddev:1282.17 (25.0%) stddev-sans-first:1245.85 17:54:07 INFO - PID 7477 | Values: 379.9 387.3 391.0 396.6 397.9 5095.5 5142.3 5186.4 5196.0 5232.2 4838.6 5126.5 5126.5 5134.5 5147.5 4017.8 4053.6 4054.4 4068.7 4078.9 4040.9 4042.0 4049.3 4071.2 4072.2 4043.0 4043.6 4046.0 4049.5 4051.5 3960.5 4152.2 4154.8 4170.1 4171.9 3739.3 3769.5 3773.7 3779.0 3789.4 5110.0 5120.3 5134.6 5135.8 5142.7 4687.2 4830.6 4839.3 4840.4 4853.3 5484.7 5500.9 5509.1 5529.0 5540.5 4148.2 4152.9 4157.6 4159.9 4160.4 5604.0 5750.2 5803.5 5808.0 5826.0 4297.8 4309.7 4311.3 4312.5 4320.5 4369.1 4383.5 4383.6 4401.5 4403.2 4575.5 4795.5 4848.7 4855.2 4870.2 5507.1 5510.2 5514.8 5537.4 5538.2 1495.4 1516.0 1521.6 1525.2 1525.5 1088.9 1103.9 1108.0 1113.9 1118.2 4824.3 4830.0 4853.9 4858.4 4878.9 5683.9 5684.7 5688.8 5700.3 5701.0 4643.1 4799.9 4806.6 4835.6 4854.6 2986.1 3009.3 3014.3 3014.4 3017.8 5299.4 5325.4 5329.1 5341.9 5346.2 5538.3 5645.5 5708.5 5774.8 5811.2 5191.5 5295.5 5330.9 5338.2 5372.6 5694.9 5701.9 5709.4 5709.8 5714.0 5454.6 5506.1 5584.8 5610.4 5611.5 5284.5 5292.5 5301.9 5306.4 5317.4 4256.6 4262.4 4264.9 4265.9 4266.6 5437.6 5634.8 5637.2 5664.7 5706.3 5432.8 5447.9 5469.0 5469.5 5493.7 5318.6 5446.6 5466.2 5476.0 5512.4 5386.2 5395.8 5401.9 5405.0 5424.9 5457.4 5482.9 5496.1 5503.9 5515.6 5128.7 5370.2 5373.6 5390.2 5400.5 17:54:07 INFO - PID 7477 | 17:54:07 INFO - PID 7477 | [#5] yui.html Cycles:180 Average:13868.42 Median:536.75 stddev:17236.48 (3211.3%) stddev-sans-first:17256.37 17:54:07 INFO - PID 7477 | Values: 678.9 703.9 704.2 704.6 708.8 13041.0 13640.0 13702.9 13716.9 13726.5 12448.4 14846.0 15362.3 15664.5 15682.5 844.4 853.9 867.4 869.6 870.0 854.0 875.0 875.0 875.1 875.5 906.2 916.3 916.8 917.8 917.8 907.9 907.9 908.3 914.4 915.8 663.4 664.8 666.2 666.6 666.7 13640.7 13996.5 14604.3 14792.5 14862.5 12967.8 14419.6 14425.4 14512.0 14516.3 10731.0 10732.1 10762.6 10785.6 10961.5 2660.1 2689.5 2707.8 2718.2 2734.1 63696.7 63835.7 64029.0 64785.7 65167.7 10146.8 10148.7 10362.7 10379.4 10742.8 20746.9 21150.6 21174.0 21377.9 21391.6 6554.5 6585.9 6623.5 6704.1 6725.1 3508.4 3540.2 3559.4 3610.7 3617.9 3682.8 3733.2 3743.6 3754.2 3812.8 627.1 628.7 635.3 638.2 640.0 539.2 541.3 552.9 561.7 572.3 8251.4 8528.5 8551.4 8720.7 9016.7 506.4 513.2 526.1 526.5 534.3 3807.8 3876.2 3934.7 3968.9 4019.3 60170.4 60426.4 62028.0 62201.0 63541.0 54784.2 55075.0 55645.7 55858.7 56144.4 48357.0 48521.3 49102.5 49162.8 49504.3 7632.7 7732.4 7794.7 7976.0 8068.1 25515.0 25899.7 26210.7 26618.3 26959.7 32548.5 32805.0 32960.8 33095.3 33663.3 9902.5 10100.5 10257.3 10304.6 10371.8 10645.8 10900.6 10954.2 11433.5 11563.0 9539.6 9917.9 9928.5 9940.6 10259.0 9715.9 10001.2 10247.9 10457.3 10492.4 9415.7 9735.3 9942.5 10195.7 10293.8 7203.4 7246.1 7423.7 7488.5 7550.9 7456.7 7734.6 8140.4 8320.1 8451.1 17:54:07 INFO - PID 7477 | -------- Summary: end -------- 17:54:07 INFO - PID 7477 | 17:54:07 INFO - TEST-INFO | 7477: exit 0 17:54:07 INFO - TEST-OK | dromaeo_css | took 1123850ms 17:54:07 INFO - TEST-START | kraken 17:54:07 INFO - operating with platform_type : linux_ 17:54:07 INFO - Initialising browser for kraken test... 17:54:07 INFO - TEST-INFO | started process 7801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgF0rXd/profile http://localhost:50336/getInfo.html) 17:54:12 INFO - PID 7801 | __metrics Screen width/height:1600/1200 17:54:12 INFO - PID 7801 | colorDepth:24 17:54:12 INFO - PID 7801 | Browser inner width/height: 1024/697 17:54:12 INFO - PID 7801 | __metrics 17:54:13 ERROR - PID 7801 | 1490662453056 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:54:13 INFO - PID 7801 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:54:13 INFO - PID 7801 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:54:14 INFO - TEST-INFO | 7801: exit 0 17:54:14 INFO - Browser initialized. 17:54:14 INFO - Running cycle 1/1 for kraken test... 17:54:14 INFO - TEST-INFO | started process 7896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgF0rXd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:26 INFO - PID 7896 | RSS: Main: 149667840 17:54:26 INFO - PID 7896 | 17:54:29 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50336/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:30 INFO - PID 7896 | RSS: Main: 205152256 17:54:30 INFO - PID 7896 | 17:54:32 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50336/tests/kraken/driver.html?testName=audio-dft) 17:54:33 INFO - PID 7896 | RSS: Main: 184442880 17:54:33 INFO - PID 7896 | 17:54:36 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50336/tests/kraken/driver.html?testName=audio-fft) 17:54:37 INFO - PID 7896 | RSS: Main: 266641408 17:54:37 INFO - PID 7896 | 17:54:39 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50336/tests/kraken/driver.html?testName=audio-oscillator) 17:54:40 INFO - PID 7896 | RSS: Main: 177803264 17:54:40 INFO - PID 7896 | 17:54:42 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:42 INFO - PID 7896 | RSS: Main: 180736000 17:54:42 INFO - PID 7896 | 17:54:46 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50336/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:46 INFO - PID 7896 | RSS: Main: 219979776 17:54:46 INFO - PID 7896 | 17:54:50 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50336/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:50 INFO - PID 7896 | RSS: Main: 215318528 17:54:50 INFO - PID 7896 | 17:54:53 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50336/tests/kraken/driver.html?testName=json-parse-financial) 17:54:54 INFO - PID 7896 | RSS: Main: 217284608 17:54:54 INFO - PID 7896 | 17:54:56 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:57 INFO - PID 7896 | RSS: Main: 180101120 17:54:57 INFO - PID 7896 | 17:54:58 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50336/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:59 INFO - PID 7896 | RSS: Main: 186691584 17:54:59 INFO - PID 7896 | 17:55:01 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:55:02 INFO - PID 7896 | RSS: Main: 197058560 17:55:02 INFO - PID 7896 | 17:55:05 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:55:05 INFO - PID 7896 | RSS: Main: 205746176 17:55:05 INFO - PID 7896 | 17:55:09 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:55:09 INFO - PID 7896 | RSS: Main: 201908224 17:55:09 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | Cycle 1(1): loaded http://localhost:50336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50336/tests/kraken/driver.html?testName=ai-astar) 17:55:11 INFO - PID 7896 | RSS: Main: 270819328 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | __start_tp_report 17:55:11 INFO - PID 7896 | _x_x_mozilla_page_load 17:55:11 INFO - PID 7896 | _x_x_mozilla_page_load_details 17:55:11 INFO - PID 7896 | |i|pagename|runs| 17:55:11 INFO - PID 7896 | |0;ai-astar;105;112;113;115;112;112;113;113;114;111 17:55:11 INFO - PID 7896 | |1;audio-beat-detection;150;124;124;171;130;130;129;125;149;130 17:55:11 INFO - PID 7896 | |2;audio-dft;164;169;179;166;166;167;165;164;165;164 17:55:11 INFO - PID 7896 | |3;audio-fft;76;77;75;107;76;77;76;76;94;77 17:55:11 INFO - PID 7896 | |4;audio-oscillator;86;85;120;86;84;84;101;89;85;109 17:55:11 INFO - PID 7896 | |5;imaging-gaussian-blur;114;114;115;114;114;114;114;114;113;115 17:55:11 INFO - PID 7896 | |6;imaging-darkroom;152;150;151;151;149;150;150;150;150;151 17:55:11 INFO - PID 7896 | |7;imaging-desaturate;94;95;94;95;95;95;95;95;95;94 17:55:11 INFO - PID 7896 | |8;json-parse-financial;66;65;66;76;65;72;67;68;68;66 17:55:11 INFO - PID 7896 | |9;json-stringify-tinderbox;57;57;55;56;55;55;56;56;56;56 17:55:11 INFO - PID 7896 | |10;stanford-crypto-aes;84;85;83;82;83;82;83;83;86;83 17:55:11 INFO - PID 7896 | |11;stanford-crypto-ccm;135;137;145;147;141;133;140;132;191;136 17:55:11 INFO - PID 7896 | |12;stanford-crypto-pbkdf2;191;195;191;199;200;199;189;197;198;197 17:55:11 INFO - PID 7896 | |13;stanford-crypto-sha256-iterative;70;71;74;74;74;74;71;73;71;71 17:55:11 INFO - PID 7896 | __end_tp_report 17:55:11 INFO - PID 7896 | __start_cc_report 17:55:11 INFO - PID 7896 | _x_x_mozilla_cycle_collect,2041 17:55:11 INFO - PID 7896 | __end_cc_report 17:55:11 INFO - PID 7896 | __startTimestamp1490662511968__endTimestamp 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | ------- Summary: start ------- 17:55:11 INFO - PID 7896 | Number of tests: 14 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.71 (2.4%) stddev-sans-first:1.20 17:55:11 INFO - PID 7896 | Values: 105.0 112.0 113.0 115.0 112.0 112.0 113.0 113.0 114.0 111.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:130.00 stddev:15.48 (11.9%) stddev-sans-first:15.59 17:55:11 INFO - PID 7896 | Values: 150.0 124.0 124.0 171.0 130.0 130.0 129.0 125.0 149.0 130.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#2] audio-dft Cycles:10 Average:166.90 Median:166.00 stddev:4.53 (2.7%) stddev-sans-first:4.68 17:55:11 INFO - PID 7896 | Values: 164.0 169.0 179.0 166.0 166.0 167.0 165.0 164.0 165.0 164.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.50 stddev:10.69 (14.0%) stddev-sans-first:11.18 17:55:11 INFO - PID 7896 | Values: 76.0 77.0 75.0 107.0 76.0 77.0 76.0 76.0 94.0 77.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:85.00 stddev:12.71 (14.9%) stddev-sans-first:13.23 17:55:11 INFO - PID 7896 | Values: 86.0 85.0 120.0 86.0 84.0 84.0 101.0 89.0 85.0 109.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:55:11 INFO - PID 7896 | Values: 114.0 114.0 115.0 114.0 114.0 114.0 114.0 114.0 113.0 115.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 17:55:11 INFO - PID 7896 | Values: 152.0 150.0 151.0 151.0 149.0 150.0 150.0 150.0 150.0 151.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:55:11 INFO - PID 7896 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:67.50 stddev:3.51 (5.2%) stddev-sans-first:3.66 17:55:11 INFO - PID 7896 | Values: 66.0 65.0 66.0 76.0 65.0 72.0 67.0 68.0 68.0 66.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 17:55:11 INFO - PID 7896 | Values: 57.0 57.0 55.0 56.0 55.0 55.0 56.0 56.0 56.0 56.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 17:55:11 INFO - PID 7896 | Values: 84.0 85.0 83.0 82.0 83.0 82.0 83.0 83.0 86.0 83.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:140.50 stddev:17.33 (12.3%) stddev-sans-first:18.09 17:55:11 INFO - PID 7896 | Values: 135.0 137.0 145.0 147.0 141.0 133.0 140.0 132.0 191.0 136.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.60 Median:197.50 stddev:3.92 (2.0%) stddev-sans-first:3.79 17:55:11 INFO - PID 7896 | Values: 191.0 195.0 191.0 199.0 200.0 199.0 189.0 197.0 198.0 197.0 17:55:11 INFO - PID 7896 | 17:55:11 INFO - PID 7896 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.50 stddev:1.64 (2.2%) stddev-sans-first:1.51 17:55:11 INFO - PID 7896 | Values: 70.0 71.0 74.0 74.0 74.0 74.0 71.0 73.0 71.0 71.0 17:55:11 INFO - PID 7896 | -------- Summary: end -------- 17:55:11 INFO - PID 7896 | 17:55:13 INFO - TEST-INFO | 7896: exit 0 17:55:13 INFO - TEST-OK | kraken | took 65157ms 17:55:13 INFO - SUITE-END | took 1189s 17:55:13 INFO - Completed test suite (00:19:49) 17:55:13 INFO - javascript benchmark 17:55:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6558.895040105987, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.388110734531, 2674.7860171186308, 2709.227870057034, 2712.6609173853267, 2720.3199200199942, 5010.348654674887, 5034.09386310464, 5156.407013193484, 5164.793408263669, 5222.060029194743, 5087.6693014954, 5105.846824595259, 5146.871328216796, 5151.639385243035, 5176.404713457953, 4612.331211974279, 4639.327297541854, 4665.88335291617, 4758.833440829571, 4820.228763397857, 4768.880777980561, 4806.110869489138, 4812.061647978628, 4814.0, 4819.373481447407, 4548.0, 4586.587207151339, 4601.12578610063, 4632.8146874125, 4735.029318989599, 4698.882527936795, 4705.623550116016, 4705.647076469244, 4763.666543341968, 4764.523547645208, 4645.744484053375, 4675.976620116878, 4687.9765601171775, 4700.576948074656, 4727.243641017455, 4931.80272789088, 4974.751262436864, 5133.974330128325, 5143.048536020848, 5196.714180720059, 5377.7580008899695, 5395.190721391783, 5396.946030539683, 5399.595030372738, 5408.107662235727, 5417.918731219035, 5420.566354691615, 5423.5932305076885, 5426.728663566845, 5433.8369848904595, 5001.624878134082, 5043.546080852704, 5049.267856160836, 5051.545360917535, 5112.897742045138, 5648.6893220872425, 5693.032184528557, 5704.429557044263, 5746.741396637161, 5764.884702306014, 5181.274621552986, 5227.660202086852, 5236.266922630834, 5434.212039254286, 5453.345598528202, 5508.118701007819, 5511.476409741068, 5512.200730893998, 5516.338039435213, 5558.916616250759, 5449.809256675997, 5452.482014208644, 5456.181572764117, 5458.699771512605, 5487.807926722626, 5275.868103297372, 5340.385855626575, 5354.866128346823, 5357.491038351351, 5358.866028349323, 4601.401817763669, 4612.262038073892, 4620.214563524209, 4631.791569379386, 4660.04469083837, 3972.443857859902, 3982.143839074613, 3985.242803867314, 4008.9799551002056, 4027.436158937751, 4755.5482229188865, 4770.427548694179, 4771.117343291502, 4772.0, 4813.326134341195, 5351.09031464652, 5367.946320536823, 5376.542993845567, 5555.833325000256, 5578.637388569811, 4713.2458806590785, 4713.269443236304, 4716.033213191287, 4742.430908291027, 4744.620430365562, 4933.112039832865, 4938.8518344449, 4944.48082951285, 4949.059678661043, 4997.225430058346, 5001.1498045331655, 5183.66306190104, 5188.533032027136, 5193.896122077613, 5241.816536421359, 5374.704391258519, 5440.6735595864375, 5456.427075157051, 5461.42655021233, 5481.314835645544, 5244.370675518962, 5253.028189784902, 5253.343332083489, 5254.15933450646, 5258.737063146904, 5449.700266485382, 5451.046066938349, 5452.591055670761, 5452.836414907559, 5505.119180931032, 5494.642848214853, 5535.6955367455175, 5541.722913854372, 5543.473370029841, 5545.805896793754, 5209.869753256199, 5266.052110620125, 5266.683998960075, 5360.303160589098, 5371.382291036581, 5404.243405923095, 5405.648632838853, 5413.864653383697, 5448.700321482356, 5450.209719590558, 5314.893702125859, 5329.227262046904, 5332.6000549958135, 5338.839834804807, 5385.542228910586, 5216.321878155815, 5218.869528261824, 5369.624126311277, 5403.081476149143, 5419.566434685295, 5138.8972220556125, 5207.583393328448, 5239.842804715865, 5258.263843061898, 5262.052830490548], "value": 5014.69585541659, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.3962756126556, 680.805970298465, 699.3111784891883, 1059.5973530058577, 1070.9571617135316, 25827.612585811203, 31438.68561314386, 32087.518687219712, 32238.516422253626, 32313.67686323136, 36363.4545481818, 37225.0, 37282.62717372825, 37295.0, 37322.626773732256, 5674.09214525676, 5779.971100144515, 7381.409487241035, 7531.472796904219, 7543.471956963015, 7212.386947109502, 7397.409556945256, 7435.665395057208, 7440.776776696708, 7445.181030086686, 7427.628618569077, 7524.473286869921, 7528.397728181732, 7528.736494222703, 7529.736459223928, 7418.517796343247, 7466.402687784964, 7476.775696729107, 7482.812929676747, 7484.438667099962, 7289.161746399179, 7290.489665723401, 7292.19785823559, 7380.9261907381315, 7577.446623442181, 34041.31917361663, 34172.82913585441, 34224.48663270053, 34274.48588271178, 34335.656643433496, 2552.234329701082, 2565.653636759051, 2573.6654234949524, 2601.4666993266337, 2658.5480468320434, 21697.34907952748, 21776.564468710694, 21992.120315187374, 22034.33896983093, 23278.0, 2937.8677959491874, 2964.9110526684235, 2979.731824135838, 2981.329200929795, 2988.865501052458, 136615.0, 136640.31679841637, 136846.3157684215, 137056.0, 137270.31364843211, 40741.1851762969, 40741.59258407378, 40847.59152408497, 40879.38680919789, 40958.180836383704, 42724.0, 42725.35911961323, 42727.0, 42743.78628106902, 42774.358384624255, 12826.743465130832, 13122.14706044104, 13123.868761312264, 13147.539836105881, 13152.473901044043, 8301.543415112226, 8405.327573794082, 10458.790824183474, 10461.790764184674, 10482.423466709251, 11271.943640281746, 11414.714632134097, 11448.084153267719, 12782.744345113046, 12846.0, 5277.445868183862, 5509.741006187444, 5512.594288456418, 5563.749631266603, 5582.2925880947705, 856.7215654912178, 882.3162049411629, 890.0787684746257, 901.733988473402, 920.5903372998952, 19733.210671572975, 20575.691364629543, 21361.14555417766, 21494.677579836316, 21834.454138646663, 977.4868194198103, 979.1236843025453, 981.74474636595, 984.6209209454412, 1005.3615953869199, 10921.781564368668, 10989.0, 11141.777164456666, 11168.106551475863, 11217.3830439325, 232671.0, 233048.0, 234122.0, 234725.0, 234745.0, 42055.7897210512, 42278.788606056776, 42336.78831605822, 42378.364324535156, 42491.36262956058, 1174.9647510574696, 1195.4142470189545, 1199.4662375242933, 1202.7173614200656, 1244.8195011723249, 19739.901300493406, 19808.0, 20588.0, 20853.582928341653, 20960.266390676865, 30107.096787096423, 30165.09504714862, 30184.5472317911, 30198.245043874078, 30204.395912082076, 205392.0, 206985.0, 207049.0, 207176.0, 208127.0, 28250.0, 28280.575791363557, 28835.56746648844, 28908.566371504025, 29148.125556233346, 27411.725882740917, 28670.713292866803, 28857.278568035126, 32279.35441291208, 34108.488372673935, 24902.37744056413, 26939.0, 27617.585736213572, 28103.156905292875, 29088.98188563475, 27693.75526172452, 27812.443751124458, 28143.296417588906, 28651.997180098595, 28736.856315718287, 30267.69732302649, 30472.238194045327, 30547.847260764443, 30575.694243057285, 30766.846165769028, 27262.318442039108, 27463.450730985667, 27546.0, 27732.0, 27913.58129628098, 20530.281440149523, 21579.0, 21733.673994890407, 21844.0, 21850.0], "value": 14610.189198352438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.5211762825636, 428.78053829207363, 430.20197533575225, 443.73819446526545, 449.914516241914, 16643.50069497914, 17288.82711172888, 17994.280228790867, 18013.7297940531, 19020.9048954755, 18585.256589736393, 18764.53088672784, 19317.710234346498, 19464.610707785836, 19470.805291947076, 5606.887862242753, 5781.19063331134, 5820.941790582104, 5840.445157710011, 5845.386234445396, 5654.236678048473, 5758.0, 5794.68129252891, 5797.478226959573, 5801.100829371454, 5704.543636509069, 5709.31488221414, 5712.742926568314, 5715.399883012286, 5783.074708046714, 5557.277553917965, 5718.542516598683, 5723.570732195081, 5750.568707346944, 5792.0, 5307.150855863082, 5312.1766126250495, 5313.548348390392, 5314.096603577363, 5320.122179840322, 22736.65895011576, 22972.310830675106, 22995.77004229953, 23246.883765581064, 23350.18274360389, 1548.0866288889608, 1548.9389768008837, 1549.4654344251214, 1602.8717702583765, 1605.6146524833955, 13330.466781328832, 13737.931310343385, 14423.639409014753, 14669.853301466956, 15115.622109447242, 1637.6151604372963, 1691.8646508279307, 1692.5176324747388, 1694.1783235130952, 1709.7264437690035, 86745.13254867433, 93657.0, 93675.0, 95917.0, 96397.0, 11146.219764616399, 11186.0, 11382.260153090023, 11464.31214127155, 11539.423028848523, 16228.269727862275, 16235.837641623433, 16266.918665406598, 16273.51179464618, 16276.75584866228, 7548.924510754932, 7736.497127686683, 7750.496217745828, 7879.960600196962, 7937.7618671438795, 7052.400545953651, 7061.611611361322, 7225.0, 7256.0, 7259.963700181465, 7150.856982860314, 7266.7093316266755, 7275.4179665626625, 7297.197308296083, 7323.267673232741, 2074.8358752901945, 2093.2464312847364, 2107.6943843142967, 2115.978840211609, 2374.655674927126, 834.6828205282076, 852.7015544559355, 861.2033868671454, 870.8432482153147, 878.9033206347297, 16885.662286754196, 16963.236654350585, 17452.0, 17692.469225923243, 18058.187381567863, 865.5931712095305, 867.0938868882033, 890.5903284489078, 895.9059298773665, 896.8834051573384, 8879.822403551892, 8962.73111806647, 9544.379615324982, 9583.760405989766, 9648.996530173546, 425851.0, 428212.0, 454760.0, 454949.0, 456310.0, 85603.0, 85951.57024214839, 86404.56797716097, 86977.0, 87233.0, 1070.6252811516063, 1078.983815242772, 1091.2688498705886, 1102.4873433853297, 1108.2242430298822, 14824.703505930036, 15919.840801591836, 17329.82670173282, 17497.637818894797, 17852.55368615795, 42547.744050049965, 43089.35365969576, 43303.0, 43820.34269485896, 44550.10899782051, 50450.0, 50797.492025080755, 50963.0, 51003.74498127485, 51138.488615113376, 7454.701811927463, 7494.850102998019, 7610.162882083077, 7739.961300193463, 8057.798555035936, 11263.66209013731, 12022.699432514257, 12965.416556254802, 13261.80107298372, 13335.533256335983, 10296.588136474456, 10404.271700980858, 10461.424621645578, 10664.573417063231, 10778.191635627516, 9842.950785246028, 10046.69859904204, 10050.547725352231, 10076.143527800219, 10100.444475553915, 10331.32846364984, 10489.213309002009, 10882.782344353227, 10894.727631809268, 11022.944885275523, 8339.679174194567, 8399.076101628938, 8572.228499434832, 8651.783705407415, 8668.609912553824, 9597.856032159383, 9602.279829012992, 9664.245689978323, 9814.214862810815, 9935.403875767477], "value": 8962.131971441293, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1077.3589714120096, 1208.2327721896595, 1237.566851601939, 1243.5709680160342, 1251.5556977273075, 8169.632366543505, 9601.759956001104, 9689.515524223787, 9788.119069283763, 9825.312228144032, 9558.330916835825, 9666.661666841663, 9968.451735154582, 9970.202383809295, 9975.351602145856, 1863.9906800465978, 2188.9890550547307, 2246.9101235950543, 2248.8313376496744, 2249.1228420915772, 1885.5097674604565, 1893.4982229709137, 1907.2371051579341, 1911.9904400477978, 2159.0392275437434, 2164.9242276520326, 2175.4887601413657, 2176.1404245323088, 2182.9890850545726, 2184.9016794244217, 2073.6371135051304, 2102.9789702102935, 2107.7892210778955, 2110.3352443980175, 2115.947101322464, 2102.2221777942104, 2150.602138604363, 2163.7836216378396, 2186.431527802767, 2189.2665956904457, 9721.56252968611, 9840.95079524605, 9930.702078937644, 9947.104760571583, 9948.104670579683, 5416.268803711488, 5634.154876768476, 5639.577031722596, 5644.294463192101, 5648.830535083913, 2901.2891841498968, 2935.4129174165037, 3099.612548431446, 3118.8908388206532, 3121.9687803121906, 953.2659851913987, 979.3193730357405, 980.0493521284343, 987.6000219910948, 988.1156365053309, 14605.415783368759, 14610.342534585969, 14651.560453186421, 14669.926650366786, 14672.559823205322, 4965.1807451770055, 5258.211268309784, 5281.471852814765, 5288.101022826128, 5296.285001524745, 12232.75534489323, 12235.265884046985, 12242.81635775464, 12244.755104897853, 12248.693782655504, 5582.692951887604, 5721.685307308138, 5726.198332233491, 5726.9713651431475, 5749.913751293734, 5002.624803139779, 5053.0, 5160.870978225499, 5188.11801993662, 5204.453532379046, 3788.1287303919703, 3878.3019056569524, 4108.342665173617, 4110.938335924963, 4192.790360481964, 1311.9737605247842, 1318.5504873874506, 1320.6764342735898, 1343.4894739998933, 1365.3992243412868, 563.4426829503157, 659.9373059559334, 675.1088563096763, 681.7613835157754, 690.2303931116769, 5342.332208473941, 5480.232767412565, 5675.120356344773, 5740.684262365527, 5793.391693872167, 805.7341077444429, 807.6244546286006, 810.7162493127358, 830.3772170871846, 844.8014716541608, 3594.514740509998, 3644.799536025491, 3668.413053911361, 3674.81625918703, 3741.0834345585504, 12630.0, 12949.741005180033, 13232.470701172038, 13233.93383033098, 13264.535741249203, 12033.63899083029, 13199.604011879659, 13224.669383265495, 13228.669283267995, 13248.536301229604, 9179.58691858868, 9470.052994700613, 9476.0, 9476.95261523688, 9480.762980925532, 5875.3243377010485, 5882.823515294548, 5916.970415147896, 5963.403659634002, 6081.209442772411, 11413.258138220988, 11593.130515211224, 11712.765744685228, 11747.412629368668, 11867.58463453775, 11476.483558240066, 11735.589254376056, 11742.412879356169, 11830.467628956545, 11844.70388240301, 8048.879266810885, 8201.384896132695, 8325.084240733393, 8329.95835020821, 8341.41610087288, 9208.861867071866, 9214.861777073214, 9289.303302252223, 9308.627654893999, 9410.52947352616, 7659.617019148909, 7688.730894418669, 7695.384369250559, 7725.111612164673, 7817.37461003107, 7419.591922444318, 7480.4015678746655, 7500.512466689648, 7510.812229694301, 7558.546487210785, 6806.455483561403, 6907.75822846218, 6968.860622787414, 6969.756058537927, 6972.477064220102, 5204.453532379046, 5218.8956220876125, 5264.894702106013, 5275.920861187008, 5309.628326017141, 5362.785488580569, 5427.402985671652, 5494.203340515683, 5554.833354999357, 5589.357223919302], "value": 4686.261120088639, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.9088218827482, 387.25840016368653, 391.0477986103837, 396.58556808135495, 397.88063580925717, 5095.490450954907, 5142.305788718522, 5186.429492755803, 5196.0, 5232.2151677248385, 4838.637102217339, 5126.487351264872, 5126.538611524962, 5134.512221338976, 5147.459516750743, 4017.774578753472, 4053.5949802166174, 4054.3918412238254, 4068.735532190413, 4078.89802754932, 4040.878538767156, 4041.9595804042024, 4049.2711311963835, 4071.246819338417, 4072.228580567448, 4043.0, 4043.555208927016, 4045.9885028742815, 4049.5343035550845, 4051.5340735815316, 3960.4851369321946, 4152.190322887023, 4154.750714957082, 4170.103427763015, 4171.937420938689, 3739.2521495700967, 3769.4722738816586, 3773.6792372648356, 3779.036345731821, 3789.3747531657245, 5110.0, 5120.334356533664, 5134.64057515974, 5135.764468384894, 5142.717150556718, 4687.203175460146, 4830.613550915953, 4839.2983017462275, 4840.370751802243, 4853.320535125085, 5484.670919744828, 5500.862478438071, 5509.146082357241, 5528.9723551382385, 5540.529055030327, 4148.211839750437, 4152.896177595554, 4157.605027522381, 4159.9376009359885, 4160.355144952507, 5603.971980140073, 5750.2237197978575, 5803.47768700819, 5808.0, 5825.970870145665, 4297.763623000765, 4309.698321117492, 4311.267084595626, 4312.54718254585, 4320.481542214954, 4369.104333611602, 4383.539728328544, 4383.561643835655, 4401.471823381215, 4403.185410699031, 4575.496695363508, 4795.520447955177, 4848.684835485682, 4855.174620314555, 4870.220764677634, 5507.0637991541535, 5510.228568000483, 5514.779408823602, 5537.36320323168, 5538.169274608841, 1495.424261659269, 1515.9696806064037, 1521.5815650695927, 1525.2221367102636, 1525.4660868695867, 1088.8530048443517, 1103.8840921703106, 1107.9889201108047, 1113.9443027848738, 1118.222835129577, 4824.300476430898, 4830.0, 4853.854384368475, 4858.416989961227, 4878.8780280492565, 5683.943160568424, 5684.715764211773, 5688.829335119953, 5700.315962084576, 5701.0, 4643.141018911512, 4799.928001079987, 4806.615470762331, 4835.6131509479155, 4854.611631069506, 2986.148947549938, 3009.337945651953, 3014.291641464254, 3014.427258820817, 3017.7887547871437, 5299.417064122943, 5325.440828713007, 5329.1206950852675, 5341.919871201935, 5346.224797404355, 5538.335399752055, 5645.5201307888465, 5708.457696518907, 5774.769009239583, 5811.215485909433, 5191.454897235812, 5295.4969277918535, 5330.866728331745, 5338.225957236179, 5372.62391632582, 5694.914576281276, 5701.857453563694, 5709.400512946081, 5709.800156994485, 5714.0, 5454.626879039729, 5506.146547285177, 5584.776608935597, 5610.429079857647, 5611.4568493664565, 5284.471552844685, 5292.470752924677, 5301.867453313698, 5306.416294207557, 5317.361916569882, 4256.59562341577, 4262.360645903139, 4264.91470170601, 4265.91468170641, 4266.573342665709, 5437.619366644297, 5634.802781902614, 5637.2107904894165, 5664.716764161858, 5706.28671416073, 5432.755526001419, 5447.863803404946, 5469.0, 5469.507744303032, 5493.725313734377, 5318.601104917069, 5446.645968012067, 5466.234727138124, 5476.0, 5512.39363670004, 5386.218998245311, 5395.811146610007, 5401.945980540144, 5405.0, 5424.891502170013, 5457.399686034612, 5482.890342193214, 5496.148097044965, 5503.862403439946, 5515.641483303572, 5128.743562821769, 5370.167624018283, 5373.623846330719, 5390.164524498709, 5400.487863398254], "value": 4229.3610146785395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.8642271545692, 703.8697840899432, 704.200732168988, 704.5878161275654, 708.844054308052, 13041.0, 13640.0, 13702.931485342559, 13716.862831371696, 13726.519571814988, 12448.43982020809, 14846.0, 15362.308696108674, 15664.451744188955, 15682.529524114267, 844.3667249562828, 853.8761879527481, 867.3624885708999, 869.5782545465444, 870.0255713600776, 853.9530325832077, 875.0199776250608, 875.0330884372772, 875.129246399833, 875.4528419737663, 906.2478143141177, 916.2578311567618, 916.8028873792133, 917.7843206846386, 917.7843206846386, 907.8910530736321, 907.9409838360485, 908.3459908865606, 914.4284821986258, 915.7573243090586, 663.4427081251772, 664.7573635623011, 666.1805978646244, 666.6333516565918, 666.6866572710818, 13640.727185456335, 13996.510122145675, 14604.34280457382, 14792.482263120846, 14862.479813206486, 12967.805482917764, 14419.639509012359, 14425.422983080769, 14512.0, 14516.346764395628, 10731.0, 10732.141428685687, 10762.569497220102, 10785.5685772569, 10961.506732197071, 2660.1088635307196, 2689.542777727791, 2707.810453268272, 2718.1981315511775, 2734.111413790506, 63696.68151659259, 63835.68082159606, 64029.0, 64785.67607161981, 65167.674161628885, 10146.847797283046, 10148.695539133838, 10362.689119326433, 10379.429131397847, 10742.785144297226, 20746.896265518575, 21150.576988460143, 21174.0, 21377.893110534347, 21391.57216855654, 6554.508411869129, 6585.86828263432, 6623.470122390294, 6704.094947182166, 6725.092112564839, 3508.3509550733197, 3540.150363912642, 3559.394902866519, 3610.711143108545, 3617.855285788539, 3682.815859207029, 3733.2346868891814, 3743.5694895086867, 3754.249150169977, 3812.8093595320124, 627.1439485102893, 628.6668065925068, 635.329727137874, 638.1894993358409, 639.9523016918013, 539.2208259065612, 541.3152362261742, 552.8811305569321, 561.7359840874782, 572.2903599536545, 8251.381146414044, 8528.464876322198, 8551.444156129832, 8720.738377848675, 9016.729498115066, 506.4024451147607, 513.2378418049194, 526.0662324374266, 526.4945652173956, 534.2707204665603, 3807.8286477108595, 3876.1860009398342, 3934.6655534279907, 3968.940465893014, 4019.2765302245293, 60170.39829601735, 60426.395736042075, 62028.0, 62201.0, 63541.0, 54784.17823732647, 55075.0, 55645.72177139169, 55858.720706396205, 56144.438555613924, 48357.0, 48521.272180917316, 49102.50897491051, 49162.754186229555, 49504.25743613848, 7632.694692212472, 7732.420068494998, 7794.727184548514, 7976.0, 8068.112507624274, 25515.0, 25899.741002589733, 26210.73789262083, 26618.334541636614, 26959.652017399443, 32548.51177232391, 32805.0, 32960.83519582387, 33095.33809323848, 33663.326733465685, 9902.455364954996, 10100.49497525106, 10257.33327333721, 10304.587816487556, 10371.844422333821, 10645.787084258427, 10900.563977440814, 10954.178436617445, 11433.485493152662, 11563.0, 9539.614667743324, 9917.851232231378, 9928.453935033642, 9940.602375904882, 10259.0, 9715.902840971783, 10001.199904007517, 10247.897521024694, 10457.26799124054, 10492.422916739653, 9415.670451534163, 9735.26985476078, 9942.502874856084, 10195.694129176136, 10293.84559231597, 7203.351698347174, 7246.130464344313, 7423.740169094056, 7488.475806693479, 7550.8867366990635, 7456.701731930662, 7734.613269336398, 8140.389470789596, 8320.12638672955, 8451.070382258069], "value": 6116.982289449681, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 115.0, 112.0, 112.0, 113.0, 113.0, 114.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 124.0, 171.0, 130.0, 130.0, 129.0, 125.0, 149.0, 130.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 179.0, 166.0, 166.0, 167.0, 165.0, 164.0, 165.0, 164.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 107.0, 76.0, 77.0, 76.0, 76.0, 94.0, 77.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 120.0, 86.0, 84.0, 84.0, 101.0, 89.0, 85.0, 109.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 151.0, 151.0, 149.0, 150.0, 150.0, 150.0, 150.0, 151.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 76.0, 65.0, 72.0, 67.0, 68.0, 68.0, 66.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 82.0, 83.0, 82.0, 83.0, 83.0, 86.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 145.0, 147.0, 141.0, 133.0, 140.0, 132.0, 191.0, 136.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 195.0, 191.0, 199.0, 200.0, 199.0, 189.0, 197.0, 198.0, 197.0], "value": 195.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 74.0, 74.0, 74.0, 74.0, 71.0, 73.0, 71.0, 71.0], "value": 72.3, "unit": "score"}]}]} 17:55:13 INFO - Return code: 0 17:55:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:13 ERROR - # TBPL SUCCESS # 17:55:13 INFO - Running post-action listener: _resource_record_post_action 17:55:13 INFO - [mozharness: 2017-03-28 00:55:13.787491Z] Finished run-tests step (success) 17:55:13 INFO - Running post-run listener: _resource_record_post_run 17:55:13 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365260800; Read time: 8; Write time: 304468 17:55:13 INFO - TinderboxPrint: CPU usage
13.0% 17:55:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 17:55:13 INFO - TinderboxPrint: I/O write bytes / time
365,260,800 / 304,468 17:55:13 INFO - TinderboxPrint: CPU idle
8,366.3 (87.0%) 17:55:13 INFO - TinderboxPrint: CPU user
1,203.4 (12.5%) 17:55:13 INFO - TinderboxPrint: Swap in / out
0 / 0 17:55:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106643456; Read time: 0; Write time: 147216 17:55:13 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258617344; Read time: 8; Write time: 157252 17:55:14 INFO - Running post-run listener: _upload_blobber_files 17:55:14 INFO - Blob upload gear active. 17:55:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:14 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 17:55:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:55:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:15 INFO - (blobuploader) - INFO - Done attempting. 17:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:19 INFO - (blobuploader) - INFO - Done attempting. 17:55:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:55:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:55:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:19 INFO - (blobuploader) - INFO - Done attempting. 17:55:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:55:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:55:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:20 INFO - (blobuploader) - INFO - Done attempting. 17:55:20 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:20 INFO - Return code: 0 17:55:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3fe68a77be7dff1626c1dc563a148c6b66ee98e9308497632a3bed0e1bbc09c36c5c929d78955e02d6f39219a7bdcbd5b50c64fa4f5f034b0e619bbf78776a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34c8ee12adcc46db2fcdb9a87ea28893cf65ee2768f42e89b7a872df732e05b331f74dce757c735076b368fdb24ba1c99338c2fd2c26d2e7c78787fbcc1ba877", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da68b9aac6583f6552b00be03efde25c1e89c9db8b3b745eb8a9ec96a1b98d48ce2fb97703231649a538bf37d1c33f28794723b22888e74a4d268b0f7edb7928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ff06e38f18d5f87260cb04e52ca811cd7347dfafbe76cc45f81b37331690ec4a01f7dd82dfcdc406b50f3bb3caa260e5828953651d3c2274708825bbb989185"} 17:55:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:20 INFO - Contents: 17:55:20 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3fe68a77be7dff1626c1dc563a148c6b66ee98e9308497632a3bed0e1bbc09c36c5c929d78955e02d6f39219a7bdcbd5b50c64fa4f5f034b0e619bbf78776a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34c8ee12adcc46db2fcdb9a87ea28893cf65ee2768f42e89b7a872df732e05b331f74dce757c735076b368fdb24ba1c99338c2fd2c26d2e7c78787fbcc1ba877", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da68b9aac6583f6552b00be03efde25c1e89c9db8b3b745eb8a9ec96a1b98d48ce2fb97703231649a538bf37d1c33f28794723b22888e74a4d268b0f7edb7928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ff06e38f18d5f87260cb04e52ca811cd7347dfafbe76cc45f81b37331690ec4a01f7dd82dfcdc406b50f3bb3caa260e5828953651d3c2274708825bbb989185"} 17:55:20 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:20 INFO - Copying logs to upload dir... 17:55:20 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.301879 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-27 17:55:20.772552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 17:55:20.776548) ========= 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=5c37b704b588aaa989324530000001d0-1490661255.384742-728312733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3fe68a77be7dff1626c1dc563a148c6b66ee98e9308497632a3bed0e1bbc09c36c5c929d78955e02d6f39219a7bdcbd5b50c64fa4f5f034b0e619bbf78776a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34c8ee12adcc46db2fcdb9a87ea28893cf65ee2768f42e89b7a872df732e05b331f74dce757c735076b368fdb24ba1c99338c2fd2c26d2e7c78787fbcc1ba877", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da68b9aac6583f6552b00be03efde25c1e89c9db8b3b745eb8a9ec96a1b98d48ce2fb97703231649a538bf37d1c33f28794723b22888e74a4d268b0f7edb7928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ff06e38f18d5f87260cb04e52ca811cd7347dfafbe76cc45f81b37331690ec4a01f7dd82dfcdc406b50f3bb3caa260e5828953651d3c2274708825bbb989185"} build_url:https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011104 build_url: 'https://queue.taskcluster.net/v1/task/OQMN3lYuTBSIu5XSGmkpfw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3fe68a77be7dff1626c1dc563a148c6b66ee98e9308497632a3bed0e1bbc09c36c5c929d78955e02d6f39219a7bdcbd5b50c64fa4f5f034b0e619bbf78776a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34c8ee12adcc46db2fcdb9a87ea28893cf65ee2768f42e89b7a872df732e05b331f74dce757c735076b368fdb24ba1c99338c2fd2c26d2e7c78787fbcc1ba877", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da68b9aac6583f6552b00be03efde25c1e89c9db8b3b745eb8a9ec96a1b98d48ce2fb97703231649a538bf37d1c33f28794723b22888e74a4d268b0f7edb7928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ff06e38f18d5f87260cb04e52ca811cd7347dfafbe76cc45f81b37331690ec4a01f7dd82dfcdc406b50f3bb3caa260e5828953651d3c2274708825bbb989185"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 17:55:20.806028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:55:20.806365) ========= 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=5c37b704b588aaa989324530000001d0-1490661255.384742-728312733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 17:55:20.893228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 17:55:20.893548) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 17:55:20.893858) ========= ========= Total master_lag: 0.18 =========