builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1486137794.8 results: success (0) revision: c02020dd7e6e190b046e0bdc992a75b647c4cffa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:14.798548) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:14.799140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:14.799466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:14.815940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:14.816324) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-03 08:03:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2017-02-03 08:03:15 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.071289 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:14.901506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:14.901824) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018205 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:14.953043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:14.953414) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c02020dd7e6e190b046e0bdc992a75b647c4cffa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c02020dd7e6e190b046e0bdc992a75b647c4cffa --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=a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-03 08:03:15,167 truncating revision to first 12 chars 2017-02-03 08:03:15,167 Setting DEBUG logging. 2017-02-03 08:03:15,167 attempt 1/10 2017-02-03 08:03:15,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c02020dd7e6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 08:03:15,525 unpacking tar archive at: mozilla-aurora-c02020dd7e6e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.694885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:15.662101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:15.662491) ========= script_repo_revision: c02020dd7e6e190b046e0bdc992a75b647c4cffa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:15.662964) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:15.663249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 08:03:15.673368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-03 08:03:15.673752) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:03:15 INFO - MultiFileLogger online at 20170203 08:03:15 in /builds/slave/test 08:03:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:03:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:15 INFO - {'append_to_log': False, 08:03:15 INFO - 'base_work_dir': '/builds/slave/test', 08:03:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:03:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:15 INFO - 'branch': 'Mozilla-Aurora', 08:03:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:15 INFO - 'config_files': ('talos/linux_config.py',), 08:03:15 INFO - 'default_actions': ('clobber', 08:03:15 INFO - 'read-buildbot-config', 08:03:15 INFO - 'download-and-extract', 08:03:15 INFO - 'populate-webroot', 08:03:15 INFO - 'create-virtualenv', 08:03:15 INFO - 'install', 08:03:15 INFO - 'run-tests'), 08:03:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:15 INFO - 'download_minidump_stackwalk': True, 08:03:15 INFO - 'download_symbols': 'ondemand', 08:03:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:15 INFO - 'installer_path': 'installer.exe', 08:03:15 INFO - 'log_level': 'info', 08:03:15 INFO - 'log_name': 'talos', 08:03:15 INFO - 'log_to_console': True, 08:03:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:03:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:03:15 INFO - 'opt_config_files': (), 08:03:15 INFO - 'pip_index': False, 08:03:15 INFO - 'sps_profile': False, 08:03:15 INFO - 'sps_profile_interval': 0, 08:03:15 INFO - 'suite': 'dromaeojs-e10s', 08:03:15 INFO - 'system_bits': '32', 08:03:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:15 INFO - 'title': 'talos-linux64-ix-064', 08:03:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:15 INFO - 'use_talos_json': True, 08:03:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:15 INFO - 'work_dir': 'build'} 08:03:15 INFO - [mozharness: 2017-02-03 16:03:15.986314Z] Running clobber step. 08:03:15 INFO - Running pre-action listener: _resource_record_pre_action 08:03:15 INFO - Running main action method: clobber 08:03:15 INFO - rmtree: /builds/slave/test/build 08:03:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:16 INFO - Running post-action listener: _resource_record_post_action 08:03:16 INFO - [mozharness: 2017-02-03 16:03:16.466650Z] Finished clobber step (success) 08:03:16 INFO - [mozharness: 2017-02-03 16:03:16.466750Z] Running read-buildbot-config step. 08:03:16 INFO - Running pre-action listener: _resource_record_pre_action 08:03:16 INFO - Running main action method: read_buildbot_config 08:03:16 INFO - Using buildbot properties: 08:03:16 INFO - { 08:03:16 INFO - "project": "", 08:03:16 INFO - "product": "firefox", 08:03:16 INFO - "who": "ryanvm@gmail.com", 08:03:16 INFO - "installer_path": "public/build/target.tar.bz2", 08:03:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:03:16 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:03:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:03:16 INFO - "stage_platform": "linux64-pgo", 08:03:16 INFO - "basedir": "/builds/slave/test", 08:03:16 INFO - "buildnumber": 752, 08:03:16 INFO - "platform": "ubuntu64_hw", 08:03:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:03:16 INFO - "slavebuilddir": "test", 08:03:16 INFO - "taskId": "GqowgDH8QSSirakvJlo2Bg", 08:03:16 INFO - "branch": "mozilla-aurora", 08:03:16 INFO - "script_repo_revision": "production", 08:03:16 INFO - "revision": "c02020dd7e6e190b046e0bdc992a75b647c4cffa", 08:03:16 INFO - "slavename": "talos-linux64-ix-064", 08:03:16 INFO - "repo_path": "releases/mozilla-aurora" 08:03:16 INFO - } 08:03:16 INFO - Finding installer, test and symbols from parent task. 08:03:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GqowgDH8QSSirakvJlo2Bg'}, attempt #1 08:03:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GqowgDH8QSSirakvJlo2Bg'}, attempt #1 08:03:17 INFO - Task dependencies: M6xI86qjR1-WS9XCjj5_tQ 08:03:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ'}, attempt #1 08:03:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.tar.bz2 08:03:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/test_packages.json 08:03:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.crashreporter-symbols.zip 08:03:17 INFO - Running post-action listener: _resource_record_post_action 08:03:17 INFO - [mozharness: 2017-02-03 16:03:17.867804Z] Finished read-buildbot-config step (success) 08:03:17 INFO - [mozharness: 2017-02-03 16:03:17.868023Z] Running download-and-extract step. 08:03:17 INFO - Running pre-action listener: _resource_record_pre_action 08:03:17 INFO - Running main action method: download_and_extract 08:03:17 INFO - mkdir: /builds/slave/test/build/tests 08:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:17 INFO - trying https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.test_packages.json 08:03:17 INFO - Downloading https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:03:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:03:18 INFO - Downloaded 896 bytes. 08:03:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:03:18 INFO - Using the following test package requirements: 08:03:18 INFO - {u'common': [u'target.common.tests.zip'], 08:03:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:03:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:03:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:03:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:03:18 INFO - u'mozbase': [u'target.common.tests.zip'], 08:03:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:03:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:03:18 INFO - u'web-platform': [u'target.common.tests.zip', 08:03:18 INFO - u'target.web-platform.tests.zip'], 08:03:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:03:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:03:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.common.tests.zip 08:03:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:03:18 INFO - Fetch https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.common.tests.zip into memory 08:03:19 INFO - Expected file size: 21856096 08:03:19 INFO - Obtained file size: 21856096 08:03:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:03:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.common.tests.zip 08:03:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:03:23 INFO - Fetch https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.common.tests.zip into memory 08:03:24 INFO - Expected file size: 21856096 08:03:24 INFO - Obtained file size: 21856096 08:03:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.talos.tests.zip 08:03:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:03:28 INFO - Fetch https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.talos.tests.zip into memory 08:03:29 INFO - Expected file size: 14403485 08:03:29 INFO - Obtained file size: 14403485 08:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:29 INFO - trying https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.tar.bz2 08:03:29 INFO - Downloading https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:03:30 INFO - Downloaded 66088838 bytes. 08:03:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.tar.bz2 08:03:30 INFO - mkdir: /builds/slave/test/properties 08:03:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:30 INFO - Contents: 08:03:30 INFO - build_url:https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.tar.bz2 08:03:30 INFO - Running post-action listener: _resource_record_post_action 08:03:30 INFO - Running post-action listener: set_extra_try_arguments 08:03:30 INFO - [mozharness: 2017-02-03 16:03:30.684187Z] Finished download-and-extract step (success) 08:03:30 INFO - [mozharness: 2017-02-03 16:03:30.684284Z] Running populate-webroot step. 08:03:30 INFO - Running pre-action listener: _resource_record_pre_action 08:03:30 INFO - Running main action method: populate_webroot 08:03:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:03:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:03:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:03:30 INFO - '--tppagecycles', 08:03:30 INFO - '7'], 08:03:30 INFO - 'tests': ['tsvgm']}}, 08:03:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:03:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:03:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:03:30 INFO - 'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:03:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:03:30 INFO - 'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['damp', 'tps']}, 08:03:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:03:30 INFO - 'tests': ['damp', 'tps']}, 08:03:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['dromaeo_dom']}, 08:03:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['basic_compositor_video']}, 08:03:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:03:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['a11yr', 08:03:30 INFO - 'ts_paint', 08:03:30 INFO - 'tpaint', 08:03:30 INFO - 'sessionrestore', 08:03:30 INFO - 'sessionrestore_no_auto_restore', 08:03:30 INFO - 'tabpaint']}, 08:03:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:30 INFO - 'ts_paint', 08:03:30 INFO - 'tpaint', 08:03:30 INFO - 'sessionrestore', 08:03:30 INFO - 'sessionrestore_no_auto_restore', 08:03:30 INFO - 'tabpaint']}, 08:03:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:03:30 INFO - 'ts_paint', 08:03:30 INFO - 'tpaint', 08:03:30 INFO - 'sessionrestore', 08:03:30 INFO - 'sessionrestore_no_auto_restore', 08:03:30 INFO - 'tabpaint']}, 08:03:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:03:30 INFO - 'ts_paint', 08:03:30 INFO - 'tpaint', 08:03:30 INFO - 'sessionrestore', 08:03:30 INFO - 'sessionrestore_no_auto_restore', 08:03:30 INFO - 'tabpaint']}, 08:03:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['a11yr', 08:03:30 INFO - 'ts_paint', 08:03:30 INFO - 'tpaint', 08:03:30 INFO - 'sessionrestore', 08:03:30 INFO - 'sessionrestore_no_auto_restore', 08:03:30 INFO - 'tabpaint']}, 08:03:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['a11yr', 08:03:30 INFO - 'ts_paint', 08:03:30 INFO - 'tpaint', 08:03:30 INFO - 'sessionrestore', 08:03:30 INFO - 'sessionrestore_no_auto_restore', 08:03:30 INFO - 'tabpaint']}, 08:03:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['tsvgx', 08:03:30 INFO - 'tsvgr_opacity', 08:03:30 INFO - 'tart', 08:03:30 INFO - 'tscrollx', 08:03:30 INFO - 'cart', 08:03:30 INFO - 'tsvg_static']}, 08:03:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:30 INFO - 'tsvgr_opacity', 08:03:30 INFO - 'tart', 08:03:30 INFO - 'tscrollx', 08:03:30 INFO - 'cart', 08:03:30 INFO - 'tsvg_static']}, 08:03:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:03:30 INFO - 'talos_options': ['--disable-e10s'], 08:03:30 INFO - 'tests': ['tp5o']}, 08:03:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:03:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:03:30 INFO - 'talos_options': ['--disable-e10s', 08:03:30 INFO - '--xperf_path', 08:03:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:30 INFO - 'tests': ['tp5n']}, 08:03:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:03:30 INFO - 'talos_options': ['--xperf_path', 08:03:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:30 INFO - 'tests': ['tp5n']}}, 08:03:30 INFO - 'talos.zip': {'path': '', 08:03:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:03:30 INFO - Running post-action listener: _resource_record_post_action 08:03:30 INFO - [mozharness: 2017-02-03 16:03:30.697349Z] Finished populate-webroot step (success) 08:03:30 INFO - [mozharness: 2017-02-03 16:03:30.697440Z] Running create-virtualenv step. 08:03:30 INFO - Running pre-action listener: _resource_record_pre_action 08:03:30 INFO - Running main action method: create_virtualenv 08:03:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:03:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:03:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:30 INFO - Using real prefix '/usr' 08:03:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:33 INFO - Installing pip.................done. 08:03:33 INFO - Return code: 0 08:03:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:03:33 INFO - Reading from file tmpfile_stdout 08:03:33 INFO - Output received: 08:03:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:03:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:03:33 INFO - Using env: {'DISPLAY': ':0', 08:03:33 INFO - 'HOME': '/home/cltbld', 08:03:33 INFO - 'LANG': 'en_US.UTF-8', 08:03:33 INFO - 'LANGUAGE': 'en_US:en', 08:03:33 INFO - 'LOGNAME': 'cltbld', 08:03:33 INFO - 'MAIL': '/var/mail/cltbld', 08:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:33 INFO - 'MOZ_NO_REMOTE': '1', 08:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:33 INFO - 'NO_EM_RESTART': '1', 08:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:33 INFO - 'PWD': '/builds/slave/test', 08:03:33 INFO - 'SHELL': '/bin/bash', 08:03:33 INFO - 'SHLVL': '1', 08:03:33 INFO - 'TERM': 'linux', 08:03:33 INFO - 'TMOUT': '86400', 08:03:33 INFO - 'USER': 'cltbld', 08:03:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:33 INFO - '_': '/tools/buildbot/bin/python'} 08:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:33 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 08:03:33 INFO - Cleaning up... 08:03:33 INFO - Return code: 0 08:03:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:03:33 INFO - Using env: {'DISPLAY': ':0', 08:03:33 INFO - 'HOME': '/home/cltbld', 08:03:33 INFO - 'LANG': 'en_US.UTF-8', 08:03:33 INFO - 'LANGUAGE': 'en_US:en', 08:03:33 INFO - 'LOGNAME': 'cltbld', 08:03:33 INFO - 'MAIL': '/var/mail/cltbld', 08:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:33 INFO - 'MOZ_NO_REMOTE': '1', 08:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:33 INFO - 'NO_EM_RESTART': '1', 08:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:33 INFO - 'PWD': '/builds/slave/test', 08:03:33 INFO - 'SHELL': '/bin/bash', 08:03:33 INFO - 'SHLVL': '1', 08:03:33 INFO - 'TERM': 'linux', 08:03:33 INFO - 'TMOUT': '86400', 08:03:33 INFO - 'USER': 'cltbld', 08:03:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:33 INFO - '_': '/tools/buildbot/bin/python'} 08:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:33 INFO - Downloading/unpacking psutil>=3.1.1 08:03:33 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 08:03:33 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 08:03:33 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 08:03:33 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 08:03:33 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 08:03:33 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 08:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:03:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:36 INFO - Installing collected packages: psutil 08:03:36 INFO - Running setup.py install for psutil 08:03:36 INFO - building 'psutil._psutil_linux' extension 08:03:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:03:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:03:36 INFO - building 'psutil._psutil_posix' extension 08:03:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:03:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:03:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:36 INFO - Successfully installed psutil 08:03:36 INFO - Cleaning up... 08:03:36 INFO - Return code: 0 08:03:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:03:36 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')]} 08:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:36 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')]} 08:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:36 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 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:36 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 08:03:36 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 08:03:36 INFO - Using env: {'DISPLAY': ':0', 08:03:36 INFO - 'HOME': '/home/cltbld', 08:03:36 INFO - 'LANG': 'en_US.UTF-8', 08:03:36 INFO - 'LANGUAGE': 'en_US:en', 08:03:36 INFO - 'LOGNAME': 'cltbld', 08:03:36 INFO - 'MAIL': '/var/mail/cltbld', 08:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:36 INFO - 'MOZ_NO_REMOTE': '1', 08:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:36 INFO - 'NO_EM_RESTART': '1', 08:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:36 INFO - 'PWD': '/builds/slave/test', 08:03:36 INFO - 'SHELL': '/bin/bash', 08:03:36 INFO - 'SHLVL': '1', 08:03:36 INFO - 'TERM': 'linux', 08:03:36 INFO - 'TMOUT': '86400', 08:03:36 INFO - 'USER': 'cltbld', 08:03:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:36 INFO - '_': '/tools/buildbot/bin/python'} 08:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:03:36 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 08:03:36 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 08:03:36 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 08:03:36 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 08:03:36 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 08:03:36 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 08:03:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:03:38 INFO - Installing collected packages: mozsystemmonitor 08:03:38 INFO - Running setup.py install for mozsystemmonitor 08:03:38 INFO - Successfully installed mozsystemmonitor 08:03:38 INFO - Cleaning up... 08:03:39 INFO - Return code: 0 08:03:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:03:39 INFO - Using env: {'DISPLAY': ':0', 08:03:39 INFO - 'HOME': '/home/cltbld', 08:03:39 INFO - 'LANG': 'en_US.UTF-8', 08:03:39 INFO - 'LANGUAGE': 'en_US:en', 08:03:39 INFO - 'LOGNAME': 'cltbld', 08:03:39 INFO - 'MAIL': '/var/mail/cltbld', 08:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:39 INFO - 'MOZ_NO_REMOTE': '1', 08:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:39 INFO - 'NO_EM_RESTART': '1', 08:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:39 INFO - 'PWD': '/builds/slave/test', 08:03:39 INFO - 'SHELL': '/bin/bash', 08:03:39 INFO - 'SHLVL': '1', 08:03:39 INFO - 'TERM': 'linux', 08:03:39 INFO - 'TMOUT': '86400', 08:03:39 INFO - 'USER': 'cltbld', 08:03:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:39 INFO - '_': '/tools/buildbot/bin/python'} 08:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:39 INFO - Downloading/unpacking jsonschema==2.5.1 08:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:03:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:03:41 INFO - warning: no files found matching '*.txt' 08:03:41 INFO - no previously-included directories found matching 'build' 08:03:41 INFO - no previously-included directories found matching 'dist' 08:03:41 INFO - no previously-included directories found matching '.git*' 08:03:41 INFO - Installing collected packages: jsonschema, functools32 08:03:41 INFO - Running setup.py install for functools32 08:03:41 INFO - warning: no files found matching '*.txt' 08:03:41 INFO - no previously-included directories found matching 'build' 08:03:41 INFO - no previously-included directories found matching 'dist' 08:03:41 INFO - no previously-included directories found matching '.git*' 08:03:41 INFO - Successfully installed jsonschema functools32 08:03:41 INFO - Cleaning up... 08:03:41 INFO - Return code: 0 08:03:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:41 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 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:41 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 08:03:41 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 08:03:41 INFO - Using env: {'DISPLAY': ':0', 08:03:41 INFO - 'HOME': '/home/cltbld', 08:03:41 INFO - 'LANG': 'en_US.UTF-8', 08:03:41 INFO - 'LANGUAGE': 'en_US:en', 08:03:41 INFO - 'LOGNAME': 'cltbld', 08:03:41 INFO - 'MAIL': '/var/mail/cltbld', 08:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:41 INFO - 'MOZ_NO_REMOTE': '1', 08:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:41 INFO - 'NO_EM_RESTART': '1', 08:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:41 INFO - 'PWD': '/builds/slave/test', 08:03:41 INFO - 'SHELL': '/bin/bash', 08:03:41 INFO - 'SHLVL': '1', 08:03:41 INFO - 'TERM': 'linux', 08:03:41 INFO - 'TMOUT': '86400', 08:03:41 INFO - 'USER': 'cltbld', 08:03:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:41 INFO - '_': '/tools/buildbot/bin/python'} 08:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:03:41 INFO - Cleaning up... 08:03:42 INFO - Return code: 0 08:03:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:03:42 INFO - Using env: {'DISPLAY': ':0', 08:03:42 INFO - 'HOME': '/home/cltbld', 08:03:42 INFO - 'LANG': 'en_US.UTF-8', 08:03:42 INFO - 'LANGUAGE': 'en_US:en', 08:03:42 INFO - 'LOGNAME': 'cltbld', 08:03:42 INFO - 'MAIL': '/var/mail/cltbld', 08:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:42 INFO - 'MOZ_NO_REMOTE': '1', 08:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:42 INFO - 'NO_EM_RESTART': '1', 08:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:42 INFO - 'PWD': '/builds/slave/test', 08:03:42 INFO - 'SHELL': '/bin/bash', 08:03:42 INFO - 'SHLVL': '1', 08:03:42 INFO - 'TERM': 'linux', 08:03:42 INFO - 'TMOUT': '86400', 08:03:42 INFO - 'USER': 'cltbld', 08:03:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:42 INFO - '_': '/tools/buildbot/bin/python'} 08:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:03:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:03:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:44 INFO - Downloading docopt-0.6.1.tar.gz 08:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:03:45 INFO - Installing collected packages: blobuploader, requests, docopt 08:03:45 INFO - Running setup.py install for blobuploader 08:03:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:03:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:03:45 INFO - Running setup.py install for requests 08:03:45 INFO - Running setup.py install for docopt 08:03:45 INFO - Successfully installed blobuploader requests docopt 08:03:45 INFO - Cleaning up... 08:03:45 INFO - Return code: 0 08:03:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:45 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')]} 08:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 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')]} 08:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 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 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:45 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 08:03:45 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 08:03:45 INFO - Using env: {'DISPLAY': ':0', 08:03:45 INFO - 'HOME': '/home/cltbld', 08:03:45 INFO - 'LANG': 'en_US.UTF-8', 08:03:45 INFO - 'LANGUAGE': 'en_US:en', 08:03:45 INFO - 'LOGNAME': 'cltbld', 08:03:45 INFO - 'MAIL': '/var/mail/cltbld', 08:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:45 INFO - 'MOZ_NO_REMOTE': '1', 08:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:45 INFO - 'NO_EM_RESTART': '1', 08:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:45 INFO - 'PWD': '/builds/slave/test', 08:03:45 INFO - 'SHELL': '/bin/bash', 08:03:45 INFO - 'SHLVL': '1', 08:03:45 INFO - 'TERM': 'linux', 08:03:45 INFO - 'TMOUT': '86400', 08:03:45 INFO - 'USER': 'cltbld', 08:03:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:45 INFO - '_': '/tools/buildbot/bin/python'} 08:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:45 INFO - Running setup.py (path:/tmp/pip-zBmAqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:45 INFO - Running setup.py (path:/tmp/pip-Dq1gv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:46 INFO - Running setup.py (path:/tmp/pip-uheLZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:46 INFO - Running setup.py (path:/tmp/pip-IdYPg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:46 INFO - Running setup.py (path:/tmp/pip-fN8Pil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:46 INFO - Running setup.py (path:/tmp/pip-g5MZi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:46 INFO - Running setup.py (path:/tmp/pip-nmcOHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:46 INFO - Running setup.py (path:/tmp/pip-dmGhi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:46 INFO - Running setup.py (path:/tmp/pip-BJd2KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:46 INFO - Running setup.py (path:/tmp/pip-kAZOUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:46 INFO - Running setup.py (path:/tmp/pip-TEYmUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:46 INFO - Running setup.py (path:/tmp/pip-aeVlFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:46 INFO - Running setup.py (path:/tmp/pip-LRfiaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:46 INFO - Running setup.py (path:/tmp/pip-B7Vo9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:46 INFO - Running setup.py (path:/tmp/pip-bh8s8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:46 INFO - Running setup.py (path:/tmp/pip-OzbBLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:47 INFO - Running setup.py (path:/tmp/pip-BS44VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:03:47 INFO - Running setup.py install for manifestparser 08:03:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:03:47 INFO - Running setup.py install for mozcrash 08:03:47 INFO - Running setup.py install for mozdebug 08:03:47 INFO - Running setup.py install for mozdevice 08:03:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:03:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:03:47 INFO - Running setup.py install for mozfile 08:03:47 INFO - Running setup.py install for mozhttpd 08:03:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:03:47 INFO - Running setup.py install for mozinfo 08:03:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:03:47 INFO - Running setup.py install for mozInstall 08:03:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:03:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:03:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:03:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:03:47 INFO - Running setup.py install for mozleak 08:03:47 INFO - Running setup.py install for mozlog 08:03:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:03:48 INFO - Running setup.py install for moznetwork 08:03:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:03:48 INFO - Running setup.py install for mozprocess 08:03:48 INFO - Running setup.py install for mozprofile 08:03:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:03:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:03:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:03:48 INFO - Running setup.py install for mozrunner 08:03:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:03:48 INFO - Running setup.py install for mozscreenshot 08:03:48 INFO - Running setup.py install for moztest 08:03:48 INFO - Running setup.py install for mozversion 08:03:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:03:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:03:48 INFO - Cleaning up... 08:03:48 INFO - Return code: 0 08:03:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:48 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 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:48 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 08:03:48 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 08:03:48 INFO - Using env: {'DISPLAY': ':0', 08:03:48 INFO - 'HOME': '/home/cltbld', 08:03:48 INFO - 'LANG': 'en_US.UTF-8', 08:03:48 INFO - 'LANGUAGE': 'en_US:en', 08:03:48 INFO - 'LOGNAME': 'cltbld', 08:03:48 INFO - 'MAIL': '/var/mail/cltbld', 08:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:48 INFO - 'MOZ_NO_REMOTE': '1', 08:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:48 INFO - 'NO_EM_RESTART': '1', 08:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:48 INFO - 'PWD': '/builds/slave/test', 08:03:48 INFO - 'SHELL': '/bin/bash', 08:03:48 INFO - 'SHLVL': '1', 08:03:48 INFO - 'TERM': 'linux', 08:03:48 INFO - 'TMOUT': '86400', 08:03:48 INFO - 'USER': 'cltbld', 08:03:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:48 INFO - '_': '/tools/buildbot/bin/python'} 08:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:49 INFO - Running setup.py (path:/tmp/pip-VLhFQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:49 INFO - Running setup.py (path:/tmp/pip-NxWmh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:49 INFO - Running setup.py (path:/tmp/pip-yqDOEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:49 INFO - Running setup.py (path:/tmp/pip-4mSl2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:49 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)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:49 INFO - Running setup.py (path:/tmp/pip-x8xPwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:49 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)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:49 INFO - Running setup.py (path:/tmp/pip-LFW1Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:49 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)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:49 INFO - Running setup.py (path:/tmp/pip-bqwIGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:49 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)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:49 INFO - Running setup.py (path:/tmp/pip-Hne_54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:49 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)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:49 INFO - Running setup.py (path:/tmp/pip-BK5dp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:49 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)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:49 INFO - Running setup.py (path:/tmp/pip-vEi0pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:49 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)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:49 INFO - Running setup.py (path:/tmp/pip-x9ipHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:49 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)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:49 INFO - Running setup.py (path:/tmp/pip-uYF0iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:50 INFO - Running setup.py (path:/tmp/pip-W_Y8O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:50 INFO - Running setup.py (path:/tmp/pip-bKfbXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:50 INFO - Running setup.py (path:/tmp/pip-IOT643-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:50 INFO - Running setup.py (path:/tmp/pip-9E0cWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:50 INFO - Running setup.py (path:/tmp/pip-hnbvjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:03:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:50 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 08:03:50 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 08:03:50 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 08:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:50 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 08:03:52 INFO - Downloading blessings-1.6.tar.gz 08:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:03:52 INFO - Installing collected packages: blessings 08:03:52 INFO - Running setup.py install for blessings 08:03:52 INFO - Successfully installed blessings 08:03:52 INFO - Cleaning up... 08:03:52 INFO - Return code: 0 08:03:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:03:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:03:52 INFO - Reading from file tmpfile_stdout 08:03:52 INFO - Current package versions: 08:03:52 INFO - argparse == 1.2.1 08:03:52 INFO - blessings == 1.6 08:03:52 INFO - blobuploader == 1.2.4 08:03:52 INFO - docopt == 0.6.1 08:03:52 INFO - functools32 == 3.2.3-2 08:03:52 INFO - jsonschema == 2.5.1 08:03:52 INFO - manifestparser == 1.1 08:03:52 INFO - mozInstall == 1.12 08:03:52 INFO - mozcrash == 1.0 08:03:52 INFO - mozdebug == 0.1 08:03:52 INFO - mozdevice == 0.49 08:03:52 INFO - mozfile == 1.2 08:03:52 INFO - mozhttpd == 0.7 08:03:52 INFO - mozinfo == 0.9 08:03:52 INFO - mozleak == 0.1 08:03:52 INFO - mozlog == 3.4 08:03:52 INFO - moznetwork == 0.27 08:03:52 INFO - mozprocess == 0.24 08:03:52 INFO - mozprofile == 0.28 08:03:52 INFO - mozrunner == 6.13 08:03:52 INFO - mozscreenshot == 0.1 08:03:52 INFO - mozsystemmonitor == 0.3 08:03:52 INFO - moztest == 0.8 08:03:52 INFO - mozversion == 1.4 08:03:52 INFO - psutil == 3.1.1 08:03:52 INFO - requests == 1.2.3 08:03:52 INFO - wsgiref == 0.1.2 08:03:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:52 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 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:52 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 08:03:52 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 08:03:52 INFO - Using env: {'DISPLAY': ':0', 08:03:52 INFO - 'HOME': '/home/cltbld', 08:03:52 INFO - 'LANG': 'en_US.UTF-8', 08:03:52 INFO - 'LANGUAGE': 'en_US:en', 08:03:52 INFO - 'LOGNAME': 'cltbld', 08:03:52 INFO - 'MAIL': '/var/mail/cltbld', 08:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:52 INFO - 'MOZ_NO_REMOTE': '1', 08:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:52 INFO - 'NO_EM_RESTART': '1', 08:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:52 INFO - 'PWD': '/builds/slave/test', 08:03:52 INFO - 'SHELL': '/bin/bash', 08:03:52 INFO - 'SHLVL': '1', 08:03:52 INFO - 'TERM': 'linux', 08:03:52 INFO - 'TMOUT': '86400', 08:03:52 INFO - 'USER': 'cltbld', 08:03:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:52 INFO - '_': '/tools/buildbot/bin/python'} 08:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:03:53 INFO - Cleaning up... 08:03:53 INFO - Return code: 0 08:03:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cab480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', '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 08:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:03: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 08:03:53 INFO - Using env: {'DISPLAY': ':0', 08:03:53 INFO - 'HOME': '/home/cltbld', 08:03:53 INFO - 'LANG': 'en_US.UTF-8', 08:03:53 INFO - 'LANGUAGE': 'en_US:en', 08:03:53 INFO - 'LOGNAME': 'cltbld', 08:03:53 INFO - 'MAIL': '/var/mail/cltbld', 08:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:53 INFO - 'MOZ_NO_REMOTE': '1', 08:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:53 INFO - 'NO_EM_RESTART': '1', 08:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:53 INFO - 'PWD': '/builds/slave/test', 08:03:53 INFO - 'SHELL': '/bin/bash', 08:03:53 INFO - 'SHLVL': '1', 08:03:53 INFO - 'TERM': 'linux', 08:03:53 INFO - 'TMOUT': '86400', 08:03:53 INFO - 'USER': 'cltbld', 08:03:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:53 INFO - '_': '/tools/buildbot/bin/python'} 08:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:03:53 INFO - Cleaning up... 08:03:53 INFO - Return code: 0 08:03:53 INFO - Running post-action listener: _resource_record_post_action 08:03:53 INFO - Running post-action listener: _start_resource_monitoring 08:03:53 INFO - Starting resource monitoring. 08:03:53 INFO - [mozharness: 2017-02-03 16:03:53.381912Z] Finished create-virtualenv step (success) 08:03:53 INFO - [mozharness: 2017-02-03 16:03:53.382426Z] Running install step. 08:03:53 INFO - Running pre-action listener: _resource_record_pre_action 08:03:53 INFO - Running main action method: install 08:03:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:03:53 INFO - Reading from file tmpfile_stdout 08:03:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:03:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:03:53 INFO - Reading from file tmpfile_stdout 08:03:53 INFO - Output received: 08:03:53 INFO - Usage: mozinstall [options] installer 08:03:53 INFO - Options: 08:03:53 INFO - -h, --help show this help message and exit 08:03:53 INFO - -d DEST, --destination=DEST 08:03:53 INFO - Directory to install application into. [default: 08:03:53 INFO - "/builds/slave/test"] 08:03:53 INFO - --app=APP Application being installed. [default: firefox] 08:03:53 INFO - mkdir: /builds/slave/test/build/application 08:03:53 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'] 08:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:04:10 INFO - Reading from file tmpfile_stdout 08:04:10 INFO - Output received: 08:04:10 INFO - /builds/slave/test/build/application/firefox/firefox 08:04:10 INFO - Running post-action listener: _resource_record_post_action 08:04:10 INFO - [mozharness: 2017-02-03 16:04:10.130846Z] Finished install step (success) 08:04:10 INFO - [mozharness: 2017-02-03 16:04:10.131122Z] Running run-tests step. 08:04:10 INFO - Running pre-action listener: _resource_record_pre_action 08:04:10 INFO - Running main action method: run_tests 08:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:10 INFO - Python 2.7.3 08:04:10 INFO - Return code: 0 08:04:10 INFO - grabbing minidump binary from tooltool 08:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:10 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 0x1ca8820>, '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 0x1ca9520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca99b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:10 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 08:04:10 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 08:04:10 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 08:04:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:10 INFO - Return code: 0 08:04:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:04:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:04:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:04:10 INFO - Using env: {'DISPLAY': ':0', 08:04:10 INFO - 'HOME': '/home/cltbld', 08:04:10 INFO - 'LANG': 'en_US.UTF-8', 08:04:10 INFO - 'LANGUAGE': 'en_US:en', 08:04:10 INFO - 'LOGNAME': 'cltbld', 08:04:10 INFO - 'MAIL': '/var/mail/cltbld', 08:04:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:10 INFO - 'MOZ_NO_REMOTE': '1', 08:04:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:10 INFO - 'NO_EM_RESTART': '1', 08:04:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:10 INFO - 'PWD': '/builds/slave/test', 08:04:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:10 INFO - 'SHELL': '/bin/bash', 08:04:10 INFO - 'SHLVL': '1', 08:04:10 INFO - 'TERM': 'linux', 08:04:10 INFO - 'TMOUT': '86400', 08:04:10 INFO - 'USER': 'cltbld', 08:04:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733', 08:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:10 INFO - '_': '/tools/buildbot/bin/python'} 08:04:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:04:10 INFO - mozversion application_buildid: 20170203145631 08:04:10 INFO - mozversion application_changeset: c02020dd7e6e190b046e0bdc992a75b647c4cffa 08:04:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:04:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:10 INFO - mozversion application_name: Firefox 08:04:10 INFO - mozversion application_remotingname: firefox-dev 08:04:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:04:10 INFO - mozversion application_vendor: Mozilla 08:04:10 INFO - mozversion application_version: 53.0a2 08:04:10 INFO - mozversion platform_buildid: 20170203145631 08:04:10 INFO - mozversion platform_changeset: c02020dd7e6e190b046e0bdc992a75b647c4cffa 08:04:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:04:10 INFO - mozversion platform_version: 53.0a2 08:04:10 INFO - using testdate: 1486137850 08:04:10 INFO - actual date: 1486137850 08:04:10 INFO - starting webserver on 'localhost:33881' 08:04:10 INFO - SUITE-START | Running 2 tests 08:04:10 INFO - TEST-START | dromaeo_css 08:04:10 INFO - operating with platform_type : linux_ 08:04:10 INFO - Initialising browser for dromaeo_css test... 08:04:10 INFO - TEST-INFO | started process 31265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBAEfal/profile http://localhost:33881/getInfo.html) 08:04:15 INFO - PROCESS | 31265 | __metrics Screen width/height:1600/1200 08:04:15 INFO - PROCESS | 31265 | colorDepth:24 08:04:15 INFO - PROCESS | 31265 | Browser inner width/height: 1024/697 08:04:15 INFO - PROCESS | 31265 | __metrics 08:04:15 INFO - PROCESS | 31265 | 1486137855727 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) 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:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpBAEfal/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpBAEfal/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpBAEfal/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpBAEfal/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:04:15 ERROR - PROCESS | 31265 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:04:16 INFO - TEST-INFO | 31265: exit 0 08:04:16 INFO - Browser initialized. 08:04:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:16 INFO - TEST-INFO | started process 31392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBAEfal/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:28 INFO - PROCESS | 31392 | RSS: Main: 144642048 08:04:28 INFO - PROCESS | 31392 | 08:07:27 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:33881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33881/tests/dromaeo/cssquery-ext.html) 08:07:28 INFO - PROCESS | 31392 | RSS: Main: 154542080 08:07:28 INFO - PROCESS | 31392 | 08:09:17 INFO - PROCESS | 31392 | ************************* 08:09:17 INFO - PROCESS | 31392 | A coding exception was thrown and uncaught in a Task. 08:09:17 INFO - PROCESS | 31392 | 08:09:17 ERROR - PROCESS | 31392 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:09:17 INFO - PROCESS | 31392 | Full stack: 08:09:17 INFO - PROCESS | 31392 | ************************* 08:10:30 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:33881/tests/dromaeo/cssquery-ext.html (next: http://localhost:33881/tests/dromaeo/cssquery-jquery.html) 08:10:31 INFO - PROCESS | 31392 | RSS: Main: 149942272 08:10:31 INFO - PROCESS | 31392 | 08:13:33 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:33881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33881/tests/dromaeo/cssquery-mootools.html) 08:13:33 INFO - PROCESS | 31392 | RSS: Main: 153583616 08:13:33 INFO - PROCESS | 31392 | 08:16:35 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:33881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33881/tests/dromaeo/cssquery-prototype.html) 08:16:36 INFO - PROCESS | 31392 | RSS: Main: 149848064 08:16:36 INFO - PROCESS | 31392 | 08:19:38 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:33881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33881/tests/dromaeo/cssquery-yui.html) 08:19:39 INFO - PROCESS | 31392 | RSS: Main: 154013696 08:19:39 INFO - PROCESS | 31392 | 08:22:41 INFO - PROCESS | 31392 | Cycle 1(1): loaded http://localhost:33881/tests/dromaeo/cssquery-yui.html (next: http://localhost:33881/tests/dromaeo/cssquery-dojo.html) 08:22:41 INFO - PROCESS | 31392 | RSS: Main: 154365952 08:22:41 INFO - PROCESS | 31392 | 08:22:41 INFO - PROCESS | 31392 | __start_tp_report 08:22:41 INFO - PROCESS | 31392 | _x_x_mozilla_page_load 08:22:41 INFO - PROCESS | 31392 | _x_x_mozilla_page_load_details 08:22:41 INFO - PROCESS | 31392 | |i|pagename|runs| 08:22:41 INFO - PROCESS | 31392 | |0;dojo.html;3264.9510257346137;3280.2291461506543;3287.161773747694;3301.603807543095;3306.173456635841;5562.694051827153;5587.7764889404425;5591.1054231323;5596.356419011805;5611.971940140304;5549.77800887964;5582.051051321275;5624.662520248788;5632.915506267409;5674.233978412913;4994.525520075596;5010.423801262847;5056.3173971513925;5096.779015021295;5104.846854594368;4997.625178111638;5052.646314757969;5090.440051594322;5113.437521872591;5139.383274007125;4937.382827146606;4952;5084.79660813567;5098.439171691111;5099.592032637399;4964.255361695738;4977.7262250576205;4990.725510096943;5056.367954005749;5099.4390617032095;4963.60291176705;5023.522765337287;5026.648134630577;5029.949700503022;5038.3198268234055;5493.340799104093;5504.614676972614;5579.330480342385;5588.245586845765;5598.664080155204;5789.363170051291;5806.245188125559;5867.647941123503;5870.589058765888;5891.3814049525035;6005.219321488178;6019.187409699678;6022.2171117754415;6054.848628784272;6073.635581865058;5612.635178713412;5615.915761263625;5620.887582248332;5627.380988091307;5629.915551266734;5882.088276317178;5949.613275137102;5959.940400595939;5996.730147143389;6082.391760823883;5839.766409343663;5879.941200587939;5900.291964964232;5925.318588362307;5927.4665280125;5905.704714764244;5928.110783382527;5975.43233392827;5982.611130276518;5983.072623743326;5752.827415177551;5811.4479124483105;5867.119932010147;5950.285965684146;5965.850853728692;5899.46904778572;5980.5514586405325;5992.730327135202;6003.699815009232;6027.819165425044;4590.196715574828;4594.6783725139585;4610.815567377334;4611.146937816515;4634.073185362941;3999.560048394674;4011.3782363733667;4097.364908439196;4103.630673239423;4126.566710495415;5710.371859095496;5722.62802917809;5745.080787074048;5819.563532735062;5853.209816674695;5976.7908123215475;6014.248218972629;6027.306859711101;6037.305709843336;6057.151998720183;5512.2558454608115;5542.944570554324;5578.497935185853;5830.387809279964;5855.502282305966;5026.447090820006;5030.798768049311;5040.672356296829;5073.898522029613;5094.032133894622;6170.136180934673;6171.5988460750805;6181.041938499539;6207.751689932443;6219.40915613016;6040.607360521552;6045.357585039243;6048.606840555526;6063.969680151571;6082.847928801815;5886.323072846678;5924.881502369843;6003.7898673546215;6199.56603037783;6260.74957001733;5739.8565035874435;5883.176355310346;5902.61632993854;5904.498117660047;5939.287285525765;5960.5827592068135;5970.223870896755;5982.910256346246;5993.951058564821;6007.8197654070445;5714.885702286014;5755.251817263729;5773.711314434346;5825.330087039875;5852.824415267379;5729.742161602821;5782.219400381063;5794.333651630117;5834.883302334015;5863.824085277449;5825.679587622722;5828;5831.562632802642;5835.9708201458725;5871.94128058714;5819.447152520504;5839.8832023358445;5864.296284445893;5872.5301975842685;5890.587658863838;5547.694876781654;5662.5469962402085;5688.800891968761;5692.516136128475;5714.685692286964 08:22:41 INFO - PROCESS | 31392 | |1;ext.html;570.4039278953493;611.5627326461579;641.653507106163;648.6270394523148;667.529391778796;46553;47795;47803.76098119513;53104.46895531043;53171;50374.244386334234;51237;51300.74349628256;51308.23037654438;51332.48667513324;9278.53607319633;9530.714078577654;10632.57469701211;10934;10941.945290273577;10843.945780271088;10934.343939363624;10936.56253749849;10939.179561532877;10941.12471002318;10894;10908.181886358516;10944.45277736114;10974;11023;10720.624778132767;10800.243982921198;10815.621453249178;10873;10874;10659.94670026645;10731.731706707316;10764;10769;10818.02637762605;42367.36448953268;42577.36133957993;42642.360364594555;42762.57237427617;42775.786121069505;4311.558338846297;4370.978145109286;4406.294992801137;4471.038726673781;4496.685232033759;31853.840730796197;31975.6802431975;32050.358992820245;32190.74378360143;32572.511412328833;4456.598906098434;4496.79764410599;4666.883327916796;4682.367880336145;4735.076660051292;365417;367033;367360;367644;367881;62322;62612.68693656594;63217;63272.683636581525;63404.68297658575;64879.67560162169;65049.67475162689;65172.348276516626;65301.34698653048;65354;16583.6683266334;16849.578760531083;17485.21316540733;17510.29958801659;17544.473665790047;13813.102148360324;13844.238566878717;13848.930755346159;14055.859441405659;14143.71712565743;19262.32581859656;19510.70733938992;19524.31947799672;19547.413577592695;19563.80436195648;6894.551854129566;7185.173705023884;7371.226021267689;7407.148177959603;7523.510971786816;1008.2035192198082;1008.2135933971514;1023.5036007536339;1024.800163968019;1028.1209565821264;33499.66500335014;33587.66412335894;33669.494957575655;33837.830810845786;34600.9619711404;1087.3530249501534;1181.8995385392166;1183.6153250193722;1204.2954871400154;1205.2888795610631;17625.91187044082;17786.733199002025;17890;17937.910310448366;18163.818361816477;538216;539266;542576;545113;546414;70357.2964270361;70657.64671176611;70984;71119;71202.64398678076;1569.7488401855649;1582.1298285942685;1593.7768712380275;1594.8405159484191;1601.7677436771603;31283.53074703927;31568;31635.683643163273;31916.68083319137;32171;59477.40522594892;59623.40376596178;60337.39662603493;60377.69811150916;60455.69772151111;382828;384094;384798;386044;386303;29197.270068248465;29349.11952641424;30177.54733678953;31337.216569585944;31831.204219894687;46620.53379466297;46800.531994679615;46914.296285556426;47451.52548474609;48255.27617085817;38320.80839595896;38805.2238955225;39304.21391572095;39771.60228397679;40588.594114058484;38904.6109538901;39068.218635627694;39495.81086933873;39509.2098158041;39904.800475997436;39783.204335913695;40507.3923891136;40520.594794052864;40566.1886762269;40775;32721.34557308888;33488.33023339568;33752.49371259482;33980.83009585035;34045.48931766075;27012.45975080448;27154.864225679536;27221.1833644991;27233.86383068072;27677 08:22:41 INFO - PROCESS | 31392 | |2;jquery.html;426.6437524666903;433.5022497271926;435.78646463233014;439.41996564534804;442.3298702465765;20233.39299821006;21056;22153.889230553825;22360.440988975282;22401.887990560066;21699.240526581572;21728.782712172913;21782.673259901116;21866.125354985783;23003.884980575116;6080.908786368197;6276.184096067527;6305.432511074003;6312.652804095773;6334.271558770732;5945.197398351233;6154.230721159855;6164.229471316085;6164.630122192661;6172.783952561661;6011.729472173763;6122.142899994004;6134.846628834271;6138.539609529281;6154.784582539612;6197.442230199281;6283.528735344822;6288.874222515524;6320.051992201161;6328.367163283658;6022.5483088768515;6130.386961303834;6169.198004259462;6208.410201030895;6246.187995560594;14572.12567245958;14720.190389528572;14828.406863725439;24172.879135604384;24739.62890556643;2735.8221715588425;2781.193453898367;2781.916542503728;2792.6229958955482;2818.619486369355;11020.724481887937;11147.554097836077;11754.764904701944;12803.48786048557;14876.70246595062;1992.5417154054649;2075.0869617368307;2077.106844057055;2084.5830833833293;2090.080364639554;76381;81086.59456702678;90431;97729;99732;12096.153269271066;12278.324692142018;12528.561500347445;12634.620961371174;12736.681582960315;17690;17804.10979451048;17818.91090544539;17886.195121219578;17891.642167156584;7274.1267199455915;7276.745313913988;7442.627868606548;8268.9663792026;9523.952380238054;9032.63869445228;9067.773305667411;9069.637214511346;9204.815903681889;9238.676646317346;5279.1289437243195;5307.575393968474;5307.787688492417;5320.733963301819;5433.429489903503;2113.9471513211984;2174.119386730467;2190.638544640148;2208.7901649343285;2210.082815631495;937.315759495572;952.0194199974038;952.590386133969;955.350361754014;961.5721004153085;19685.40943771689;21205.469863253544;21375.57248855014;21421.666816147943;21605.02777375022;947.4836214263244;966.8888077871135;971.4462756228882;977.5600979559226;988.945607991553;11650.708732281591;11717.531298747954;11726.41367931617;11768.70578235551;11786.88213117875;619242;643256;678331;695959;700125;98292;98842.5057874706;98986.50506747421;102379;102927.02845362504;962.6438217859297;988.5205675247499;991.5785791038924;994.5275993902839;999.7750506136061;17503.82496175022;17755.822441775417;17874.5531361717;17968.820311796713;18199.45401637953;42711.57288427076;44468;44895.55104449044;45668.54331456643;45724.771376142904;59747.103793444;62040.689796552535;65769.67115164394;66386.3123465262;67551;8944.284457243535;8977.955110224408;9003.954980225057;9107.908920910706;9283.442993420416;13030.609081727564;13177.47290108385;13224.272665003517;13225.603231903058;13580.117292375964;11179.72050698739;11315.547378104784;11407.144464165054;11675.64973050776;11795.941020294844;11086;11250.831237531607;11335.603253886075;11376.431178441211;11525.135614828754;10747.408892510986;11326.886731132912;11404.543818247177;11503.194776365573;11991.460384282555;8864.46520457606;8904.910950890668;8958.596863141305;8984.505852177932;9225;8832.028476867668;10885.23803333759;11457.369844658624;11620.128490363088;11777.470013849226 08:22:41 INFO - PROCESS | 31392 | |3;mootools.html;1441.9927900360497;1472.9189894555798;1477.5641185850172;1484.2875419798504;1489.5754709907676;7560.810979725509;7734;8025.759227223178;8529.957350213248;8554.358423118269;7980.600969951508;8152.5516096614665;8164.142765009663;8379.874301885477;8391.412601117925;2371.95256094878;2389.569877422063;2392.4018995251186;2396.6405039244164;2407.217654262363;2333.0784340185614;2367.2898130560848;2380.297812145421;2382.344855164835;2390.199283240108;2315.073970411832;2318.6058370077044;2326.3486223857262;2327.3948773318975;2352.2358231326507;2269.5914735347633;2275.8065564427043;2311.9653205201766;2321.512482378694;2326.2323433267065;2273.8408311418207;2308.0075567505965;2319.5360927814336;2328.6041372966465;2330.382448651109;8307.169283071706;8351.582420878993;8370.3303735701;8379.874301885477;8391.454555453876;4956.479569645171;5016.648834581581;5161.4322424533275;5187.299714538527;5221.425643179247;3167;3228.176814912206;3264.6245681746664;3286.7699261051735;3311.1887587540964;1304.2370213425158;1306.8954483641287;1312.4356526693614;1321.8479874814423;1340.1021315718492;11225.494852731646;11255.60605378816;11273.605423810128;11331.546738130464;11352.091832653368;4264;4500.954990450119;4505.346724724896;4581.587657110876;4645.5354464553275;9814.411135331902;9864.013598640078;9874.358166719141;9881.456519891331;9897;5115.0792857285305;5160.767765450564;5174.172132458789;5186.507281808297;5205.869853253699;4716.245400735935;4769.785359658824;4839.322494850724;4898.90202195954;4961.280614310905;3567.126054116758;3641.690456311243;3676.1544844685873;3705.3330400527625;3722.1625134344554;987.3434166279344;1000.494750151169;1021.5300961557618;1032.0866033560353;1044.4360045575456;992.374803873555;1006.5319626373771;1015.1777060580805;1023.2070145637042;1031.6853359725205;5566.972165139148;5727.541796656257;5744.913826292609;5850.9414905851245;5950;1021.2953062386929;1044.587387981743;1061.877884043345;1062.8512008318842;1103.2387652519897;3859.4017927221325;3885.2812229737588;3929.941050884182;3934.6458818706456;3971.6624086952934;9137.223336016381;9360.62557497706;9397.953010235042;9412.764680883032;9415.811683766286;9255.213306868856;9262.629494820132;9295.953520232355;9327.813443731224;9340.159385655325;7556.395488360918;7824.452288339876;7865.567393793282;7887.9605601971625;7915.366770658448;5800.39095894925;5859.179714840011;5911.201987731602;5962.403759624003;6030.4572588467245;8885.911140888767;8947.19475247231;8955.59699813523;9081.500517471603;9195.080491950752;9094.681686140953;9155.816883662157;9269.073092690676;9281.303902207497;9289.62841486333;7238.819029524304;7342.669579869025;7385.741499047507;7434;7486.475946683898;8240.381971352292;8313.833723325379;8318.62566184511;8321.500709957421;8326.167383261625;7165.820854478679;7219.6751146199595;7229.638518074181;7335;7389.630518474162;6745.089412929192;6848.075509806312;6873.175218973755;6899.275576064641;7114.1463024435325;6101.084837274267;6157.599756015845;6187.938120618736;6227.314995350598;6271.592346497463;4786.95213047865;4794.808207671654;4795.328653988375;4861.1979023460735;4891.021795640815;4851.902961940671;4867.5862551682085;4965;4983.775730092082;4992.500749925124 08:22:41 INFO - PROCESS | 31392 | |4;prototype.html;383.9116105839944;388.63468339760624;388.74537178148313;393.5867339293741;395.49969288849627;5430.3755068167075;5579.832605021846;5582.9441705582985;5634.323696244282;5688.288963879515;5438.592105592076;5463.153211252253;5486.890262194754;5487.149491828773;5518.475744804237;4224.556421575744;4265.765382903939;4266.189424009428;4280.336547835091;4291.527931927485;4010.358342665174;4162.229987452316;4233.618974292313;4255.17024180285;4268.743875367472;4166.625003749662;4166.8749937501925;4182.4562806835065;4189.832406703728;4193.664506839461;4157.3140431828715;4187.246295666779;4195.622393984556;4219.831206751726;4231.61915427613;3697.85208591656;3715.925681486382;3724.8510059597857;3730.9253814923823;3741.494898188737;5134.8202812901745;5264.368275806928;5275.709835959021;5299.258103865462;5333.466653334674;4847.006363695434;4865.562099411035;4881.388457175394;4895.2167653175675;4908.950910490885;5459.672419654833;5660.830175094754;5676.460736230051;5676.858078548028;5681.147827825818;4079.7960101995077;4085.6935729820384;4089.9591004090175;4103.281925663027;4110.136871257039;5919.3192782829665;5978.461938425519;5991.693198118712;6007.506884642868;6030.33666296707;4258.276093064186;4270.786460677016;4283.850065247701;4288.270993931039;4313.352997050468;4154.065335299594;4283.20760659279;4286.207051695446;4311.698181127291;4312.072904325585;4863.95136048635;4864.829730959399;4885.706857588556;4913.852584422473;4930.767308172957;5626.649604094988;5747.25285712863;5786.003828679099;5794.565407594448;5811.605214748514;1414.335262426658;1418.14202407544;1419.5457453614745;1425.7647488164337;1426.4579459805207;957.707899090784;978.8874279457812;983.7786498037884;994.6866736977829;1003.3628645809817;5399.244105825188;5466.753996070186;5489;5506.03644362243;5514.393416724157;5741.8564535886935;5756.827295181151;5759.107338362477;5776.451237132465;5853.7365818538265;5351.902859913786;5533.474319939599;5539.944600553943;5565.526930210977;5582.944170558242;3031.545268209786;3071.262896904727;3077.2153100959113;3088.7953698057777;3102.860371283298;5683.374828768832;5803.767849286066;5916.5504451408815;5967.671778052162;5989.55078369124;5840.269966254218;5843.678597677083;5853.678047707332;5854.677992710442;5898.764049437975;5811.767529298865;5829.775747093158;5851.180834683063;5859.472647461749;5934.851628709231;5599.040335882409;5692.8576785579035;5714.885702285847;5876.412358764261;5914.467697907209;5798.797042103506;5826.359100498857;5834.795782147605;5841.948449279171;5846.210761547307;5889.61223888206;6061.848453788691;6158.353372895961;6163;6166.784162554289;4063.227986682521;4089.2843752342624;4160.937585936153;4164.292070347988;4169.541350451387;5892.908017653843;5893.970530147321;5904.557158213065;5926.67403292823;5948.5538584605465;5740.741666625096;5744.741486633028;5774.797882074107;5820.30156381237;5822.243108395882;5607.943920560905;5714.857128571819;5740.540756739534;5751.654900705971;5754.309482861916;5736.6558006519745;5757.683327417032;5768.942310577008;5778.27771528559;5778.653280803165;5481.479259470344;5750.7987220447085;5797.420257974169;5797.579592999742;5824.475797178275;5640.4077571856005;5686.829395118153;5700.3444603871085;5701.515371193495;5719.8856022880145 08:22:41 INFO - PROCESS | 31392 | |5;yui.html;684.5858255755268;689.4553302890716;744.4677055905026;803.2489622203241;825.8265764189518;15695.60760980976;16937.576560585992;16975.15124243789;16986.915065424688;17041.82958170418;16284.022958622461;16390.180490975432;16548.172591370414;16583.005019698798;17286.654266914684;802.2619190344882;825.0676735289145;825.2655136928139;827.2926647716206;830.5182993863575;796.024869534821;796.7370767646663;798.2297083314601;800.0199755299741;800.5236884053978;847.2417186617973;849.9405041647087;853.7822855171922;853.9573021348939;854.2909385210261;845.5053793530792;845.6913226672251;848.1603212819296;849.9362547808877;852.3947996922193;616.5314361085562;618.7865186510646;619.3280290884396;619.6994457688018;621.8352136683783;15398.230088495531;15461.149636769973;15463.304151313105;15737.055776653437;16063.116528590923;13620.659483512893;13621.727565448635;13626.386812593359;13646.727065458734;13667.111637743516;12100.577262440118;12104.576339828063;12177.208481448766;12297.93851030748;12419.689507762378;3985.880423587297;4011.2779699654343;4039.171969746195;4115.753054816691;4122.793860306972;75948.43388857879;76760.61619691867;77440.61279693566;78657.60671196722;80209;10778.514966826511;10948.671539853816;10971;10990.450477476094;11030;22209.111635534722;22214.55570888573;22216.444588885406;22233.777662223496;22247.110115595195;8429.283510901641;8472.788180295418;8523;8564.48613083217;8763.60563774619;4749.335093086902;4766.213574760126;4830.879228019257;4867.148249056472;4868.659193856396;3618.3667858124722;3696.353138200804;3727;3727.794971276606;3733.4586484959527;623.4731651754261;625.271558634186;627.8712863862897;639.6769631336145;645.1677336236296;663.1942190238883;668.4785867023633;670.4234358451728;687.8933765266391;690.3510699942038;11004.614838480615;11525.308481490969;11528.481218345194;11823.054155667525;11968.281903085843;707.8195060259703;726.9345758881726;731.5976213082783;741.3402072155785;854.9615267312986;5221.295125158131;5621.634593751393;5639.802606908738;5668.943310566924;5693.146028095736;63788;64310.67844660747;66862.33137668562;77413;81528.18471815206;58103.70948145232;59843.40156598378;60689.69655151696;62687;65388.67305663441;60082.39917600768;61234;62238;62692;64008.35991640117;11456.770864582495;11649.475773590379;11774.764504709687;11848.28910265387;11894.940525297317;37105.81447092747;39640;42200.36699449449;42616.5738342625;43458.13083738244;49379;52283;52833.47166528286;52920.73539632277;55106.44893551013;12940;13149.145305555108;13271.734565308832;13392;13633.182009079486;15864.206789660702;15887.761683574987;15923.203839808195;16008.359665613245;16351.100689462193;14708.485203017843;14853.405863765329;14854.33155507983;14970.775438368215;15122.470713524974;14750.409983600965;14834.406623734929;15024.474143404928;15105.697886041999;15275.847241527443;14727.92636036813;14738.778918316018;14789.408423662933;14794.408223670933;15169.165695886832;11500.309981401142;11898.19745394099;11917.582884598998;12413.379331033593;12419.565315213924;11466.94266528662;11484.598039068593;11664.88335116638;11774.470148843495;11775.76448471043 08:22:41 INFO - PROCESS | 31392 | __end_tp_report 08:22:41 INFO - PROCESS | 31392 | __start_cc_report 08:22:41 INFO - PROCESS | 31392 | _x_x_mozilla_cycle_collect,312 08:22:41 INFO - PROCESS | 31392 | __end_cc_report 08:22:41 INFO - PROCESS | 31392 | __startTimestamp1486138961852__endTimestamp 08:22:41 INFO - PROCESS | 31392 | 08:22:41 INFO - PROCESS | 31392 | ------- Summary: start ------- 08:22:41 INFO - PROCESS | 31392 | Number of tests: 6 08:22:41 INFO - PROCESS | 31392 | 08:22:41 INFO - PROCESS | 31392 | [#0] dojo.html Cycles:165 Average:5536.53 Median:5782.22 stddev:623.12 (10.8%) stddev-sans-first:599.01 08:22:41 INFO - PROCESS | 31392 | Values: 3265.0 3280.2 3287.2 3301.6 3306.2 5562.7 5587.8 5591.1 5596.4 5612.0 5549.8 5582.1 5624.7 5632.9 5674.2 4994.5 5010.4 5056.3 5096.8 5104.8 4997.6 5052.6 5090.4 5113.4 5139.4 4937.4 4952.0 5084.8 5098.4 5099.6 4964.3 4977.7 4990.7 5056.4 5099.4 4963.6 5023.5 5026.6 5029.9 5038.3 5493.3 5504.6 5579.3 5588.2 5598.7 5789.4 5806.2 5867.6 5870.6 5891.4 6005.2 6019.2 6022.2 6054.8 6073.6 5612.6 5615.9 5620.9 5627.4 5629.9 5882.1 5949.6 5959.9 5996.7 6082.4 5839.8 5879.9 5900.3 5925.3 5927.5 5905.7 5928.1 5975.4 5982.6 5983.1 5752.8 5811.4 5867.1 5950.3 5965.9 5899.5 5980.6 5992.7 6003.7 6027.8 4590.2 4594.7 4610.8 4611.1 4634.1 3999.6 4011.4 4097.4 4103.6 4126.6 5710.4 5722.6 5745.1 5819.6 5853.2 5976.8 6014.2 6027.3 6037.3 6057.2 5512.3 5542.9 5578.5 5830.4 5855.5 5026.4 5030.8 5040.7 5073.9 5094.0 6170.1 6171.6 6181.0 6207.8 6219.4 6040.6 6045.4 6048.6 6064.0 6082.8 5886.3 5924.9 6003.8 6199.6 6260.7 5739.9 5883.2 5902.6 5904.5 5939.3 5960.6 5970.2 5982.9 5994.0 6007.8 5714.9 5755.3 5773.7 5825.3 5852.8 5729.7 5782.2 5794.3 5834.9 5863.8 5825.7 5828.0 5831.6 5836.0 5871.9 5819.4 5839.9 5864.3 5872.5 5890.6 5547.7 5662.5 5688.8 5692.5 5714.7 08:22:41 INFO - PROCESS | 31392 | 08:22:41 INFO - PROCESS | 31392 | [#1] ext.html Cycles:180 Average:60967.89 Median:367502.00 stddev:115994.46 (31.6%) stddev-sans-first:116231.21 08:22:41 INFO - PROCESS | 31392 | Values: 570.4 611.6 641.7 648.6 667.5 46553.0 47795.0 47803.8 53104.5 53171.0 50374.2 51237.0 51300.7 51308.2 51332.5 9278.5 9530.7 10632.6 10934.0 10941.9 10843.9 10934.3 10936.6 10939.2 10941.1 10894.0 10908.2 10944.5 10974.0 11023.0 10720.6 10800.2 10815.6 10873.0 10874.0 10659.9 10731.7 10764.0 10769.0 10818.0 42367.4 42577.4 42642.4 42762.6 42775.8 4311.6 4371.0 4406.3 4471.0 4496.7 31853.8 31975.7 32050.4 32190.7 32572.5 4456.6 4496.8 4666.9 4682.4 4735.1 365417.0 367033.0 367360.0 367644.0 367881.0 62322.0 62612.7 63217.0 63272.7 63404.7 64879.7 65049.7 65172.3 65301.3 65354.0 16583.7 16849.6 17485.2 17510.3 17544.5 13813.1 13844.2 13848.9 14055.9 14143.7 19262.3 19510.7 19524.3 19547.4 19563.8 6894.6 7185.2 7371.2 7407.1 7523.5 1008.2 1008.2 1023.5 1024.8 1028.1 33499.7 33587.7 33669.5 33837.8 34601.0 1087.4 1181.9 1183.6 1204.3 1205.3 17625.9 17786.7 17890.0 17937.9 18163.8 538216.0 539266.0 542576.0 545113.0 546414.0 70357.3 70657.6 70984.0 71119.0 71202.6 1569.7 1582.1 1593.8 1594.8 1601.8 31283.5 31568.0 31635.7 31916.7 32171.0 59477.4 59623.4 60337.4 60377.7 60455.7 382828.0 384094.0 384798.0 386044.0 386303.0 29197.3 29349.1 30177.5 31337.2 31831.2 46620.5 46800.5 46914.3 47451.5 48255.3 38320.8 38805.2 39304.2 39771.6 40588.6 38904.6 39068.2 39495.8 39509.2 39904.8 39783.2 40507.4 40520.6 40566.2 40775.0 32721.3 33488.3 33752.5 33980.8 34045.5 27012.5 27154.9 27221.2 27233.9 27677.0 08:22:41 INFO - PROCESS | 31392 | 08:22:41 INFO - PROCESS | 31392 | [#2] jquery.html Cycles:180 Average:35037.52 Median:440.87 stddev:109658.14 (24872.8%) stddev-sans-first:109934.97 08:22:41 INFO - PROCESS | 31392 | Values: 426.6 433.5 435.8 439.4 442.3 20233.4 21056.0 22153.9 22360.4 22401.9 21699.2 21728.8 21782.7 21866.1 23003.9 6080.9 6276.2 6305.4 6312.7 6334.3 5945.2 6154.2 6164.2 6164.6 6172.8 6011.7 6122.1 6134.8 6138.5 6154.8 6197.4 6283.5 6288.9 6320.1 6328.4 6022.5 6130.4 6169.2 6208.4 6246.2 14572.1 14720.2 14828.4 24172.9 24739.6 2735.8 2781.2 2781.9 2792.6 2818.6 11020.7 11147.6 11754.8 12803.5 14876.7 1992.5 2075.1 2077.1 2084.6 2090.1 76381.0 81086.6 90431.0 97729.0 99732.0 12096.2 12278.3 12528.6 12634.6 12736.7 17690.0 17804.1 17818.9 17886.2 17891.6 7274.1 7276.7 7442.6 8269.0 9524.0 9032.6 9067.8 9069.6 9204.8 9238.7 5279.1 5307.6 5307.8 5320.7 5433.4 2113.9 2174.1 2190.6 2208.8 2210.1 937.3 952.0 952.6 955.4 961.6 19685.4 21205.5 21375.6 21421.7 21605.0 947.5 966.9 971.4 977.6 988.9 11650.7 11717.5 11726.4 11768.7 11786.9 619242.0 643256.0 678331.0 695959.0 700125.0 98292.0 98842.5 98986.5 102379.0 102927.0 962.6 988.5 991.6 994.5 999.8 17503.8 17755.8 17874.6 17968.8 18199.5 42711.6 44468.0 44895.6 45668.5 45724.8 59747.1 62040.7 65769.7 66386.3 67551.0 8944.3 8978.0 9004.0 9107.9 9283.4 13030.6 13177.5 13224.3 13225.6 13580.1 11179.7 11315.5 11407.1 11675.6 11795.9 11086.0 11250.8 11335.6 11376.4 11525.1 10747.4 11326.9 11404.5 11503.2 11991.5 8864.5 8904.9 8958.6 8984.5 9225.0 8832.0 10885.2 11457.4 11620.1 11777.5 08:22:41 INFO - PROCESS | 31392 | 08:22:41 INFO - PROCESS | 31392 | [#3] mootools.html Cycles:180 Average:5444.22 Median:5137.92 stddev:2942.04 (57.3%) stddev-sans-first:2934.92 08:22:41 INFO - PROCESS | 31392 | Values: 1442.0 1472.9 1477.6 1484.3 1489.6 7560.8 7734.0 8025.8 8530.0 8554.4 7980.6 8152.6 8164.1 8379.9 8391.4 2372.0 2389.6 2392.4 2396.6 2407.2 2333.1 2367.3 2380.3 2382.3 2390.2 2315.1 2318.6 2326.3 2327.4 2352.2 2269.6 2275.8 2312.0 2321.5 2326.2 2273.8 2308.0 2319.5 2328.6 2330.4 8307.2 8351.6 8370.3 8379.9 8391.5 4956.5 5016.6 5161.4 5187.3 5221.4 3167.0 3228.2 3264.6 3286.8 3311.2 1304.2 1306.9 1312.4 1321.8 1340.1 11225.5 11255.6 11273.6 11331.5 11352.1 4264.0 4501.0 4505.3 4581.6 4645.5 9814.4 9864.0 9874.4 9881.5 9897.0 5115.1 5160.8 5174.2 5186.5 5205.9 4716.2 4769.8 4839.3 4898.9 4961.3 3567.1 3641.7 3676.2 3705.3 3722.2 987.3 1000.5 1021.5 1032.1 1044.4 992.4 1006.5 1015.2 1023.2 1031.7 5567.0 5727.5 5744.9 5850.9 5950.0 1021.3 1044.6 1061.9 1062.9 1103.2 3859.4 3885.3 3929.9 3934.6 3971.7 9137.2 9360.6 9398.0 9412.8 9415.8 9255.2 9262.6 9296.0 9327.8 9340.2 7556.4 7824.5 7865.6 7888.0 7915.4 5800.4 5859.2 5911.2 5962.4 6030.5 8885.9 8947.2 8955.6 9081.5 9195.1 9094.7 9155.8 9269.1 9281.3 9289.6 7238.8 7342.7 7385.7 7434.0 7486.5 8240.4 8313.8 8318.6 8321.5 8326.2 7165.8 7219.7 7229.6 7335.0 7389.6 6745.1 6848.1 6873.2 6899.3 7114.1 6101.1 6157.6 6187.9 6227.3 6271.6 4787.0 4794.8 4795.3 4861.2 4891.0 4851.9 4867.6 4965.0 4983.8 4992.5 08:22:41 INFO - PROCESS | 31392 | 08:22:41 INFO - PROCESS | 31392 | [#4] prototype.html Cycles:180 Average:4813.49 Median:5536.71 stddev:1412.89 (25.5%) stddev-sans-first:1377.18 08:22:41 INFO - PROCESS | 31392 | Values: 383.9 388.6 388.7 393.6 395.5 5430.4 5579.8 5582.9 5634.3 5688.3 5438.6 5463.2 5486.9 5487.1 5518.5 4224.6 4265.8 4266.2 4280.3 4291.5 4010.4 4162.2 4233.6 4255.2 4268.7 4166.6 4166.9 4182.5 4189.8 4193.7 4157.3 4187.2 4195.6 4219.8 4231.6 3697.9 3715.9 3724.9 3730.9 3741.5 5134.8 5264.4 5275.7 5299.3 5333.5 4847.0 4865.6 4881.4 4895.2 4909.0 5459.7 5660.8 5676.5 5676.9 5681.1 4079.8 4085.7 4090.0 4103.3 4110.1 5919.3 5978.5 5991.7 6007.5 6030.3 4258.3 4270.8 4283.9 4288.3 4313.4 4154.1 4283.2 4286.2 4311.7 4312.1 4864.0 4864.8 4885.7 4913.9 4930.8 5626.6 5747.3 5786.0 5794.6 5811.6 1414.3 1418.1 1419.5 1425.8 1426.5 957.7 978.9 983.8 994.7 1003.4 5399.2 5466.8 5489.0 5506.0 5514.4 5741.9 5756.8 5759.1 5776.5 5853.7 5351.9 5533.5 5539.9 5565.5 5582.9 3031.5 3071.3 3077.2 3088.8 3102.9 5683.4 5803.8 5916.6 5967.7 5989.6 5840.3 5843.7 5853.7 5854.7 5898.8 5811.8 5829.8 5851.2 5859.5 5934.9 5599.0 5692.9 5714.9 5876.4 5914.5 5798.8 5826.4 5834.8 5841.9 5846.2 5889.6 6061.8 6158.4 6163.0 6166.8 4063.2 4089.3 4160.9 4164.3 4169.5 5892.9 5894.0 5904.6 5926.7 5948.6 5740.7 5744.7 5774.8 5820.3 5822.2 5607.9 5714.9 5740.5 5751.7 5754.3 5736.7 5757.7 5768.9 5778.3 5778.7 5481.5 5750.8 5797.4 5797.6 5824.5 5640.4 5686.8 5700.3 5701.5 5719.9 08:22:41 INFO - PROCESS | 31392 | 08:22:41 INFO - PROCESS | 31392 | [#5] yui.html Cycles:180 Average:17441.91 Median:4119.27 stddev:21007.21 (510.0%) stddev-sans-first:21028.46 08:22:41 INFO - PROCESS | 31392 | Values: 684.6 689.5 744.5 803.2 825.8 15695.6 16937.6 16975.2 16986.9 17041.8 16284.0 16390.2 16548.2 16583.0 17286.7 802.3 825.1 825.3 827.3 830.5 796.0 796.7 798.2 800.0 800.5 847.2 849.9 853.8 854.0 854.3 845.5 845.7 848.2 849.9 852.4 616.5 618.8 619.3 619.7 621.8 15398.2 15461.1 15463.3 15737.1 16063.1 13620.7 13621.7 13626.4 13646.7 13667.1 12100.6 12104.6 12177.2 12297.9 12419.7 3985.9 4011.3 4039.2 4115.8 4122.8 75948.4 76760.6 77440.6 78657.6 80209.0 10778.5 10948.7 10971.0 10990.5 11030.0 22209.1 22214.6 22216.4 22233.8 22247.1 8429.3 8472.8 8523.0 8564.5 8763.6 4749.3 4766.2 4830.9 4867.1 4868.7 3618.4 3696.4 3727.0 3727.8 3733.5 623.5 625.3 627.9 639.7 645.2 663.2 668.5 670.4 687.9 690.4 11004.6 11525.3 11528.5 11823.1 11968.3 707.8 726.9 731.6 741.3 855.0 5221.3 5621.6 5639.8 5668.9 5693.1 63788.0 64310.7 66862.3 77413.0 81528.2 58103.7 59843.4 60689.7 62687.0 65388.7 60082.4 61234.0 62238.0 62692.0 64008.4 11456.8 11649.5 11774.8 11848.3 11894.9 37105.8 39640.0 42200.4 42616.6 43458.1 49379.0 52283.0 52833.5 52920.7 55106.4 12940.0 13149.1 13271.7 13392.0 13633.2 15864.2 15887.8 15923.2 16008.4 16351.1 14708.5 14853.4 14854.3 14970.8 15122.5 14750.4 14834.4 15024.5 15105.7 15275.8 14727.9 14738.8 14789.4 14794.4 15169.2 11500.3 11898.2 11917.6 12413.4 12419.6 11466.9 11484.6 11664.9 11774.5 11775.8 08:22:41 INFO - PROCESS | 31392 | -------- Summary: end -------- 08:22:41 INFO - PROCESS | 31392 | 08:22:42 INFO - TEST-INFO | 31392: exit 0 08:22:42 INFO - TEST-OK | dromaeo_css | took 1112165ms 08:22:42 INFO - TEST-START | kraken 08:22:42 INFO - operating with platform_type : linux_ 08:22:42 INFO - Initialising browser for kraken test... 08:22:42 INFO - TEST-INFO | started process 31762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_x6KYn/profile http://localhost:33881/getInfo.html) 08:22:47 INFO - PROCESS | 31762 | __metrics Screen width/height:1600/1200 08:22:47 INFO - PROCESS | 31762 | colorDepth:24 08:22:47 INFO - PROCESS | 31762 | Browser inner width/height: 1024/697 08:22:47 INFO - PROCESS | 31762 | __metrics 08:22:47 INFO - PROCESS | 31762 | 1486138967896 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) 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:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmp_x6KYn/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp_x6KYn/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp_x6KYn/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp_x6KYn/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:22:47 ERROR - PROCESS | 31762 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:22:48 INFO - TEST-INFO | 31762: exit 0 08:22:48 INFO - Browser initialized. 08:22:48 INFO - Running cycle 1/1 for kraken test... 08:22:48 INFO - TEST-INFO | started process 31888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_x6KYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:00 INFO - PROCESS | 31888 | RSS: Main: 145039360 08:23:00 INFO - PROCESS | 31888 | 08:23:03 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33881/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:04 INFO - PROCESS | 31888 | RSS: Main: 151785472 08:23:04 INFO - PROCESS | 31888 | 08:23:06 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33881/tests/kraken/driver.html?testName=audio-dft) 08:23:07 INFO - PROCESS | 31888 | RSS: Main: 150085632 08:23:07 INFO - PROCESS | 31888 | 08:23:10 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33881/tests/kraken/driver.html?testName=audio-fft) 08:23:10 INFO - PROCESS | 31888 | RSS: Main: 151175168 08:23:10 INFO - PROCESS | 31888 | 08:23:12 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33881/tests/kraken/driver.html?testName=audio-oscillator) 08:23:13 INFO - PROCESS | 31888 | RSS: Main: 150286336 08:23:13 INFO - PROCESS | 31888 | 08:23:15 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:16 INFO - PROCESS | 31888 | RSS: Main: 150298624 08:23:16 INFO - PROCESS | 31888 | 08:23:19 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33881/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:19 INFO - PROCESS | 31888 | RSS: Main: 153190400 08:23:19 INFO - PROCESS | 31888 | 08:23:23 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33881/tests/kraken/driver.html?testName=imaging-desaturate) 08:23:23 INFO - PROCESS | 31888 | RSS: Main: 153673728 08:23:23 INFO - PROCESS | 31888 | 08:23:26 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33881/tests/kraken/driver.html?testName=json-parse-financial) 08:23:27 INFO - PROCESS | 31888 | RSS: Main: 152616960 08:23:27 INFO - PROCESS | 31888 | 08:23:28 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:23:29 INFO - PROCESS | 31888 | RSS: Main: 152072192 08:23:29 INFO - PROCESS | 31888 | 08:23:31 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33881/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:23:31 INFO - PROCESS | 31888 | RSS: Main: 152326144 08:23:31 INFO - PROCESS | 31888 | 08:23:33 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:23:34 INFO - PROCESS | 31888 | RSS: Main: 152465408 08:23:34 INFO - PROCESS | 31888 | 08:23:37 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:23:37 INFO - PROCESS | 31888 | RSS: Main: 152289280 08:23:37 INFO - PROCESS | 31888 | 08:23:40 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:23:41 INFO - PROCESS | 31888 | RSS: Main: 152915968 08:23:41 INFO - PROCESS | 31888 | 08:23:42 INFO - PROCESS | 31888 | Cycle 1(1): loaded http://localhost:33881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33881/tests/kraken/driver.html?testName=ai-astar) 08:23:43 INFO - PROCESS | 31888 | RSS: Main: 154685440 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | __start_tp_report 08:23:43 INFO - PROCESS | 31888 | _x_x_mozilla_page_load 08:23:43 INFO - PROCESS | 31888 | _x_x_mozilla_page_load_details 08:23:43 INFO - PROCESS | 31888 | |i|pagename|runs| 08:23:43 INFO - PROCESS | 31888 | |0;ai-astar;105;114;113;113;114;114;114;113;112;114 08:23:43 INFO - PROCESS | 31888 | |1;audio-beat-detection;145;126;123;162;127;124;123;121;140;123 08:23:43 INFO - PROCESS | 31888 | |2;audio-dft;162;163;165;164;164;162;162;161;167;162 08:23:43 INFO - PROCESS | 31888 | |3;audio-fft;76;76;76;112;79;76;78;74;97;76 08:23:43 INFO - PROCESS | 31888 | |4;audio-oscillator;83;83;104;82;85;84;105;82;85;115 08:23:43 INFO - PROCESS | 31888 | |5;imaging-gaussian-blur;117;118;118;117;117;117;119;118;125;118 08:23:43 INFO - PROCESS | 31888 | |6;imaging-darkroom;150;149;150;148;149;149;149;149;148;148 08:23:43 INFO - PROCESS | 31888 | |7;imaging-desaturate;97;97;96;96;96;97;96;97;97;101 08:23:43 INFO - PROCESS | 31888 | |8;json-parse-financial;55;57;55;54;55;56;55;55;55;59 08:23:43 INFO - PROCESS | 31888 | |9;json-stringify-tinderbox;65;65;64;65;68;64;64;64;65;66 08:23:43 INFO - PROCESS | 31888 | |10;stanford-crypto-aes;79;81;77;76;82;76;76;77;76;77 08:23:43 INFO - PROCESS | 31888 | |11;stanford-crypto-ccm;136;130;125;121;120;119;129;129;165;123 08:23:43 INFO - PROCESS | 31888 | |12;stanford-crypto-pbkdf2;160;154;153;160;166;155;157;159;155;158 08:23:43 INFO - PROCESS | 31888 | |13;stanford-crypto-sha256-iterative;64;66;62;63;62;62;60;60;60;61 08:23:43 INFO - PROCESS | 31888 | __end_tp_report 08:23:43 INFO - PROCESS | 31888 | __start_cc_report 08:23:43 INFO - PROCESS | 31888 | _x_x_mozilla_cycle_collect,713 08:23:43 INFO - PROCESS | 31888 | __end_cc_report 08:23:43 INFO - PROCESS | 31888 | __startTimestamp1486139023008__endTimestamp 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | ------- Summary: start ------- 08:23:43 INFO - PROCESS | 31888 | Number of tests: 14 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:2.76 (2.4%) stddev-sans-first:0.73 08:23:43 INFO - PROCESS | 31888 | Values: 105.0 114.0 113.0 113.0 114.0 114.0 114.0 113.0 112.0 114.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:126.50 stddev:13.41 (10.6%) stddev-sans-first:13.29 08:23:43 INFO - PROCESS | 31888 | Values: 145.0 126.0 123.0 162.0 127.0 124.0 123.0 121.0 140.0 123.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.81 (1.1%) stddev-sans-first:1.87 08:23:43 INFO - PROCESS | 31888 | Values: 162.0 163.0 165.0 164.0 164.0 162.0 162.0 161.0 167.0 162.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.45 (16.4%) stddev-sans-first:13.01 08:23:43 INFO - PROCESS | 31888 | Values: 76.0 76.0 76.0 112.0 79.0 76.0 78.0 74.0 97.0 76.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:83.00 stddev:12.25 (14.8%) stddev-sans-first:12.67 08:23:43 INFO - PROCESS | 31888 | Values: 83.0 83.0 104.0 82.0 85.0 84.0 105.0 82.0 85.0 115.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:2.41 (2.0%) stddev-sans-first:2.51 08:23:43 INFO - PROCESS | 31888 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 119.0 118.0 125.0 118.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 08:23:43 INFO - PROCESS | 31888 | Values: 150.0 149.0 150.0 148.0 149.0 149.0 149.0 149.0 148.0 148.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:1.49 (1.5%) stddev-sans-first:1.58 08:23:43 INFO - PROCESS | 31888 | Values: 97.0 97.0 96.0 96.0 96.0 97.0 96.0 97.0 97.0 101.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:1.43 (2.6%) stddev-sans-first:1.50 08:23:43 INFO - PROCESS | 31888 | Values: 55.0 57.0 55.0 54.0 55.0 56.0 55.0 55.0 55.0 59.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 08:23:43 INFO - PROCESS | 31888 | Values: 65.0 65.0 64.0 65.0 68.0 64.0 64.0 64.0 65.0 66.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.00 stddev:2.21 (2.9%) stddev-sans-first:2.30 08:23:43 INFO - PROCESS | 31888 | Values: 79.0 81.0 77.0 76.0 82.0 76.0 76.0 77.0 76.0 77.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:129.00 stddev:13.49 (10.5%) stddev-sans-first:14.12 08:23:43 INFO - PROCESS | 31888 | Values: 136.0 130.0 125.0 121.0 120.0 119.0 129.0 129.0 165.0 123.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.50 stddev:3.83 (2.4%) stddev-sans-first:3.97 08:23:43 INFO - PROCESS | 31888 | Values: 160.0 154.0 153.0 160.0 166.0 155.0 157.0 159.0 155.0 158.0 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - PROCESS | 31888 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.94 (3.1%) stddev-sans-first:1.92 08:23:43 INFO - PROCESS | 31888 | Values: 64.0 66.0 62.0 63.0 62.0 62.0 60.0 60.0 60.0 61.0 08:23:43 INFO - PROCESS | 31888 | -------- Summary: end -------- 08:23:43 INFO - PROCESS | 31888 | 08:23:43 INFO - TEST-INFO | 31888: exit 0 08:23:44 INFO - TEST-OK | kraken | took 61448ms 08:23:44 INFO - SUITE-END | took 1173s 08:23:44 INFO - Completed test suite (00:19:33) 08:23:44 INFO - javascript benchmark 08:23:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7431.437765942972, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3264.9510257346137, 3280.2291461506543, 3287.161773747694, 3301.603807543095, 3306.173456635841, 5562.694051827153, 5587.7764889404425, 5591.1054231323, 5596.356419011805, 5611.971940140304, 5549.77800887964, 5582.051051321275, 5624.662520248788, 5632.915506267409, 5674.233978412913, 4994.525520075596, 5010.423801262847, 5056.3173971513925, 5096.779015021295, 5104.846854594368, 4997.625178111638, 5052.646314757969, 5090.440051594322, 5113.437521872591, 5139.383274007125, 4937.382827146606, 4952.0, 5084.79660813567, 5098.439171691111, 5099.592032637399, 4964.255361695738, 4977.7262250576205, 4990.725510096943, 5056.367954005749, 5099.4390617032095, 4963.60291176705, 5023.522765337287, 5026.648134630577, 5029.949700503022, 5038.3198268234055, 5493.340799104093, 5504.614676972614, 5579.330480342385, 5588.245586845765, 5598.664080155204, 5789.363170051291, 5806.245188125559, 5867.647941123503, 5870.589058765888, 5891.3814049525035, 6005.219321488178, 6019.187409699678, 6022.2171117754415, 6054.848628784272, 6073.635581865058, 5612.635178713412, 5615.915761263625, 5620.887582248332, 5627.380988091307, 5629.915551266734, 5882.088276317178, 5949.613275137102, 5959.940400595939, 5996.730147143389, 6082.391760823883, 5839.766409343663, 5879.941200587939, 5900.291964964232, 5925.318588362307, 5927.4665280125, 5905.704714764244, 5928.110783382527, 5975.43233392827, 5982.611130276518, 5983.072623743326, 5752.827415177551, 5811.4479124483105, 5867.119932010147, 5950.285965684146, 5965.850853728692, 5899.46904778572, 5980.5514586405325, 5992.730327135202, 6003.699815009232, 6027.819165425044, 4590.196715574828, 4594.6783725139585, 4610.815567377334, 4611.146937816515, 4634.073185362941, 3999.560048394674, 4011.3782363733667, 4097.364908439196, 4103.630673239423, 4126.566710495415, 5710.371859095496, 5722.62802917809, 5745.080787074048, 5819.563532735062, 5853.209816674695, 5976.7908123215475, 6014.248218972629, 6027.306859711101, 6037.305709843336, 6057.151998720183, 5512.2558454608115, 5542.944570554324, 5578.497935185853, 5830.387809279964, 5855.502282305966, 5026.447090820006, 5030.798768049311, 5040.672356296829, 5073.898522029613, 5094.032133894622, 6170.136180934673, 6171.5988460750805, 6181.041938499539, 6207.751689932443, 6219.40915613016, 6040.607360521552, 6045.357585039243, 6048.606840555526, 6063.969680151571, 6082.847928801815, 5886.323072846678, 5924.881502369843, 6003.7898673546215, 6199.56603037783, 6260.74957001733, 5739.8565035874435, 5883.176355310346, 5902.61632993854, 5904.498117660047, 5939.287285525765, 5960.5827592068135, 5970.223870896755, 5982.910256346246, 5993.951058564821, 6007.8197654070445, 5714.885702286014, 5755.251817263729, 5773.711314434346, 5825.330087039875, 5852.824415267379, 5729.742161602821, 5782.219400381063, 5794.333651630117, 5834.883302334015, 5863.824085277449, 5825.679587622722, 5828.0, 5831.562632802642, 5835.9708201458725, 5871.94128058714, 5819.447152520504, 5839.8832023358445, 5864.296284445893, 5872.5301975842685, 5890.587658863838, 5547.694876781654, 5662.5469962402085, 5688.800891968761, 5692.516136128475, 5714.685692286964], "value": 5495.2302697641035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4039278953493, 611.5627326461579, 641.653507106163, 648.6270394523148, 667.529391778796, 46553.0, 47795.0, 47803.76098119513, 53104.46895531043, 53171.0, 50374.244386334234, 51237.0, 51300.74349628256, 51308.23037654438, 51332.48667513324, 9278.53607319633, 9530.714078577654, 10632.57469701211, 10934.0, 10941.945290273577, 10843.945780271088, 10934.343939363624, 10936.56253749849, 10939.179561532877, 10941.12471002318, 10894.0, 10908.181886358516, 10944.45277736114, 10974.0, 11023.0, 10720.624778132767, 10800.243982921198, 10815.621453249178, 10873.0, 10874.0, 10659.94670026645, 10731.731706707316, 10764.0, 10769.0, 10818.02637762605, 42367.36448953268, 42577.36133957993, 42642.360364594555, 42762.57237427617, 42775.786121069505, 4311.558338846297, 4370.978145109286, 4406.294992801137, 4471.038726673781, 4496.685232033759, 31853.840730796197, 31975.6802431975, 32050.358992820245, 32190.74378360143, 32572.511412328833, 4456.598906098434, 4496.79764410599, 4666.883327916796, 4682.367880336145, 4735.076660051292, 365417.0, 367033.0, 367360.0, 367644.0, 367881.0, 62322.0, 62612.68693656594, 63217.0, 63272.683636581525, 63404.68297658575, 64879.67560162169, 65049.67475162689, 65172.348276516626, 65301.34698653048, 65354.0, 16583.6683266334, 16849.578760531083, 17485.21316540733, 17510.29958801659, 17544.473665790047, 13813.102148360324, 13844.238566878717, 13848.930755346159, 14055.859441405659, 14143.71712565743, 19262.32581859656, 19510.70733938992, 19524.31947799672, 19547.413577592695, 19563.80436195648, 6894.551854129566, 7185.173705023884, 7371.226021267689, 7407.148177959603, 7523.510971786816, 1008.2035192198082, 1008.2135933971514, 1023.5036007536339, 1024.800163968019, 1028.1209565821264, 33499.66500335014, 33587.66412335894, 33669.494957575655, 33837.830810845786, 34600.9619711404, 1087.3530249501534, 1181.8995385392166, 1183.6153250193722, 1204.2954871400154, 1205.2888795610631, 17625.91187044082, 17786.733199002025, 17890.0, 17937.910310448366, 18163.818361816477, 538216.0, 539266.0, 542576.0, 545113.0, 546414.0, 70357.2964270361, 70657.64671176611, 70984.0, 71119.0, 71202.64398678076, 1569.7488401855649, 1582.1298285942685, 1593.7768712380275, 1594.8405159484191, 1601.7677436771603, 31283.53074703927, 31568.0, 31635.683643163273, 31916.68083319137, 32171.0, 59477.40522594892, 59623.40376596178, 60337.39662603493, 60377.69811150916, 60455.69772151111, 382828.0, 384094.0, 384798.0, 386044.0, 386303.0, 29197.270068248465, 29349.11952641424, 30177.54733678953, 31337.216569585944, 31831.204219894687, 46620.53379466297, 46800.531994679615, 46914.296285556426, 47451.52548474609, 48255.27617085817, 38320.80839595896, 38805.2238955225, 39304.21391572095, 39771.60228397679, 40588.594114058484, 38904.6109538901, 39068.218635627694, 39495.81086933873, 39509.2098158041, 39904.800475997436, 39783.204335913695, 40507.3923891136, 40520.594794052864, 40566.1886762269, 40775.0, 32721.34557308888, 33488.33023339568, 33752.49371259482, 33980.83009585035, 34045.48931766075, 27012.45975080448, 27154.864225679536, 27221.1833644991, 27233.86383068072, 27677.0], "value": 21458.188746255964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.6437524666903, 433.5022497271926, 435.78646463233014, 439.41996564534804, 442.3298702465765, 20233.39299821006, 21056.0, 22153.889230553825, 22360.440988975282, 22401.887990560066, 21699.240526581572, 21728.782712172913, 21782.673259901116, 21866.125354985783, 23003.884980575116, 6080.908786368197, 6276.184096067527, 6305.432511074003, 6312.652804095773, 6334.271558770732, 5945.197398351233, 6154.230721159855, 6164.229471316085, 6164.630122192661, 6172.783952561661, 6011.729472173763, 6122.142899994004, 6134.846628834271, 6138.539609529281, 6154.784582539612, 6197.442230199281, 6283.528735344822, 6288.874222515524, 6320.051992201161, 6328.367163283658, 6022.5483088768515, 6130.386961303834, 6169.198004259462, 6208.410201030895, 6246.187995560594, 14572.12567245958, 14720.190389528572, 14828.406863725439, 24172.879135604384, 24739.62890556643, 2735.8221715588425, 2781.193453898367, 2781.916542503728, 2792.6229958955482, 2818.619486369355, 11020.724481887937, 11147.554097836077, 11754.764904701944, 12803.48786048557, 14876.70246595062, 1992.5417154054649, 2075.0869617368307, 2077.106844057055, 2084.5830833833293, 2090.080364639554, 76381.0, 81086.59456702678, 90431.0, 97729.0, 99732.0, 12096.153269271066, 12278.324692142018, 12528.561500347445, 12634.620961371174, 12736.681582960315, 17690.0, 17804.10979451048, 17818.91090544539, 17886.195121219578, 17891.642167156584, 7274.1267199455915, 7276.745313913988, 7442.627868606548, 8268.9663792026, 9523.952380238054, 9032.63869445228, 9067.773305667411, 9069.637214511346, 9204.815903681889, 9238.676646317346, 5279.1289437243195, 5307.575393968474, 5307.787688492417, 5320.733963301819, 5433.429489903503, 2113.9471513211984, 2174.119386730467, 2190.638544640148, 2208.7901649343285, 2210.082815631495, 937.315759495572, 952.0194199974038, 952.590386133969, 955.350361754014, 961.5721004153085, 19685.40943771689, 21205.469863253544, 21375.57248855014, 21421.666816147943, 21605.02777375022, 947.4836214263244, 966.8888077871135, 971.4462756228882, 977.5600979559226, 988.945607991553, 11650.708732281591, 11717.531298747954, 11726.41367931617, 11768.70578235551, 11786.88213117875, 619242.0, 643256.0, 678331.0, 695959.0, 700125.0, 98292.0, 98842.5057874706, 98986.50506747421, 102379.0, 102927.02845362504, 962.6438217859297, 988.5205675247499, 991.5785791038924, 994.5275993902839, 999.7750506136061, 17503.82496175022, 17755.822441775417, 17874.5531361717, 17968.820311796713, 18199.45401637953, 42711.57288427076, 44468.0, 44895.55104449044, 45668.54331456643, 45724.771376142904, 59747.103793444, 62040.689796552535, 65769.67115164394, 66386.3123465262, 67551.0, 8944.284457243535, 8977.955110224408, 9003.954980225057, 9107.908920910706, 9283.442993420416, 13030.609081727564, 13177.47290108385, 13224.272665003517, 13225.603231903058, 13580.117292375964, 11179.72050698739, 11315.547378104784, 11407.144464165054, 11675.64973050776, 11795.941020294844, 11086.0, 11250.831237531607, 11335.603253886075, 11376.431178441211, 11525.135614828754, 10747.408892510986, 11326.886731132912, 11404.543818247177, 11503.194776365573, 11991.460384282555, 8864.46520457606, 8904.910950890668, 8958.596863141305, 8984.505852177932, 9225.0, 8832.028476867668, 10885.23803333759, 11457.369844658624, 11620.128490363088, 11777.470013849226], "value": 9839.92480847975, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.9927900360497, 1472.9189894555798, 1477.5641185850172, 1484.2875419798504, 1489.5754709907676, 7560.810979725509, 7734.0, 8025.759227223178, 8529.957350213248, 8554.358423118269, 7980.600969951508, 8152.5516096614665, 8164.142765009663, 8379.874301885477, 8391.412601117925, 2371.95256094878, 2389.569877422063, 2392.4018995251186, 2396.6405039244164, 2407.217654262363, 2333.0784340185614, 2367.2898130560848, 2380.297812145421, 2382.344855164835, 2390.199283240108, 2315.073970411832, 2318.6058370077044, 2326.3486223857262, 2327.3948773318975, 2352.2358231326507, 2269.5914735347633, 2275.8065564427043, 2311.9653205201766, 2321.512482378694, 2326.2323433267065, 2273.8408311418207, 2308.0075567505965, 2319.5360927814336, 2328.6041372966465, 2330.382448651109, 8307.169283071706, 8351.582420878993, 8370.3303735701, 8379.874301885477, 8391.454555453876, 4956.479569645171, 5016.648834581581, 5161.4322424533275, 5187.299714538527, 5221.425643179247, 3167.0, 3228.176814912206, 3264.6245681746664, 3286.7699261051735, 3311.1887587540964, 1304.2370213425158, 1306.8954483641287, 1312.4356526693614, 1321.8479874814423, 1340.1021315718492, 11225.494852731646, 11255.60605378816, 11273.605423810128, 11331.546738130464, 11352.091832653368, 4264.0, 4500.954990450119, 4505.346724724896, 4581.587657110876, 4645.5354464553275, 9814.411135331902, 9864.013598640078, 9874.358166719141, 9881.456519891331, 9897.0, 5115.0792857285305, 5160.767765450564, 5174.172132458789, 5186.507281808297, 5205.869853253699, 4716.245400735935, 4769.785359658824, 4839.322494850724, 4898.90202195954, 4961.280614310905, 3567.126054116758, 3641.690456311243, 3676.1544844685873, 3705.3330400527625, 3722.1625134344554, 987.3434166279344, 1000.494750151169, 1021.5300961557618, 1032.0866033560353, 1044.4360045575456, 992.374803873555, 1006.5319626373771, 1015.1777060580805, 1023.2070145637042, 1031.6853359725205, 5566.972165139148, 5727.541796656257, 5744.913826292609, 5850.9414905851245, 5950.0, 1021.2953062386929, 1044.587387981743, 1061.877884043345, 1062.8512008318842, 1103.2387652519897, 3859.4017927221325, 3885.2812229737588, 3929.941050884182, 3934.6458818706456, 3971.6624086952934, 9137.223336016381, 9360.62557497706, 9397.953010235042, 9412.764680883032, 9415.811683766286, 9255.213306868856, 9262.629494820132, 9295.953520232355, 9327.813443731224, 9340.159385655325, 7556.395488360918, 7824.452288339876, 7865.567393793282, 7887.9605601971625, 7915.366770658448, 5800.39095894925, 5859.179714840011, 5911.201987731602, 5962.403759624003, 6030.4572588467245, 8885.911140888767, 8947.19475247231, 8955.59699813523, 9081.500517471603, 9195.080491950752, 9094.681686140953, 9155.816883662157, 9269.073092690676, 9281.303902207497, 9289.62841486333, 7238.819029524304, 7342.669579869025, 7385.741499047507, 7434.0, 7486.475946683898, 8240.381971352292, 8313.833723325379, 8318.62566184511, 8321.500709957421, 8326.167383261625, 7165.820854478679, 7219.6751146199595, 7229.638518074181, 7335.0, 7389.630518474162, 6745.089412929192, 6848.075509806312, 6873.175218973755, 6899.275576064641, 7114.1463024435325, 6101.084837274267, 6157.599756015845, 6187.938120618736, 6227.314995350598, 6271.592346497463, 4786.95213047865, 4794.808207671654, 4795.328653988375, 4861.1979023460735, 4891.021795640815, 4851.902961940671, 4867.5862551682085, 4965.0, 4983.775730092082, 4992.500749925124], "value": 4447.4680477587835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9116105839944, 388.63468339760624, 388.74537178148313, 393.5867339293741, 395.49969288849627, 5430.3755068167075, 5579.832605021846, 5582.9441705582985, 5634.323696244282, 5688.288963879515, 5438.592105592076, 5463.153211252253, 5486.890262194754, 5487.149491828773, 5518.475744804237, 4224.556421575744, 4265.765382903939, 4266.189424009428, 4280.336547835091, 4291.527931927485, 4010.358342665174, 4162.229987452316, 4233.618974292313, 4255.17024180285, 4268.743875367472, 4166.625003749662, 4166.8749937501925, 4182.4562806835065, 4189.832406703728, 4193.664506839461, 4157.3140431828715, 4187.246295666779, 4195.622393984556, 4219.831206751726, 4231.61915427613, 3697.85208591656, 3715.925681486382, 3724.8510059597857, 3730.9253814923823, 3741.494898188737, 5134.8202812901745, 5264.368275806928, 5275.709835959021, 5299.258103865462, 5333.466653334674, 4847.006363695434, 4865.562099411035, 4881.388457175394, 4895.2167653175675, 4908.950910490885, 5459.672419654833, 5660.830175094754, 5676.460736230051, 5676.858078548028, 5681.147827825818, 4079.7960101995077, 4085.6935729820384, 4089.9591004090175, 4103.281925663027, 4110.136871257039, 5919.3192782829665, 5978.461938425519, 5991.693198118712, 6007.506884642868, 6030.33666296707, 4258.276093064186, 4270.786460677016, 4283.850065247701, 4288.270993931039, 4313.352997050468, 4154.065335299594, 4283.20760659279, 4286.207051695446, 4311.698181127291, 4312.072904325585, 4863.95136048635, 4864.829730959399, 4885.706857588556, 4913.852584422473, 4930.767308172957, 5626.649604094988, 5747.25285712863, 5786.003828679099, 5794.565407594448, 5811.605214748514, 1414.335262426658, 1418.14202407544, 1419.5457453614745, 1425.7647488164337, 1426.4579459805207, 957.707899090784, 978.8874279457812, 983.7786498037884, 994.6866736977829, 1003.3628645809817, 5399.244105825188, 5466.753996070186, 5489.0, 5506.03644362243, 5514.393416724157, 5741.8564535886935, 5756.827295181151, 5759.107338362477, 5776.451237132465, 5853.7365818538265, 5351.902859913786, 5533.474319939599, 5539.944600553943, 5565.526930210977, 5582.944170558242, 3031.545268209786, 3071.262896904727, 3077.2153100959113, 3088.7953698057777, 3102.860371283298, 5683.374828768832, 5803.767849286066, 5916.5504451408815, 5967.671778052162, 5989.55078369124, 5840.269966254218, 5843.678597677083, 5853.678047707332, 5854.677992710442, 5898.764049437975, 5811.767529298865, 5829.775747093158, 5851.180834683063, 5859.472647461749, 5934.851628709231, 5599.040335882409, 5692.8576785579035, 5714.885702285847, 5876.412358764261, 5914.467697907209, 5798.797042103506, 5826.359100498857, 5834.795782147605, 5841.948449279171, 5846.210761547307, 5889.61223888206, 6061.848453788691, 6158.353372895961, 6163.0, 6166.784162554289, 4063.227986682521, 4089.2843752342624, 4160.937585936153, 4164.292070347988, 4169.541350451387, 5892.908017653843, 5893.970530147321, 5904.557158213065, 5926.67403292823, 5948.5538584605465, 5740.741666625096, 5744.741486633028, 5774.797882074107, 5820.30156381237, 5822.243108395882, 5607.943920560905, 5714.857128571819, 5740.540756739534, 5751.654900705971, 5754.309482861916, 5736.6558006519745, 5757.683327417032, 5768.942310577008, 5778.27771528559, 5778.653280803165, 5481.479259470344, 5750.7987220447085, 5797.420257974169, 5797.579592999742, 5824.475797178275, 5640.4077571856005, 5686.829395118153, 5700.3444603871085, 5701.515371193495, 5719.8856022880145], "value": 4375.138494139316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.5858255755268, 689.4553302890716, 744.4677055905026, 803.2489622203241, 825.8265764189518, 15695.60760980976, 16937.576560585992, 16975.15124243789, 16986.915065424688, 17041.82958170418, 16284.022958622461, 16390.180490975432, 16548.172591370414, 16583.005019698798, 17286.654266914684, 802.2619190344882, 825.0676735289145, 825.2655136928139, 827.2926647716206, 830.5182993863575, 796.024869534821, 796.7370767646663, 798.2297083314601, 800.0199755299741, 800.5236884053978, 847.2417186617973, 849.9405041647087, 853.7822855171922, 853.9573021348939, 854.2909385210261, 845.5053793530792, 845.6913226672251, 848.1603212819296, 849.9362547808877, 852.3947996922193, 616.5314361085562, 618.7865186510646, 619.3280290884396, 619.6994457688018, 621.8352136683783, 15398.230088495531, 15461.149636769973, 15463.304151313105, 15737.055776653437, 16063.116528590923, 13620.659483512893, 13621.727565448635, 13626.386812593359, 13646.727065458734, 13667.111637743516, 12100.577262440118, 12104.576339828063, 12177.208481448766, 12297.93851030748, 12419.689507762378, 3985.880423587297, 4011.2779699654343, 4039.171969746195, 4115.753054816691, 4122.793860306972, 75948.43388857879, 76760.61619691867, 77440.61279693566, 78657.60671196722, 80209.0, 10778.514966826511, 10948.671539853816, 10971.0, 10990.450477476094, 11030.0, 22209.111635534722, 22214.55570888573, 22216.444588885406, 22233.777662223496, 22247.110115595195, 8429.283510901641, 8472.788180295418, 8523.0, 8564.48613083217, 8763.60563774619, 4749.335093086902, 4766.213574760126, 4830.879228019257, 4867.148249056472, 4868.659193856396, 3618.3667858124722, 3696.353138200804, 3727.0, 3727.794971276606, 3733.4586484959527, 623.4731651754261, 625.271558634186, 627.8712863862897, 639.6769631336145, 645.1677336236296, 663.1942190238883, 668.4785867023633, 670.4234358451728, 687.8933765266391, 690.3510699942038, 11004.614838480615, 11525.308481490969, 11528.481218345194, 11823.054155667525, 11968.281903085843, 707.8195060259703, 726.9345758881726, 731.5976213082783, 741.3402072155785, 854.9615267312986, 5221.295125158131, 5621.634593751393, 5639.802606908738, 5668.943310566924, 5693.146028095736, 63788.0, 64310.67844660747, 66862.33137668562, 77413.0, 81528.18471815206, 58103.70948145232, 59843.40156598378, 60689.69655151696, 62687.0, 65388.67305663441, 60082.39917600768, 61234.0, 62238.0, 62692.0, 64008.35991640117, 11456.770864582495, 11649.475773590379, 11774.764504709687, 11848.28910265387, 11894.940525297317, 37105.81447092747, 39640.0, 42200.36699449449, 42616.5738342625, 43458.13083738244, 49379.0, 52283.0, 52833.47166528286, 52920.73539632277, 55106.44893551013, 12940.0, 13149.145305555108, 13271.734565308832, 13392.0, 13633.182009079486, 15864.206789660702, 15887.761683574987, 15923.203839808195, 16008.359665613245, 16351.100689462193, 14708.485203017843, 14853.405863765329, 14854.33155507983, 14970.775438368215, 15122.470713524974, 14750.409983600965, 14834.406623734929, 15024.474143404928, 15105.697886041999, 15275.847241527443, 14727.92636036813, 14738.778918316018, 14789.408423662933, 14794.408223670933, 15169.165695886832, 11500.309981401142, 11898.19745394099, 11917.582884598998, 12413.379331033593, 12419.565315213924, 11466.94266528662, 11484.598039068593, 11664.88335116638, 11774.470148843495, 11775.76448471043], "value": 7459.57021892647, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 112.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 126.0, 123.0, 162.0, 127.0, 124.0, 123.0, 121.0, 140.0, 123.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 164.0, 164.0, 162.0, 162.0, 161.0, 167.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 112.0, 79.0, 76.0, 78.0, 74.0, 97.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 104.0, 82.0, 85.0, 84.0, 105.0, 82.0, 85.0, 115.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 118.0, 125.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 148.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 101.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 55.0, 54.0, 55.0, 56.0, 55.0, 55.0, 55.0, 59.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 68.0, 64.0, 64.0, 64.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 77.0, 76.0, 82.0, 76.0, 76.0, 77.0, 76.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 130.0, 125.0, 121.0, 120.0, 119.0, 129.0, 129.0, 165.0, 123.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 154.0, 153.0, 160.0, 166.0, 155.0, 157.0, 159.0, 155.0, 158.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 62.0, 63.0, 62.0, 62.0, 60.0, 60.0, 60.0, 61.0], "value": 62.0, "unit": "score"}]}]} 08:23:44 INFO - Return code: 0 08:23:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:23:44 ERROR - # TBPL SUCCESS # 08:23:44 INFO - Running post-action listener: _resource_record_post_action 08:23:44 INFO - [mozharness: 2017-02-03 16:23:44.323087Z] Finished run-tests step (success) 08:23:44 INFO - Running post-run listener: _resource_record_post_run 08:23:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361046016; Read time: 12; Write time: 322436 08:23:44 INFO - TinderboxPrint: CPU usage
13.3% 08:23:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:23:44 INFO - TinderboxPrint: I/O write bytes / time
361,046,016 / 322,436 08:23:44 INFO - TinderboxPrint: CPU idle
8,230.3 (86.7%) 08:23:44 INFO - TinderboxPrint: CPU user
1,206.9 (12.7%) 08:23:44 INFO - TinderboxPrint: Swap in / out
0 / 0 08:23:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110014464; Read time: 0; Write time: 131168 08:23:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251031552; Read time: 12; Write time: 191268 08:23:44 INFO - Running post-run listener: _upload_blobber_files 08:23:44 INFO - Blob upload gear active. 08:23:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:23:44 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 08:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:23:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:23:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:23:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:23:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:46 INFO - (blobuploader) - INFO - Done attempting. 08:23:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:23:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:23:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:46 INFO - (blobuploader) - INFO - Done attempting. 08:23:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:23:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:50 INFO - (blobuploader) - INFO - Done attempting. 08:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:51 INFO - (blobuploader) - INFO - Done attempting. 08:23:51 INFO - (blobuploader) - INFO - Iteration through files over. 08:23:51 INFO - Return code: 0 08:23:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:23:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:23:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ec0d740031386e67ac5f01ee114d1a737e6f4650e958e915df5cf01d5acb201c5dce5af5eaa3bf648112358984a3b8d608a36d3f4f4795d60420cdeb5d87b21", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06fb71ecdfe0c83a8a0245748b6b6e4c14a87d09858b0acfb1650b20484c4d71eec6c40bed3092bf1335ba4645abbe7e00141f0944f658f73a0c780c365544f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/098ae709c433dd8addc03693bbaf21ee3afab59cc841b552ba4639195c50264c71c9d6f827808cc720eb59a73677495814d826e90c6626ad00ab44d8596bf1df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca16d7cc75b4d9249995eed9aa4581714ba4a75526ae5f556c0e5ce952759539bcadfabcdc8c372a4816e4ae42c7c77be8628af206623527560c96869ce4e3e3"} 08:23:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:23:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:23:51 INFO - Contents: 08:23:51 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ec0d740031386e67ac5f01ee114d1a737e6f4650e958e915df5cf01d5acb201c5dce5af5eaa3bf648112358984a3b8d608a36d3f4f4795d60420cdeb5d87b21", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06fb71ecdfe0c83a8a0245748b6b6e4c14a87d09858b0acfb1650b20484c4d71eec6c40bed3092bf1335ba4645abbe7e00141f0944f658f73a0c780c365544f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/098ae709c433dd8addc03693bbaf21ee3afab59cc841b552ba4639195c50264c71c9d6f827808cc720eb59a73677495814d826e90c6626ad00ab44d8596bf1df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca16d7cc75b4d9249995eed9aa4581714ba4a75526ae5f556c0e5ce952759539bcadfabcdc8c372a4816e4ae42c7c77be8628af206623527560c96869ce4e3e3"} 08:23:51 INFO - Running post-run listener: copy_logs_to_upload_dir 08:23:51 INFO - Copying logs to upload dir... 08:23:51 INFO - mkdir: /builds/slave/test/build/upload/logs 08:23:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.322094 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-03 08:23:51.107085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 08:23:51.111491) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ec0d740031386e67ac5f01ee114d1a737e6f4650e958e915df5cf01d5acb201c5dce5af5eaa3bf648112358984a3b8d608a36d3f4f4795d60420cdeb5d87b21", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06fb71ecdfe0c83a8a0245748b6b6e4c14a87d09858b0acfb1650b20484c4d71eec6c40bed3092bf1335ba4645abbe7e00141f0944f658f73a0c780c365544f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/098ae709c433dd8addc03693bbaf21ee3afab59cc841b552ba4639195c50264c71c9d6f827808cc720eb59a73677495814d826e90c6626ad00ab44d8596bf1df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca16d7cc75b4d9249995eed9aa4581714ba4a75526ae5f556c0e5ce952759539bcadfabcdc8c372a4816e4ae42c7c77be8628af206623527560c96869ce4e3e3"} build_url:https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/M6xI86qjR1-WS9XCjj5_tQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ec0d740031386e67ac5f01ee114d1a737e6f4650e958e915df5cf01d5acb201c5dce5af5eaa3bf648112358984a3b8d608a36d3f4f4795d60420cdeb5d87b21", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06fb71ecdfe0c83a8a0245748b6b6e4c14a87d09858b0acfb1650b20484c4d71eec6c40bed3092bf1335ba4645abbe7e00141f0944f658f73a0c780c365544f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/098ae709c433dd8addc03693bbaf21ee3afab59cc841b552ba4639195c50264c71c9d6f827808cc720eb59a73677495814d826e90c6626ad00ab44d8596bf1df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca16d7cc75b4d9249995eed9aa4581714ba4a75526ae5f556c0e5ce952759539bcadfabcdc8c372a4816e4ae42c7c77be8628af206623527560c96869ce4e3e3"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 08:23:51.260819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:23:51.261201) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1486137794.245935-1475171733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 08:23:51.310900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 08:23:51.311298) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 08:23:51.311611) ========= ========= Total master_lag: 0.36 =========