builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-077 starttime: 1486616954.6 results: success (0) revision: ee5b1dfbf4011568f8d4316a59f617a0ada3a3d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:14.596554) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:14.596997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:14.597281) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:14.616457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:14.616732) ========= 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=20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-08 21:09: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% 41.8M=0s 2017-02-08 21:09:15 (41.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.245709 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:14.875619) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:14.875944) ========= 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=20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:14.928710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:14.932078) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ee5b1dfbf4011568f8d4316a59f617a0ada3a3d3 --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 ee5b1dfbf4011568f8d4316a59f617a0ada3a3d3 --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=20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-08 21:09:15,130 truncating revision to first 12 chars 2017-02-08 21:09:15,130 Setting DEBUG logging. 2017-02-08 21:09:15,130 attempt 1/10 2017-02-08 21:09:15,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ee5b1dfbf401?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 21:09:15,432 unpacking tar archive at: mozilla-aurora-ee5b1dfbf401/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:15.576466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:15.576803) ========= script_repo_revision: ee5b1dfbf4011568f8d4316a59f617a0ada3a3d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:15.577235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:15.577500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 21:09:15.586212) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-08 21:09:15.586516) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:09:15 INFO - MultiFileLogger online at 20170208 21:09:15 in /builds/slave/test 21:09:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 21:09:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:09:15 INFO - {'append_to_log': False, 21:09:15 INFO - 'base_work_dir': '/builds/slave/test', 21:09:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 21:09:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:09:15 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 21:09:15 INFO - 'buildbot_json_path': 'buildprops.json', 21:09:15 INFO - 'config_files': ('talos/linux_config.py',), 21:09:15 INFO - 'default_actions': ('clobber', 21:09:15 INFO - 'read-buildbot-config', 21:09:15 INFO - 'download-and-extract', 21:09:15 INFO - 'populate-webroot', 21:09:15 INFO - 'create-virtualenv', 21:09:15 INFO - 'install', 21:09:15 INFO - 'run-tests'), 21:09:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:09:15 INFO - 'download_minidump_stackwalk': True, 21:09:15 INFO - 'download_symbols': 'ondemand', 21:09:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:09:15 INFO - 'tooltool.py': '/tools/tooltool.py', 21:09:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:09:15 INFO - '/tools/misc-python/virtualenv.py')}, 21:09:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:09:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:09:15 INFO - 'installer_path': 'installer.exe', 21:09:15 INFO - 'log_level': 'info', 21:09:15 INFO - 'log_name': 'talos', 21:09:15 INFO - 'log_to_console': True, 21:09:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:09:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:09:15 INFO - 'opt_config_files': (), 21:09:15 INFO - 'pip_index': False, 21:09:15 INFO - 'sps_profile': False, 21:09:15 INFO - 'sps_profile_interval': 0, 21:09:15 INFO - 'suite': 'dromaeojs-e10s', 21:09:15 INFO - 'system_bits': '32', 21:09:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:09:15 INFO - 'title': 'talos-linux64-ix-077', 21:09:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:09:15 INFO - 'use_talos_json': True, 21:09:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:09:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:09:15 INFO - 'work_dir': 'build'} 21:09:15 INFO - [mozharness: 2017-02-09 05:09:15.886594Z] Running clobber step. 21:09:15 INFO - Running pre-action listener: _resource_record_pre_action 21:09:15 INFO - Running main action method: clobber 21:09:15 INFO - rmtree: /builds/slave/test/build 21:09:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:09:16 INFO - Running post-action listener: _resource_record_post_action 21:09:16 INFO - [mozharness: 2017-02-09 05:09:16.868693Z] Finished clobber step (success) 21:09:16 INFO - [mozharness: 2017-02-09 05:09:16.868790Z] Running read-buildbot-config step. 21:09:16 INFO - Running pre-action listener: _resource_record_pre_action 21:09:16 INFO - Running main action method: read_buildbot_config 21:09:16 INFO - Using buildbot properties: 21:09:16 INFO - { 21:09:16 INFO - "project": "", 21:09:16 INFO - "product": "firefox", 21:09:16 INFO - "who": "mozilla@noorenberghe.ca", 21:09:16 INFO - "installer_path": "public/build/target.tar.bz2", 21:09:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 21:09:16 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 21:09:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 21:09:16 INFO - "stage_platform": "linux64", 21:09:16 INFO - "basedir": "/builds/slave/test", 21:09:16 INFO - "buildnumber": 17, 21:09:16 INFO - "platform": "ubuntu64_hw", 21:09:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:09:16 INFO - "slavebuilddir": "test", 21:09:16 INFO - "taskId": "XYU9SjepRBexKdhTXRkJyA", 21:09:16 INFO - "branch": "mozilla-aurora", 21:09:16 INFO - "script_repo_revision": "production", 21:09:16 INFO - "revision": "ee5b1dfbf4011568f8d4316a59f617a0ada3a3d3", 21:09:16 INFO - "slavename": "talos-linux64-ix-077", 21:09:16 INFO - "repo_path": "releases/mozilla-aurora" 21:09:16 INFO - } 21:09:16 INFO - Finding installer, test and symbols from parent task. 21:09:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XYU9SjepRBexKdhTXRkJyA'}, attempt #1 21:09:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XYU9SjepRBexKdhTXRkJyA'}, attempt #1 21:09:17 INFO - Task dependencies: e8m8RZB1S36J0OzXvDc99w 21:09:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w'}, attempt #1 21:09:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.tar.bz2 21:09:18 INFO - Set test_url: https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/test_packages.json 21:09:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.crashreporter-symbols.zip 21:09:18 INFO - Running post-action listener: _resource_record_post_action 21:09:18 INFO - [mozharness: 2017-02-09 05:09:18.306119Z] Finished read-buildbot-config step (success) 21:09:18 INFO - [mozharness: 2017-02-09 05:09:18.306379Z] Running download-and-extract step. 21:09:18 INFO - Running pre-action listener: _resource_record_pre_action 21:09:18 INFO - Running main action method: download_and_extract 21:09:18 INFO - mkdir: /builds/slave/test/build/tests 21:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:18 INFO - trying https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.test_packages.json 21:09:18 INFO - Downloading https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:09:18 INFO - Downloaded 896 bytes. 21:09:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:09:18 INFO - Using the following test package requirements: 21:09:18 INFO - {u'common': [u'target.common.tests.zip'], 21:09:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:09:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:09:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:09:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:09:18 INFO - u'mozbase': [u'target.common.tests.zip'], 21:09:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:09:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:09:18 INFO - u'web-platform': [u'target.common.tests.zip', 21:09:18 INFO - u'target.web-platform.tests.zip'], 21:09:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:09:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:09:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.common.tests.zip 21:09:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:09:18 INFO - Fetch https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.common.tests.zip into memory 21:09:19 INFO - Expected file size: 21858407 21:09:19 INFO - Obtained file size: 21858407 21:09:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:09:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.common.tests.zip 21:09:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:09:23 INFO - Fetch https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.common.tests.zip into memory 21:09:24 INFO - Expected file size: 21858407 21:09:24 INFO - Obtained file size: 21858407 21:09:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.talos.tests.zip 21:09:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:09:29 INFO - Fetch https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.talos.tests.zip into memory 21:09:29 INFO - Expected file size: 14403485 21:09:29 INFO - Obtained file size: 14403485 21:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:30 INFO - trying https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.tar.bz2 21:09:30 INFO - Downloading https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:09:31 INFO - Downloaded 66019236 bytes. 21:09:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.tar.bz2 21:09:31 INFO - mkdir: /builds/slave/test/properties 21:09:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:09:31 INFO - Writing to file /builds/slave/test/properties/build_url 21:09:31 INFO - Contents: 21:09:31 INFO - build_url:https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.tar.bz2 21:09:31 INFO - Running post-action listener: _resource_record_post_action 21:09:31 INFO - Running post-action listener: set_extra_try_arguments 21:09:31 INFO - [mozharness: 2017-02-09 05:09:31.256094Z] Finished download-and-extract step (success) 21:09:31 INFO - [mozharness: 2017-02-09 05:09:31.256190Z] Running populate-webroot step. 21:09:31 INFO - Running pre-action listener: _resource_record_pre_action 21:09:31 INFO - Running main action method: populate_webroot 21:09:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:09:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:09:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:09:31 INFO - '--tppagecycles', 21:09:31 INFO - '7'], 21:09:31 INFO - 'tests': ['tsvgm']}}, 21:09:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:09:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:09:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:09:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:09:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:09:31 INFO - 'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:09:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:09:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:09:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:09:31 INFO - 'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['damp', 'tps']}, 21:09:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:09:31 INFO - 'tests': ['damp', 'tps']}, 21:09:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['dromaeo_dom']}, 21:09:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:09:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['basic_compositor_video']}, 21:09:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:09:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['a11yr', 21:09:31 INFO - 'ts_paint', 21:09:31 INFO - 'tpaint', 21:09:31 INFO - 'sessionrestore', 21:09:31 INFO - 'sessionrestore_no_auto_restore', 21:09:31 INFO - 'tabpaint']}, 21:09:31 INFO - 'other-e10s': {'tests': ['a11yr', 21:09:31 INFO - 'ts_paint', 21:09:31 INFO - 'tpaint', 21:09:31 INFO - 'sessionrestore', 21:09:31 INFO - 'sessionrestore_no_auto_restore', 21:09:31 INFO - 'tabpaint']}, 21:09:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:09:31 INFO - 'ts_paint', 21:09:31 INFO - 'tpaint', 21:09:31 INFO - 'sessionrestore', 21:09:31 INFO - 'sessionrestore_no_auto_restore', 21:09:31 INFO - 'tabpaint']}, 21:09:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:09:31 INFO - 'ts_paint', 21:09:31 INFO - 'tpaint', 21:09:31 INFO - 'sessionrestore', 21:09:31 INFO - 'sessionrestore_no_auto_restore', 21:09:31 INFO - 'tabpaint']}, 21:09:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['a11yr', 21:09:31 INFO - 'ts_paint', 21:09:31 INFO - 'tpaint', 21:09:31 INFO - 'sessionrestore', 21:09:31 INFO - 'sessionrestore_no_auto_restore', 21:09:31 INFO - 'tabpaint']}, 21:09:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['a11yr', 21:09:31 INFO - 'ts_paint', 21:09:31 INFO - 'tpaint', 21:09:31 INFO - 'sessionrestore', 21:09:31 INFO - 'sessionrestore_no_auto_restore', 21:09:31 INFO - 'tabpaint']}, 21:09:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['tsvgx', 21:09:31 INFO - 'tsvgr_opacity', 21:09:31 INFO - 'tart', 21:09:31 INFO - 'tscrollx', 21:09:31 INFO - 'cart', 21:09:31 INFO - 'tsvg_static']}, 21:09:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:09:31 INFO - 'tsvgr_opacity', 21:09:31 INFO - 'tart', 21:09:31 INFO - 'tscrollx', 21:09:31 INFO - 'cart', 21:09:31 INFO - 'tsvg_static']}, 21:09:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:09:31 INFO - 'talos_options': ['--disable-e10s'], 21:09:31 INFO - 'tests': ['tp5o']}, 21:09:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:09:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:09:31 INFO - 'talos_options': ['--disable-e10s', 21:09:31 INFO - '--xperf_path', 21:09:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:09:31 INFO - 'tests': ['tp5n']}, 21:09:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:09:31 INFO - 'talos_options': ['--xperf_path', 21:09:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:09:31 INFO - 'tests': ['tp5n']}}, 21:09:31 INFO - 'talos.zip': {'path': '', 21:09:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:09:31 INFO - Running post-action listener: _resource_record_post_action 21:09:31 INFO - [mozharness: 2017-02-09 05:09:31.269324Z] Finished populate-webroot step (success) 21:09:31 INFO - [mozharness: 2017-02-09 05:09:31.269414Z] Running create-virtualenv step. 21:09:31 INFO - Running pre-action listener: _resource_record_pre_action 21:09:31 INFO - Running main action method: create_virtualenv 21:09:31 INFO - Creating virtualenv /builds/slave/test/build/venv 21:09:31 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 21:09:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:09:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:09:31 INFO - Using real prefix '/usr' 21:09:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:09:31 INFO - Installing distribute.............................................................................................................................................................................................done. 21:09:33 INFO - Installing pip.................done. 21:09:33 INFO - Return code: 0 21:09:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:09:34 INFO - Reading from file tmpfile_stdout 21:09:34 INFO - Output received: 21:09:34 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) 21:09:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:34 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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09:34 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 21:09:34 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 21:09:34 INFO - Using env: {'DISPLAY': ':0', 21:09:34 INFO - 'HOME': '/home/cltbld', 21:09:34 INFO - 'LANG': 'en_US.UTF-8', 21:09:34 INFO - 'LANGUAGE': 'en_US:en', 21:09:34 INFO - 'LOGNAME': 'cltbld', 21:09:34 INFO - 'MAIL': '/var/mail/cltbld', 21:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:34 INFO - 'MOZ_NO_REMOTE': '1', 21:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:34 INFO - 'NO_EM_RESTART': '1', 21:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:34 INFO - 'PWD': '/builds/slave/test', 21:09:34 INFO - 'SHELL': '/bin/bash', 21:09:34 INFO - 'SHLVL': '1', 21:09:34 INFO - 'TERM': 'linux', 21:09:34 INFO - 'TMOUT': '86400', 21:09:34 INFO - 'USER': 'cltbld', 21:09:34 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:34 INFO - '_': '/tools/buildbot/bin/python'} 21:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:34 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 21:09:34 INFO - Cleaning up... 21:09:34 INFO - Return code: 0 21:09:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:34 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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09:34 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 21:09:34 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 21:09:34 INFO - Using env: {'DISPLAY': ':0', 21:09:34 INFO - 'HOME': '/home/cltbld', 21:09:34 INFO - 'LANG': 'en_US.UTF-8', 21:09:34 INFO - 'LANGUAGE': 'en_US:en', 21:09:34 INFO - 'LOGNAME': 'cltbld', 21:09:34 INFO - 'MAIL': '/var/mail/cltbld', 21:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:34 INFO - 'MOZ_NO_REMOTE': '1', 21:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:34 INFO - 'NO_EM_RESTART': '1', 21:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:34 INFO - 'PWD': '/builds/slave/test', 21:09:34 INFO - 'SHELL': '/bin/bash', 21:09:34 INFO - 'SHLVL': '1', 21:09:34 INFO - 'TERM': 'linux', 21:09:34 INFO - 'TMOUT': '86400', 21:09:34 INFO - 'USER': 'cltbld', 21:09:34 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:34 INFO - '_': '/tools/buildbot/bin/python'} 21:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:34 INFO - Downloading/unpacking psutil>=3.1.1 21:09:34 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 21:09:34 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 21:09:34 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 21:09:34 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 21:09:34 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 21:09:34 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 21:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:09:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:36 INFO - Installing collected packages: psutil 21:09:36 INFO - Running setup.py install for psutil 21:09:36 INFO - building 'psutil._psutil_linux' extension 21:09: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 21:09: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 21:09:36 INFO - building 'psutil._psutil_posix' extension 21:09: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 21:09:37 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 21:09:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:37 INFO - Successfully installed psutil 21:09:37 INFO - Cleaning up... 21:09:37 INFO - Return code: 0 21:09:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:37 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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09:37 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 21:09:37 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 21:09:37 INFO - Using env: {'DISPLAY': ':0', 21:09:37 INFO - 'HOME': '/home/cltbld', 21:09:37 INFO - 'LANG': 'en_US.UTF-8', 21:09:37 INFO - 'LANGUAGE': 'en_US:en', 21:09:37 INFO - 'LOGNAME': 'cltbld', 21:09:37 INFO - 'MAIL': '/var/mail/cltbld', 21:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:37 INFO - 'MOZ_NO_REMOTE': '1', 21:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:37 INFO - 'NO_EM_RESTART': '1', 21:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:37 INFO - 'PWD': '/builds/slave/test', 21:09:37 INFO - 'SHELL': '/bin/bash', 21:09:37 INFO - 'SHLVL': '1', 21:09:37 INFO - 'TERM': 'linux', 21:09:37 INFO - 'TMOUT': '86400', 21:09:37 INFO - 'USER': 'cltbld', 21:09:37 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:37 INFO - '_': '/tools/buildbot/bin/python'} 21:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:09:37 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 21:09:37 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 21:09:37 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 21:09:37 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 21:09:37 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 21:09:37 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 21:09:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:09:39 INFO - Installing collected packages: mozsystemmonitor 21:09:39 INFO - Running setup.py install for mozsystemmonitor 21:09:39 INFO - Successfully installed mozsystemmonitor 21:09:39 INFO - Cleaning up... 21:09:39 INFO - Return code: 0 21:09:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09: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 21:09: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 21:09:39 INFO - Using env: {'DISPLAY': ':0', 21:09:39 INFO - 'HOME': '/home/cltbld', 21:09:39 INFO - 'LANG': 'en_US.UTF-8', 21:09:39 INFO - 'LANGUAGE': 'en_US:en', 21:09:39 INFO - 'LOGNAME': 'cltbld', 21:09:39 INFO - 'MAIL': '/var/mail/cltbld', 21:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:39 INFO - 'MOZ_NO_REMOTE': '1', 21:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:39 INFO - 'NO_EM_RESTART': '1', 21:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:39 INFO - 'PWD': '/builds/slave/test', 21:09:39 INFO - 'SHELL': '/bin/bash', 21:09:39 INFO - 'SHLVL': '1', 21:09:39 INFO - 'TERM': 'linux', 21:09:39 INFO - 'TMOUT': '86400', 21:09:39 INFO - 'USER': 'cltbld', 21:09:39 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:39 INFO - '_': '/tools/buildbot/bin/python'} 21:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:39 INFO - Downloading/unpacking jsonschema==2.5.1 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:09:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09:42 INFO - Downloading functools32-3.2.3-2.tar.gz 21:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:09:42 INFO - warning: no files found matching '*.txt' 21:09:42 INFO - no previously-included directories found matching 'build' 21:09:42 INFO - no previously-included directories found matching 'dist' 21:09:42 INFO - no previously-included directories found matching '.git*' 21:09:42 INFO - Installing collected packages: jsonschema, functools32 21:09:42 INFO - Running setup.py install for functools32 21:09:42 INFO - warning: no files found matching '*.txt' 21:09:42 INFO - no previously-included directories found matching 'build' 21:09:42 INFO - no previously-included directories found matching 'dist' 21:09:42 INFO - no previously-included directories found matching '.git*' 21:09:42 INFO - Successfully installed jsonschema functools32 21:09:42 INFO - Cleaning up... 21:09:42 INFO - Return code: 0 21:09:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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', '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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:09: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 functools32==3.2.3-2 21:09:42 INFO - Using env: {'DISPLAY': ':0', 21:09:42 INFO - 'HOME': '/home/cltbld', 21:09:42 INFO - 'LANG': 'en_US.UTF-8', 21:09:42 INFO - 'LANGUAGE': 'en_US:en', 21:09:42 INFO - 'LOGNAME': 'cltbld', 21:09:42 INFO - 'MAIL': '/var/mail/cltbld', 21:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:42 INFO - 'MOZ_NO_REMOTE': '1', 21:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:42 INFO - 'NO_EM_RESTART': '1', 21:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:42 INFO - 'PWD': '/builds/slave/test', 21:09:42 INFO - 'SHELL': '/bin/bash', 21:09:42 INFO - 'SHLVL': '1', 21:09:42 INFO - 'TERM': 'linux', 21:09:42 INFO - 'TMOUT': '86400', 21:09:42 INFO - 'USER': 'cltbld', 21:09:42 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:42 INFO - '_': '/tools/buildbot/bin/python'} 21:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:09:42 INFO - Cleaning up... 21:09:42 INFO - Return code: 0 21:09:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09: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 21:09: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 21:09:42 INFO - Using env: {'DISPLAY': ':0', 21:09:42 INFO - 'HOME': '/home/cltbld', 21:09:42 INFO - 'LANG': 'en_US.UTF-8', 21:09:42 INFO - 'LANGUAGE': 'en_US:en', 21:09:42 INFO - 'LOGNAME': 'cltbld', 21:09:42 INFO - 'MAIL': '/var/mail/cltbld', 21:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:42 INFO - 'MOZ_NO_REMOTE': '1', 21:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:42 INFO - 'NO_EM_RESTART': '1', 21:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:42 INFO - 'PWD': '/builds/slave/test', 21:09:42 INFO - 'SHELL': '/bin/bash', 21:09:42 INFO - 'SHLVL': '1', 21:09:42 INFO - 'TERM': 'linux', 21:09:42 INFO - 'TMOUT': '86400', 21:09:42 INFO - 'USER': 'cltbld', 21:09:42 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:42 INFO - '_': '/tools/buildbot/bin/python'} 21:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:42 INFO - Downloading/unpacking blobuploader==1.2.4 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 21:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:09:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:09:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:09:45 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 21:09:45 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 21:09:45 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 21:09:45 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 21:09:45 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 21:09:45 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 21:09:45 INFO - Downloading docopt-0.6.1.tar.gz 21:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 21:09:45 INFO - Running setup.py install for blobuploader 21:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:09:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:09:45 INFO - Running setup.py install for requests 21:09:46 INFO - Running setup.py install for docopt 21:09:46 INFO - Successfully installed blobuploader requests docopt 21:09:46 INFO - Cleaning up... 21:09:46 INFO - Return code: 0 21:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:46 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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09:46 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 21:09:46 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 21:09:46 INFO - Using env: {'DISPLAY': ':0', 21:09:46 INFO - 'HOME': '/home/cltbld', 21:09:46 INFO - 'LANG': 'en_US.UTF-8', 21:09:46 INFO - 'LANGUAGE': 'en_US:en', 21:09:46 INFO - 'LOGNAME': 'cltbld', 21:09:46 INFO - 'MAIL': '/var/mail/cltbld', 21:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:46 INFO - 'MOZ_NO_REMOTE': '1', 21:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:46 INFO - 'NO_EM_RESTART': '1', 21:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:46 INFO - 'PWD': '/builds/slave/test', 21:09:46 INFO - 'SHELL': '/bin/bash', 21:09:46 INFO - 'SHLVL': '1', 21:09:46 INFO - 'TERM': 'linux', 21:09:46 INFO - 'TMOUT': '86400', 21:09:46 INFO - 'USER': 'cltbld', 21:09:46 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:46 INFO - '_': '/tools/buildbot/bin/python'} 21:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:46 INFO - Running setup.py (path:/tmp/pip-EtQZtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:46 INFO - Running setup.py (path:/tmp/pip-hy85ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:46 INFO - Running setup.py (path:/tmp/pip-SmcyLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:46 INFO - Running setup.py (path:/tmp/pip-7rfC6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:46 INFO - Running setup.py (path:/tmp/pip-tIZg4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:46 INFO - Running setup.py (path:/tmp/pip-0Zy5QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:46 INFO - Running setup.py (path:/tmp/pip-n89Xsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:46 INFO - Running setup.py (path:/tmp/pip-SZAQpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:47 INFO - Running setup.py (path:/tmp/pip-PTYM7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:47 INFO - Running setup.py (path:/tmp/pip-lHxk6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:47 INFO - Running setup.py (path:/tmp/pip-ALj8tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:47 INFO - Running setup.py (path:/tmp/pip-wx1N6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:47 INFO - Running setup.py (path:/tmp/pip-DYLXx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:47 INFO - Running setup.py (path:/tmp/pip-8l8Wmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:47 INFO - Running setup.py (path:/tmp/pip-aEd9rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:47 INFO - Running setup.py (path:/tmp/pip-fgyuBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:47 INFO - Running setup.py (path:/tmp/pip-lUdXwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:09:47 INFO - Running setup.py install for manifestparser 21:09:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:09:47 INFO - Running setup.py install for mozcrash 21:09:47 INFO - Running setup.py install for mozdebug 21:09:47 INFO - Running setup.py install for mozdevice 21:09:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Running setup.py install for mozfile 21:09:48 INFO - Running setup.py install for mozhttpd 21:09:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Running setup.py install for mozinfo 21:09:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Running setup.py install for mozInstall 21:09:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Running setup.py install for mozleak 21:09:48 INFO - Running setup.py install for mozlog 21:09:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Running setup.py install for moznetwork 21:09:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Running setup.py install for mozprocess 21:09:48 INFO - Running setup.py install for mozprofile 21:09:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:09:48 INFO - Running setup.py install for mozrunner 21:09:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:09:49 INFO - Running setup.py install for mozscreenshot 21:09:49 INFO - Running setup.py install for moztest 21:09:49 INFO - Running setup.py install for mozversion 21:09:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:09:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:09:49 INFO - Cleaning up... 21:09:49 INFO - Return code: 0 21:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:49 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')]} 21:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:49 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')]} 21:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:49 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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09:49 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 21:09:49 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 21:09:49 INFO - Using env: {'DISPLAY': ':0', 21:09:49 INFO - 'HOME': '/home/cltbld', 21:09:49 INFO - 'LANG': 'en_US.UTF-8', 21:09:49 INFO - 'LANGUAGE': 'en_US:en', 21:09:49 INFO - 'LOGNAME': 'cltbld', 21:09:49 INFO - 'MAIL': '/var/mail/cltbld', 21:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:49 INFO - 'MOZ_NO_REMOTE': '1', 21:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:49 INFO - 'NO_EM_RESTART': '1', 21:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:49 INFO - 'PWD': '/builds/slave/test', 21:09:49 INFO - 'SHELL': '/bin/bash', 21:09:49 INFO - 'SHLVL': '1', 21:09:49 INFO - 'TERM': 'linux', 21:09:49 INFO - 'TMOUT': '86400', 21:09:49 INFO - 'USER': 'cltbld', 21:09:49 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:49 INFO - '_': '/tools/buildbot/bin/python'} 21:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:49 INFO - Running setup.py (path:/tmp/pip-Tihw4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09: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)) 21:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:49 INFO - Running setup.py (path:/tmp/pip-PPhN6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09: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)) 21:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:49 INFO - Running setup.py (path:/tmp/pip-2_UoB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:50 INFO - Running setup.py (path:/tmp/pip-lKABfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:50 INFO - Running setup.py (path:/tmp/pip-Q_Vpui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:50 INFO - Running setup.py (path:/tmp/pip-IHG9n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:50 INFO - Running setup.py (path:/tmp/pip-Z0UsDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:50 INFO - Running setup.py (path:/tmp/pip-G4zqF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:50 INFO - Running setup.py (path:/tmp/pip-QmJLYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:50 INFO - Running setup.py (path:/tmp/pip-jssTAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:50 INFO - Running setup.py (path:/tmp/pip-0QrAgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:50 INFO - Running setup.py (path:/tmp/pip-GCSALC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:50 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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:50 INFO - Running setup.py (path:/tmp/pip-zSMnJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09: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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:50 INFO - Running setup.py (path:/tmp/pip-xOsEZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09: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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:50 INFO - Running setup.py (path:/tmp/pip-9TAQgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09: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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:50 INFO - Running setup.py (path:/tmp/pip-p0cHfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09: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)) 21:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:50 INFO - Running setup.py (path:/tmp/pip-MHHWjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:51 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)) 21:09:51 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)) 21:09:51 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)) 21:09:51 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)) 21:09:51 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)) 21:09:51 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)) 21:09:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:53 INFO - Downloading blessings-1.6.tar.gz 21:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:09:53 INFO - Installing collected packages: blessings 21:09:53 INFO - Running setup.py install for blessings 21:09:53 INFO - Successfully installed blessings 21:09:53 INFO - Cleaning up... 21:09:53 INFO - Return code: 0 21:09:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:53 INFO - Reading from file tmpfile_stdout 21:09:53 INFO - Current package versions: 21:09:53 INFO - argparse == 1.2.1 21:09:53 INFO - blessings == 1.6 21:09:53 INFO - blobuploader == 1.2.4 21:09:53 INFO - docopt == 0.6.1 21:09:53 INFO - functools32 == 3.2.3-2 21:09:53 INFO - jsonschema == 2.5.1 21:09:53 INFO - manifestparser == 1.1 21:09:53 INFO - mozInstall == 1.12 21:09:53 INFO - mozcrash == 1.0 21:09:53 INFO - mozdebug == 0.1 21:09:53 INFO - mozdevice == 0.49 21:09:53 INFO - mozfile == 1.2 21:09:53 INFO - mozhttpd == 0.7 21:09:53 INFO - mozinfo == 0.9 21:09:53 INFO - mozleak == 0.1 21:09:53 INFO - mozlog == 3.4 21:09:53 INFO - moznetwork == 0.27 21:09:53 INFO - mozprocess == 0.24 21:09:53 INFO - mozprofile == 0.28 21:09:53 INFO - mozrunner == 6.13 21:09:53 INFO - mozscreenshot == 0.1 21:09:53 INFO - mozsystemmonitor == 0.3 21:09:53 INFO - moztest == 0.8 21:09:53 INFO - mozversion == 1.4 21:09:53 INFO - psutil == 3.1.1 21:09:53 INFO - requests == 1.2.3 21:09:53 INFO - wsgiref == 0.1.2 21:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:53 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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09:53 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 21:09:53 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 21:09:53 INFO - Using env: {'DISPLAY': ':0', 21:09:53 INFO - 'HOME': '/home/cltbld', 21:09:53 INFO - 'LANG': 'en_US.UTF-8', 21:09:53 INFO - 'LANGUAGE': 'en_US:en', 21:09:53 INFO - 'LOGNAME': 'cltbld', 21:09:53 INFO - 'MAIL': '/var/mail/cltbld', 21:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:53 INFO - 'MOZ_NO_REMOTE': '1', 21:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:53 INFO - 'NO_EM_RESTART': '1', 21:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:53 INFO - 'PWD': '/builds/slave/test', 21:09:53 INFO - 'SHELL': '/bin/bash', 21:09:53 INFO - 'SHLVL': '1', 21:09:53 INFO - 'TERM': 'linux', 21:09:53 INFO - 'TMOUT': '86400', 21:09:53 INFO - 'USER': 'cltbld', 21:09:53 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:53 INFO - '_': '/tools/buildbot/bin/python'} 21:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09: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)) 21:09: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)) 21:09: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)) 21:09: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)) 21:09: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)) 21:09: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)) 21:09: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)) 21:09: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)) 21:09: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)) 21:09: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)) 21:09: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)) 21:09:53 INFO - Cleaning up... 21:09:53 INFO - Return code: 0 21:09:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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 0x10f01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1462a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, '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': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', '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 21:09: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 21:09: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 21:09:53 INFO - Using env: {'DISPLAY': ':0', 21:09:53 INFO - 'HOME': '/home/cltbld', 21:09:53 INFO - 'LANG': 'en_US.UTF-8', 21:09:53 INFO - 'LANGUAGE': 'en_US:en', 21:09:53 INFO - 'LOGNAME': 'cltbld', 21:09:53 INFO - 'MAIL': '/var/mail/cltbld', 21:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:53 INFO - 'MOZ_NO_REMOTE': '1', 21:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:53 INFO - 'NO_EM_RESTART': '1', 21:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:53 INFO - 'PWD': '/builds/slave/test', 21:09:53 INFO - 'SHELL': '/bin/bash', 21:09:53 INFO - 'SHLVL': '1', 21:09:53 INFO - 'TERM': 'linux', 21:09:53 INFO - 'TMOUT': '86400', 21:09:53 INFO - 'USER': 'cltbld', 21:09:53 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:53 INFO - '_': '/tools/buildbot/bin/python'} 21:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:09:53 INFO - Cleaning up... 21:09:53 INFO - Return code: 0 21:09:53 INFO - Running post-action listener: _resource_record_post_action 21:09:53 INFO - Running post-action listener: _start_resource_monitoring 21:09:54 INFO - Starting resource monitoring. 21:09:54 INFO - [mozharness: 2017-02-09 05:09:54.013233Z] Finished create-virtualenv step (success) 21:09:54 INFO - [mozharness: 2017-02-09 05:09:54.013722Z] Running install step. 21:09:54 INFO - Running pre-action listener: _resource_record_pre_action 21:09:54 INFO - Running main action method: install 21:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:54 INFO - Reading from file tmpfile_stdout 21:09:54 INFO - Detecting whether we're running mozinstall >=1.0... 21:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:09:54 INFO - Reading from file tmpfile_stdout 21:09:54 INFO - Output received: 21:09:54 INFO - Usage: mozinstall [options] installer 21:09:54 INFO - Options: 21:09:54 INFO - -h, --help show this help message and exit 21:09:54 INFO - -d DEST, --destination=DEST 21:09:54 INFO - Directory to install application into. [default: 21:09:54 INFO - "/builds/slave/test"] 21:09:54 INFO - --app=APP Application being installed. [default: firefox] 21:09:54 INFO - mkdir: /builds/slave/test/build/application 21:09:54 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'] 21:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:10:10 INFO - Reading from file tmpfile_stdout 21:10:10 INFO - Output received: 21:10:10 INFO - /builds/slave/test/build/application/firefox/firefox 21:10:10 INFO - Running post-action listener: _resource_record_post_action 21:10:10 INFO - [mozharness: 2017-02-09 05:10:10.801759Z] Finished install step (success) 21:10:10 INFO - [mozharness: 2017-02-09 05:10:10.802029Z] Running run-tests step. 21:10:10 INFO - Running pre-action listener: _resource_record_pre_action 21:10:10 INFO - Running main action method: run_tests 21:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:10:10 INFO - Python 2.7.3 21:10:10 INFO - Return code: 0 21:10:10 INFO - grabbing minidump binary from tooltool 21:10: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')]} 21:10: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 0x145fd20>, '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 0x1460ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1460f60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:10: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 21:10: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 21:10: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 21:10:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:10:10 INFO - Return code: 0 21:10:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:10:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:10:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:10:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:10:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 21:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-077 --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 21:10:10 INFO - Using env: {'DISPLAY': ':0', 21:10:10 INFO - 'HOME': '/home/cltbld', 21:10:10 INFO - 'LANG': 'en_US.UTF-8', 21:10:10 INFO - 'LANGUAGE': 'en_US:en', 21:10:10 INFO - 'LOGNAME': 'cltbld', 21:10:10 INFO - 'MAIL': '/var/mail/cltbld', 21:10:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:10:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:10 INFO - 'MOZ_NO_REMOTE': '1', 21:10:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:10 INFO - 'NO_EM_RESTART': '1', 21:10:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:10 INFO - 'PWD': '/builds/slave/test', 21:10:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:10:10 INFO - 'SHELL': '/bin/bash', 21:10:10 INFO - 'SHLVL': '1', 21:10:10 INFO - 'TERM': 'linux', 21:10:10 INFO - 'TMOUT': '86400', 21:10:10 INFO - 'USER': 'cltbld', 21:10:10 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943', 21:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:10 INFO - '_': '/tools/buildbot/bin/python'} 21:10:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 21:10:11 INFO - mozversion application_buildid: 20170209040000 21:10:11 INFO - mozversion application_changeset: ee5b1dfbf4011568f8d4316a59f617a0ada3a3d3 21:10:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:10:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:10:11 INFO - mozversion application_name: Firefox 21:10:11 INFO - mozversion application_remotingname: firefox-dev 21:10:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:10:11 INFO - mozversion application_vendor: Mozilla 21:10:11 INFO - mozversion application_version: 53.0a2 21:10:11 INFO - mozversion platform_buildid: 20170209040000 21:10:11 INFO - mozversion platform_changeset: ee5b1dfbf4011568f8d4316a59f617a0ada3a3d3 21:10:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:10:11 INFO - mozversion platform_version: 53.0a2 21:10:11 INFO - using testdate: 1486617011 21:10:11 INFO - actual date: 1486617011 21:10:11 INFO - starting webserver on 'localhost:33600' 21:10:11 INFO - SUITE-START | Running 2 tests 21:10:11 INFO - TEST-START | dromaeo_css 21:10:11 INFO - operating with platform_type : linux_ 21:10:11 INFO - Initialising browser for dromaeo_css test... 21:10:11 INFO - TEST-INFO | started process 10651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRV1iYz/profile http://localhost:33600/getInfo.html) 21:10:15 INFO - PROCESS | 10651 | __metrics Screen width/height:1600/1200 21:10:15 INFO - PROCESS | 10651 | colorDepth:24 21:10:15 INFO - PROCESS | 10651 | Browser inner width/height: 1024/697 21:10:15 INFO - PROCESS | 10651 | __metrics 21:10:15 INFO - PROCESS | 10651 | 1486617015933 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/tmpRV1iYz/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpRV1iYz/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpRV1iYz/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpRV1iYz/profile/extensions/talos-powers@TalosPowersService.js:55:9 21:10:15 ERROR - PROCESS | 10651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 21:10:16 INFO - TEST-INFO | 10651: exit 0 21:10:16 INFO - Browser initialized. 21:10:16 INFO - Running cycle 1/1 for dromaeo_css test... 21:10:16 INFO - TEST-INFO | started process 10777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRV1iYz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:10:28 INFO - PROCESS | 10777 | RSS: Main: 144457728 21:10:28 INFO - PROCESS | 10777 | 21:13:27 INFO - PROCESS | 10777 | Cycle 1(1): loaded http://localhost:33600/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33600/tests/dromaeo/cssquery-ext.html) 21:13:29 INFO - PROCESS | 10777 | RSS: Main: 152219648 21:13:29 INFO - PROCESS | 10777 | 21:15:17 INFO - PROCESS | 10777 | ************************* 21:15:17 INFO - PROCESS | 10777 | A coding exception was thrown and uncaught in a Task. 21:15:17 INFO - PROCESS | 10777 | 21:15:17 ERROR - PROCESS | 10777 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:15:17 INFO - PROCESS | 10777 | Full stack: 21:15:17 INFO - PROCESS | 10777 | ************************* 21:16:31 INFO - PROCESS | 10777 | Cycle 1(1): loaded http://localhost:33600/tests/dromaeo/cssquery-ext.html (next: http://localhost:33600/tests/dromaeo/cssquery-jquery.html) 21:16:31 INFO - PROCESS | 10777 | RSS: Main: 149811200 21:16:31 INFO - PROCESS | 10777 | 21:19:33 INFO - PROCESS | 10777 | Cycle 1(1): loaded http://localhost:33600/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33600/tests/dromaeo/cssquery-mootools.html) 21:19:34 INFO - PROCESS | 10777 | RSS: Main: 153149440 21:19:34 INFO - PROCESS | 10777 | 21:22:35 INFO - PROCESS | 10777 | Cycle 1(1): loaded http://localhost:33600/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33600/tests/dromaeo/cssquery-prototype.html) 21:22:36 INFO - PROCESS | 10777 | RSS: Main: 149397504 21:22:36 INFO - PROCESS | 10777 | 21:25:38 INFO - PROCESS | 10777 | Cycle 1(1): loaded http://localhost:33600/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33600/tests/dromaeo/cssquery-yui.html) 21:25:39 INFO - PROCESS | 10777 | RSS: Main: 152801280 21:25:39 INFO - PROCESS | 10777 | 21:28:41 INFO - PROCESS | 10777 | Cycle 1(1): loaded http://localhost:33600/tests/dromaeo/cssquery-yui.html (next: http://localhost:33600/tests/dromaeo/cssquery-dojo.html) 21:28:41 INFO - PROCESS | 10777 | RSS: Main: 155549696 21:28:41 INFO - PROCESS | 10777 | 21:28:41 INFO - PROCESS | 10777 | __start_tp_report 21:28:41 INFO - PROCESS | 10777 | _x_x_mozilla_page_load 21:28:41 INFO - PROCESS | 10777 | _x_x_mozilla_page_load_details 21:28:41 INFO - PROCESS | 10777 | |i|pagename|runs| 21:28:41 INFO - PROCESS | 10777 | |0;dojo.html;3277.9836100819493;3297.7032067113955;3328.5839270091255;3351.111955331836;3351.145457908236;5483.424240454755;5511.3937466878715;5533.22534845121;5534.667919924802;5537.307836520435;5532.30846144232;5614.66312021279;5617.578681598876;5618.494335509803;5635.21107045014;4926.852194434173;4986.10250154972;5034.773435195425;5043.041822053798;5073.315102461176;5023.6985780853265;5069.239614057884;5070.898582028357;5075.441701412841;5097.184450487923;4875.9756201219125;4883.731394773286;5060.089183946907;5066.6706664066905;5067.594592432615;4938.16051271283;4956.653034287601;4992.87517812054;5012.147934851084;5076.619253555961;4970.850874473772;4999.325091112726;5017.949820501784;5020.548150666457;5027.84916452507;5503.449655034505;5518.779248830042;5583.553315734732;5588.804391846306;5603.047481928042;5755.30936287644;5761.395053519362;5784.971075144639;5821.126830975345;5842.561807864385;5889.5288376930175;5906.173135760997;5909.37951515089;5914.231149950522;5953.851153721148;5502.5597952163735;5504.532114770249;5508.008558459475;5512.724363781795;5522.861928451821;5865.090910908816;5939.346671866091;5967.582269241198;5971.4327138921735;5990.970045149834;5846.56150788684;5920.911186332209;5936.5547583931375;5937.910931336033;5961.046232602763;5901.262342207224;5940.435658612425;5955.970220148872;5962.731677074542;5964.135200396005;5773.826785196451;5776.68228247442;5809.302883653989;5926.525877929756;5933.762649494059;5811.360750317462;5864.7947321844385;5897.823065308047;5905.527557795452;5926.140709597084;4533.342665313511;4539.319102134707;4552.294394368878;4555.043440877453;4569.13186494565;3992.1416895367634;4000.159966407029;4053.007013281706;4067.3695577185586;4079.4288799568085;5674.631148975303;5687.146927960756;5719.7140142992685;5784.334801497882;5826.038703613941;5978.133170690313;6018.398160184034;6025.698715064229;6035.366286539938;6037.516998640098;5566.582506312043;5604.327480702342;5636.689982051026;5781.075027995501;5792.102224155178;5017.272495488134;5069.898602028013;5094.312267843794;5097;5101.20931255656;6173.69131543421;6183.443490085824;6184;6184.134221208944;6199.690015499207;5826.446487583673;5937.228160339128;5948.048312270016;5952.196453478725;5954.851128721816;6014.609050411709;6027.969860150672;6032.185654936703;6033.245844269466;6179.598326108789;5794.101914203306;5805.912911306249;5823.912641310469;5848.619839710405;5868.823935281948;5897.351291357862;5942.108683697307;5950.315713692808;5953.613015154001;5956.583039187389;5660;5726.226959360433;5729.197912292199;5738.799142030176;5763.827085187451;5804.912926306193;5813.82558523245;5823.359430462561;5823.854403639943;5829.358770535153;5785.768569257182;5795.623284486495;5804;5806;5812.244408226903;5731.083026715705;5740.856478588069;5797.043487824461;5800.970995144998;5807.796727114531;5780.21967034445;5806;5808.157817116579;5814.941850581609;5859.5019423349495 21:28:41 INFO - PROCESS | 10777 | |1;ext.html;532.7248641080158;588.8822235552889;611.9143319935209;687.3058211206679;704.5209257704759;46266;47167.29249061263;51477.485225147735;51477.485225147735;51517.48482515174;52159;53244.733776331064;53247;53297.46702532974;53308;9299.814003719921;10815.67552973412;10903.34579925203;11235.887641123565;11352;10864.130869530458;10980.450977451135;11005.504752286166;11019.83470247947;11028.613998510054;10993.175511836604;10994.90050994902;11076;11080.889191108066;11092;11001.119910407187;11003.61487347943;11009.83485247722;11046.171537134707;11060.391678457681;10953.288036277616;11033.337999720043;11074.889251107546;11075.11399088079;11084.224104312701;43559.78220108911;43606;43804.56195438037;43935.34096988516;43972.12055758899;4290.892727681801;4349.086691794727;4438.911221775546;4509.143262780061;4516.751578663172;32443.675563244302;32854;33112.50331245033;33114.37153993193;33435.49846752301;3991.501062367204;4080.5511393746665;4169.499660040784;4194.454720886265;4263.722858014219;380563;380867;380997;383158;383622;63217.36782632115;63550;64166;64178.67910660417;64180.35819641744;66395.66802165959;66955;67086.66456667783;67155.66422167858;67330.3266967324;16837;17238.224279907434;19300.1314940828;19750.90124549397;19891.801081989284;15000;15330.846691532943;15336.616584585252;15782.842171578366;15839;20189.192432302836;20543.8972805135;20601.278955236496;20625.381238562568;20695.06872190725;7165.856682866313;7266.818329541804;7280.890786638205;7416.814579635445;7534.924650753532;969.4958621516772;970.752458123174;982.0523195116747;986.2603047714215;988.584794386345;33891.32217355688;34012;34050.14874628154;34284.314313713585;34313.48529772055;1067.4129228924216;1178.6581891251442;1183.5088438298183;1227.4783217132683;1230.7353918907477;17794.199261033285;17883.398531670508;17885.025544368047;17937.37219197322;18022.061506320162;327493;329902;330383;330960;331082;68802;69443;69597.65201173961;69739.30260697429;69851;1548.620587955958;1550.643352029017;1556.120791752656;1568.3412966554074;1581.1066747287746;32605.673943260263;33084.33831323408;33515.66484335223;33566.49650255199;33706.325873482885;58878.411215887296;59366;59392;59551.702241488514;59647.40352596592;396944;397463;398005;399441;401209;32006;32633.673663263064;32642.51036234506;32898.67101329052;33002.504962425104;53020.73489632527;54052.45947540474;54189.729051356066;55252.618684533205;56235.71882140563;43814.12371752611;43868.12263754643;44707.552924470336;44946.550534494236;45786.31320530128;45332.54667453283;45449.31826022546;45565;46130;46181.538184617726;43498.56501434945;43889.561104389824;44103.33844992264;44234;44428.333574995755;36608.633913660524;37945;38620.420693690176;39205;39546.80226598849;28159.15522534327;28209;28217.153485395473;28361;28405.43189136247 21:28:41 INFO - PROCESS | 10777 | |2;jquery.html;418.89527618095474;420.379939589106;438.246216507607;438.2680922858825;442.8029526860548;20160.69758953615;21170.89414552927;22165.556688866214;22299.777002229974;22369.10523579057;22440.214592489265;22727;23514.764852351513;23529;23634;6150.753969841201;6151.753929842824;6341.714622841983;6379.776707815227;6399.552031357807;6126.111713801496;6275.4979601631985;6281.780137695182;6295.118683384307;6305.9684701576425;6052.818415447521;6171.969140154293;6259.624422534663;6262.248530176385;6271.404216599439;6154.230721159855;6212;6218.471429928439;6224.937750622481;6227.688615569226;5433.212184233304;5563.109902415594;5577.749001294951;5602.411746766572;5604.635698679614;25866.96532138712;25989.610155847677;26297.3425664358;26332;26374.340641483923;3229.257270827723;3333.749968752353;3347.330533893207;3382.3742607617423;3400.9829950850335;15954.44159454425;15956.361745530165;16209.91895040529;16395.60637345827;16495.175241237892;2031.522592190834;2077.1587507059667;2078.844086693504;2087.332053742803;2100.6638937769885;95502;95693.5215323919;96480;96877.5156124222;98872.50563747135;12089.455974481169;12383.69040773988;12439.813402798965;12497.687557811127;12522.937385313015;17658.293668253384;17710.291588336324;17761.911190443963;17775.46673599794;17782.377616783608;9402.717918462457;9700.466474343837;9770.706878793648;9788.461634610023;9879.456629885282;9558.856617150748;9572.808543829084;9603.663871764455;9630.422174669402;9781.462019588991;7612.391008719289;7873.763787086396;7882.330001949784;7882.527048377001;8106.432549721463;2136.42316574524;2155.2887547109417;2161.8594791338514;2186.4533866533366;2217.9001944912516;1169.7774228965034;1176.1120354132574;1198.0714945916984;1198.9880101198876;1212.442276552778;20657.380278591667;21093.472663183544;21112.78887211139;21216.78783212179;21266.680999785014;1172.8240763885485;1182.633383651071;1197.9395439843456;1208.3112625803208;1217.2027322104036;11447.713807154887;11917.106217033757;12171.695707607203;12218.144729868824;12268.938655306845;660879;672146;685345;748817;752106;95471;95483;99270;100349.49825250827;100934.49532752436;1118.6532175025932;1119.6641007697658;1153.9942300288444;1154.988450115505;1163.650904728578;17964.371247006293;18083.728744069114;18161.091945402943;18218.635627287644;18620.255189792257;41358.79320603378;42625.5737442634;43072.56927430686;43394.349084763126;43912;62482.68758656178;62762;63256.36743632689;63525.364746351945;65312.67343663251;6567.014947757683;7455.776326710207;9612.807743845224;9675.274354423587;9729.951350243487;10891.455427228448;13642.181469111885;14110.647233819236;14525.564233073024;15057.47298844579;12798.616041518397;12833.679158021125;12902.354882256037;12905.741885162432;12937.417816198105;12370.62888113358;12620.684482887635;12704;13075.215487070805;13091.41088651032;12328.19866708661;12580.622581322576;12939;13077.542286019943;13348.332583370599;9615.56729947168;9694;9738.707838764849;9952.203823693942;9971.60113595477;12343.259404435763;12691.873081269068;12855.16441431304;13116.475340986253;13131.146475479063 21:28:41 INFO - PROCESS | 10777 | |3;mootools.html;1484.829244636867;1485.3019081031914;1493.3056128900066;1498.61036130606;1509.0719207687273;7703.191164927686;8076.232757888006;8082.232187942143;8181.672733090677;8401.201885820838;8534.957325213381;8643.222110010098;8659.870101948476;8689.174528419806;8702.086280940504;2405.56699794037;2407.8194135439867;2416.4200591857916;2433.051110067075;2435.025989604155;2342.847714898535;2397.1729753235104;2403.9158629447975;2408.987955060231;2411.963820542693;2307.48081681622;2317.7102862142233;2319.257837492003;2339.847909885852;2340.953180936389;2264.4338915271182;2270.421042634126;2273.976710480274;2286.4741109544816;2290.3815969688176;2188.3544354415485;2228.721409823772;2229.1306390507716;2229.9665505017438;2233.6649502574583;8425.578721063923;8432.620532076071;8482.448640838325;8513;8517.403781735282;5199.6360254782185;5327.360716713981;5334.119870221409;5340.572754179656;5347.973260133714;3217.227865312308;3362.9406736877804;3386.9661303386897;3421.5894092708786;3461.359648465042;1382.1361648969394;1411.4636438153436;1458.8759955403698;1475.4762059468842;1476.2840022589037;11072.114230861513;11094.889051109547;11142.944285278603;11143.777124457547;11238.325700458;4363.759993200341;4429.114177164515;4501.662375321864;4570.314452832035;4621.560951709582;9246.676366327147;9271.860922086174;9294.302927280345;9332.300077494216;9343.159115679622;5223.190405487156;5246.4753524647995;5291.1798671206025;5294.41761406245;5295.338082739658;4669.089527542164;4822.397200349957;4845.9030819383415;4939.135651261086;4953.6532442729385;3817.7327587069194;3933.7443066200603;3952.604739526082;3996.680265578747;4005.639492445694;1187.7446349035;1189.0725234317247;1190.2025642819333;1194.964151075469;1195.838561794164;990.3711143423977;997.4464172384396;1003.3428104591504;1007.5566750629699;1017.4099022566893;5325.760340784674;5433.6196466247775;5466.3713672928125;5548.528375088082;5607.467290607386;605.7183409714504;608.9786857459968;615.1910238036967;630.4956035171845;638.3680156644888;3662.432322989941;3678.1356381250384;3775.7734535927934;3824.674902633252;4006.358982562776;9418.199453046567;9793.21654267657;9804.460754658563;9826.312158149003;9829.262805289489;9852.359596626196;9937.602495900082;9942.950285248528;9946.45294508809;9969.501524923724;7960.2039796019935;7975.521468711896;8008;8026.077001144943;8052.436329456999;5500.972495137498;5507.091329930517;5607.271054763018;5617.241672374177;5654.604177707521;9106.95446522763;9149.359544832065;9209.907900920905;9309.581068851783;9321.114494123047;8991.14584114508;9253.491057991874;9279.164875161268;9401.34190606651;9449.007854175212;7097.432205423657;7105.147382314155;7145.428365730625;7155.284471552803;7187.31720486553;7706.190849960673;7713.112992005991;7735.381169506313;7743.341815945708;7787.844243115219;7198;7246;7337.779866604011;7342;7512.586807725409;7155.391791697556;7156.463265255023;7163.06880105583;7182.4613154014705;7229.240929702306;6391.360863913572;6507.511936604868;6515.73937042513;6550.8362290943105;6598.37315455031;4704.482506924304;4803.1354356214815;4805.13507568627;4929.433115191656;4944.752762361795;5013.323201367769;5052.772625231947;5129.179331306973;5144.151215049625;5191.974040129775 21:28:41 INFO - PROCESS | 10777 | |4;prototype.html;390.4923599320883;395.32991579273136;405.6065616352141;410.79870863277006;411.21252800886305;5490.368607610126;5517.503424691777;5579.2746942897365;5587.720613969301;5596.720163991799;5223.973880130594;5455.372632147304;5486.506214440699;5510.531604813586;5515.586331025169;4348.586884246008;4359.564043595647;4361.49842768081;4366.934495982563;4370.169667763131;4361.498427680825;4362.847300344489;4363.956360436403;4414.713043652168;4414.7351158930405;3972.82122304497;4118.217538667644;4169.3954376615375;4363.8435814509185;4374.300111982084;4131.347461015588;4131.483564554431;4146.688998325138;4168.707700612805;4168.7081904266715;3672.100335417813;3677.632236776301;3678.393065144248;3678.5769636491877;3681.742278040538;5272.314599102092;5354.625176237665;5357.491038351351;5357.973210133963;5382.838514844561;4860.343853579792;4884.487128851455;4897.3878265216845;4908.337374454439;4909.705417674915;5748.223989761413;5752.913706294409;5753;5786.189933409326;5804.303483581955;3941.881743547698;4082.2447847148374;4116.75299482032;4127.772972486512;4132.710710250284;5746.954114319417;5888.440598143126;5928.318243402021;5955.731992060324;5958.195643588104;4239.59723826236;4248.893777655521;4263.76549289792;4265.402843601898;4287.65698744106;4331.0904710011255;4336.132773445261;4337;4349.630281426114;4350.847720329773;4830.106430310334;4865.635077369211;4912.238603016467;4913.729744863996;4968.677035992649;5710.486056254957;5749.981259838618;5765.85585360361;5794.391588883191;5811.418858114154;1402.5231421316598;1424.4159894443228;1427.8220468113848;1427.9714405711827;1430.4336751257356;964.6961207219704;1004.4525733475127;1011.1304278320638;1013.761765984993;1025.092792878308;5346.625736198429;5400.6759594423675;5442.523651738449;5502.487959872866;5508.7521061552325;5666.603337766317;5783.826485205451;5790.681512516852;5811.883762324815;5812.593118481665;5351.759170837322;5433.239346491494;5439.755211015514;5610.85972850682;5669.744861481243;3047.756179505634;3066.6933306669152;3069.8772049118234;3078.2150551609197;3080.922976925595;5696.3733989261145;5884.499817515473;5942.346341902387;6006.255058503733;6009.849753756191;5799.637085284955;5806;5834.565730045196;5841.795537156179;5846.930361560215;5904.291485021739;5921.61509501881;5953.315368732565;6018.969905150446;6061.818145455643;5638.069718496567;5660.830175094754;5680.375158732453;5782.1615865698395;5803.419658034163;5689.34572524165;5700.714964251853;5728.312602487728;5737.942620573741;5742.626729262584;5952;5961.940380596138;6137.41694539018;6156.891759483156;6168.845778855564;4281.1651727914;4290.1205252922455;4317.136572685413;4323.52441231458;4325.447985688459;5739.253896993364;5909.645421274738;5986.401359864153;5996.2504686914135;6004.249468816398;5744.6265992712015;5757.280339957505;5762.683052432157;5801.1878337033695;5804.920694392406;5747.827565173052;5781.479666829838;5803.448672376117;5805.709714514173;5823.5923485355615;5496.395396506301;5727.570432217683;5737.827865164052;5754.726882881322;5773.3072031356505;5755.755255450294;5765.135229715576;5839.474447299764;5845.386234445322;5856.648601083778;5570.777168913198;5726.856828579319;5730.799422020209;5735.9388513125205;5746.7701291949525 21:28:41 INFO - PROCESS | 10777 | |5;yui.html;815.6452886798166;828.983420331593;848.5375470368648;914.5290175559586;952.4380615436893;15867.206639667998;16111.83888161118;16529.173541322914;16529.50411487656;17651.205695743705;15681.510256525611;15728.606784830385;15947.20263986799;15983.360665573393;16194.676106477864;820.9343252539798;835.0230230630146;840.1682334488873;840.861257892447;841.1924552429675;804.7304153108715;826.8181000179981;831.3473922970439;834.7412302186311;840.504102579478;870.5516658920629;875.1817051057282;878.4992554244084;880.6125304865839;881.995590022049;877.7410663854179;881.5592203898051;881.8368601808654;882.6469412235093;882.6778225947515;633.8732253549263;635.6249812610582;642.4218203616736;643.572024603638;644.4103645164669;16351.182440878027;16695.83304166967;16822.495325140266;16845.32618695251;16941;14890;14998.925005375013;15068.171250581214;15094.924525377413;15390.692186156215;11304.943475282653;11330.150238732129;11398.544058237661;11417.486213120346;11424.771504569862;3937.8621748238675;3969.444277801081;3980.641742243212;3994.840206391741;4086.6322031017053;57762.13356799651;58510.414895850925;68614.31385686129;77257;77773.61113194398;11351.772964540663;11612.535498579962;11679.766404671858;12220.816687749691;12339.383030848421;20794.584108317747;23294.883525582263;23666.7633323668;23688.40778980505;23746.168884088973;8504.957475212585;8557.957210214034;8602.483850968962;8669.21977022071;8766.95616521926;4658.604018658452;4678.719276843401;4739.834105806281;4744.122337367598;4771.570558649738;3606.2787442511603;3705.110773414361;3724.0875985383755;3744.925101498009;3756.511653485084;636.2810024672091;640.2445114764622;646.4860435953428;647.3688154049764;657.6317262333109;634.4987459906714;643.2634633344794;655.7639249870043;658.7365053978447;662.493192707579;10970.177236707279;11068.3912384818;11173.329600224013;11382.772344553228;11407.714807129889;774.4888373673349;781.800640836583;792.4096548071724;810.1736229046339;816.4529765057307;5427.240186373911;5478.808241711521;5542.251796007487;5606.887862242814;5635.8591035224445;86711;86855;87887.56056219806;89431.55284223537;89924.20151597062;73664;73948;75401;75842.62078689571;77373.45253094907;61409.385906140364;62431;63150.36849631445;64710.676446617465;65221.34778652248;10034.498275086362;10557.841632375366;10579.4710264488;10614.681559553226;10684.786304273715;45250.32124518069;45518.54481455143;46134;46205.458699771836;47136.764316178196;57338;59126.40873591209;59314;59901;61822;12411;12704.872951270369;12739.872601273868;12773.425195866394;13068.477260909458;13185.208887466782;13370.665733356744;13532;13858.16850988944;14140.080894741808;13207.207567545978;13646.795298070736;13672.794908076188;13726.45094196221;14125.576232713034;13826.30868456553;13930.373133209232;13953.441862325393;14076.718465630835;14168.362423690753;12783.296918669563;13501;13533.796993044914;13538.120022198525;14084.718305633625;11537.82693259585;11574.6527604172;11682.88317116818;11849.881501184878;12271.57049503263;10571.2600117991;10641.255112142077;10797.838032429363;10812.56749730002;10817.891821081688 21:28:41 INFO - PROCESS | 10777 | __end_tp_report 21:28:41 INFO - PROCESS | 10777 | __start_cc_report 21:28:41 INFO - PROCESS | 10777 | _x_x_mozilla_cycle_collect,309 21:28:41 INFO - PROCESS | 10777 | __end_cc_report 21:28:41 INFO - PROCESS | 10777 | __startTimestamp1486618121567__endTimestamp 21:28:41 INFO - PROCESS | 10777 | 21:28:41 INFO - PROCESS | 10777 | ------- Summary: start ------- 21:28:41 INFO - PROCESS | 10777 | Number of tests: 6 21:28:41 INFO - PROCESS | 10777 | 21:28:41 INFO - PROCESS | 10777 | [#0] dojo.html Cycles:165 Average:5509.04 Median:5780.22 stddev:613.52 (10.6%) stddev-sans-first:589.91 21:28:41 INFO - PROCESS | 10777 | Values: 3278.0 3297.7 3328.6 3351.1 3351.1 5483.4 5511.4 5533.2 5534.7 5537.3 5532.3 5614.7 5617.6 5618.5 5635.2 4926.9 4986.1 5034.8 5043.0 5073.3 5023.7 5069.2 5070.9 5075.4 5097.2 4876.0 4883.7 5060.1 5066.7 5067.6 4938.2 4956.7 4992.9 5012.1 5076.6 4970.9 4999.3 5017.9 5020.5 5027.8 5503.4 5518.8 5583.6 5588.8 5603.0 5755.3 5761.4 5785.0 5821.1 5842.6 5889.5 5906.2 5909.4 5914.2 5953.9 5502.6 5504.5 5508.0 5512.7 5522.9 5865.1 5939.3 5967.6 5971.4 5991.0 5846.6 5920.9 5936.6 5937.9 5961.0 5901.3 5940.4 5956.0 5962.7 5964.1 5773.8 5776.7 5809.3 5926.5 5933.8 5811.4 5864.8 5897.8 5905.5 5926.1 4533.3 4539.3 4552.3 4555.0 4569.1 3992.1 4000.2 4053.0 4067.4 4079.4 5674.6 5687.1 5719.7 5784.3 5826.0 5978.1 6018.4 6025.7 6035.4 6037.5 5566.6 5604.3 5636.7 5781.1 5792.1 5017.3 5069.9 5094.3 5097.0 5101.2 6173.7 6183.4 6184.0 6184.1 6199.7 5826.4 5937.2 5948.0 5952.2 5954.9 6014.6 6028.0 6032.2 6033.2 6179.6 5794.1 5805.9 5823.9 5848.6 5868.8 5897.4 5942.1 5950.3 5953.6 5956.6 5660.0 5726.2 5729.2 5738.8 5763.8 5804.9 5813.8 5823.4 5823.9 5829.4 5785.8 5795.6 5804.0 5806.0 5812.2 5731.1 5740.9 5797.0 5801.0 5807.8 5780.2 5806.0 5808.2 5814.9 5859.5 21:28:41 INFO - PROCESS | 10777 | 21:28:41 INFO - PROCESS | 10777 | [#1] ext.html Cycles:180 Average:57019.46 Median:211121.21 stddev:97219.88 (46.0%) stddev-sans-first:97400.09 21:28:41 INFO - PROCESS | 10777 | Values: 532.7 588.9 611.9 687.3 704.5 46266.0 47167.3 51477.5 51477.5 51517.5 52159.0 53244.7 53247.0 53297.5 53308.0 9299.8 10815.7 10903.3 11235.9 11352.0 10864.1 10980.5 11005.5 11019.8 11028.6 10993.2 10994.9 11076.0 11080.9 11092.0 11001.1 11003.6 11009.8 11046.2 11060.4 10953.3 11033.3 11074.9 11075.1 11084.2 43559.8 43606.0 43804.6 43935.3 43972.1 4290.9 4349.1 4438.9 4509.1 4516.8 32443.7 32854.0 33112.5 33114.4 33435.5 3991.5 4080.6 4169.5 4194.5 4263.7 380563.0 380867.0 380997.0 383158.0 383622.0 63217.4 63550.0 64166.0 64178.7 64180.4 66395.7 66955.0 67086.7 67155.7 67330.3 16837.0 17238.2 19300.1 19750.9 19891.8 15000.0 15330.8 15336.6 15782.8 15839.0 20189.2 20543.9 20601.3 20625.4 20695.1 7165.9 7266.8 7280.9 7416.8 7534.9 969.5 970.8 982.1 986.3 988.6 33891.3 34012.0 34050.1 34284.3 34313.5 1067.4 1178.7 1183.5 1227.5 1230.7 17794.2 17883.4 17885.0 17937.4 18022.1 327493.0 329902.0 330383.0 330960.0 331082.0 68802.0 69443.0 69597.7 69739.3 69851.0 1548.6 1550.6 1556.1 1568.3 1581.1 32605.7 33084.3 33515.7 33566.5 33706.3 58878.4 59366.0 59392.0 59551.7 59647.4 396944.0 397463.0 398005.0 399441.0 401209.0 32006.0 32633.7 32642.5 32898.7 33002.5 53020.7 54052.5 54189.7 55252.6 56235.7 43814.1 43868.1 44707.6 44946.6 45786.3 45332.5 45449.3 45565.0 46130.0 46181.5 43498.6 43889.6 44103.3 44234.0 44428.3 36608.6 37945.0 38620.4 39205.0 39546.8 28159.2 28209.0 28217.2 28361.0 28405.4 21:28:41 INFO - PROCESS | 10777 | 21:28:41 INFO - PROCESS | 10777 | [#2] jquery.html Cycles:180 Average:36844.81 Median:23581.50 stddev:115521.79 (489.9%) stddev-sans-first:115813.47 21:28:41 INFO - PROCESS | 10777 | Values: 418.9 420.4 438.2 438.3 442.8 20160.7 21170.9 22165.6 22299.8 22369.1 22440.2 22727.0 23514.8 23529.0 23634.0 6150.8 6151.8 6341.7 6379.8 6399.6 6126.1 6275.5 6281.8 6295.1 6306.0 6052.8 6172.0 6259.6 6262.2 6271.4 6154.2 6212.0 6218.5 6224.9 6227.7 5433.2 5563.1 5577.7 5602.4 5604.6 25867.0 25989.6 26297.3 26332.0 26374.3 3229.3 3333.7 3347.3 3382.4 3401.0 15954.4 15956.4 16209.9 16395.6 16495.2 2031.5 2077.2 2078.8 2087.3 2100.7 95502.0 95693.5 96480.0 96877.5 98872.5 12089.5 12383.7 12439.8 12497.7 12522.9 17658.3 17710.3 17761.9 17775.5 17782.4 9402.7 9700.5 9770.7 9788.5 9879.5 9558.9 9572.8 9603.7 9630.4 9781.5 7612.4 7873.8 7882.3 7882.5 8106.4 2136.4 2155.3 2161.9 2186.5 2217.9 1169.8 1176.1 1198.1 1199.0 1212.4 20657.4 21093.5 21112.8 21216.8 21266.7 1172.8 1182.6 1197.9 1208.3 1217.2 11447.7 11917.1 12171.7 12218.1 12268.9 660879.0 672146.0 685345.0 748817.0 752106.0 95471.0 95483.0 99270.0 100349.5 100934.5 1118.7 1119.7 1154.0 1155.0 1163.7 17964.4 18083.7 18161.1 18218.6 18620.3 41358.8 42625.6 43072.6 43394.3 43912.0 62482.7 62762.0 63256.4 63525.4 65312.7 6567.0 7455.8 9612.8 9675.3 9730.0 10891.5 13642.2 14110.6 14525.6 15057.5 12798.6 12833.7 12902.4 12905.7 12937.4 12370.6 12620.7 12704.0 13075.2 13091.4 12328.2 12580.6 12939.0 13077.5 13348.3 9615.6 9694.0 9738.7 9952.2 9971.6 12343.3 12691.9 12855.2 13116.5 13131.1 21:28:41 INFO - PROCESS | 10777 | 21:28:41 INFO - PROCESS | 10777 | [#3] mootools.html Cycles:180 Average:5475.23 Median:5330.74 stddev:2971.57 (55.7%) stddev-sans-first:2964.78 21:28:41 INFO - PROCESS | 10777 | Values: 1484.8 1485.3 1493.3 1498.6 1509.1 7703.2 8076.2 8082.2 8181.7 8401.2 8535.0 8643.2 8659.9 8689.2 8702.1 2405.6 2407.8 2416.4 2433.1 2435.0 2342.8 2397.2 2403.9 2409.0 2412.0 2307.5 2317.7 2319.3 2339.8 2341.0 2264.4 2270.4 2274.0 2286.5 2290.4 2188.4 2228.7 2229.1 2230.0 2233.7 8425.6 8432.6 8482.4 8513.0 8517.4 5199.6 5327.4 5334.1 5340.6 5348.0 3217.2 3362.9 3387.0 3421.6 3461.4 1382.1 1411.5 1458.9 1475.5 1476.3 11072.1 11094.9 11142.9 11143.8 11238.3 4363.8 4429.1 4501.7 4570.3 4621.6 9246.7 9271.9 9294.3 9332.3 9343.2 5223.2 5246.5 5291.2 5294.4 5295.3 4669.1 4822.4 4845.9 4939.1 4953.7 3817.7 3933.7 3952.6 3996.7 4005.6 1187.7 1189.1 1190.2 1195.0 1195.8 990.4 997.4 1003.3 1007.6 1017.4 5325.8 5433.6 5466.4 5548.5 5607.5 605.7 609.0 615.2 630.5 638.4 3662.4 3678.1 3775.8 3824.7 4006.4 9418.2 9793.2 9804.5 9826.3 9829.3 9852.4 9937.6 9943.0 9946.5 9969.5 7960.2 7975.5 8008.0 8026.1 8052.4 5501.0 5507.1 5607.3 5617.2 5654.6 9107.0 9149.4 9209.9 9309.6 9321.1 8991.1 9253.5 9279.2 9401.3 9449.0 7097.4 7105.1 7145.4 7155.3 7187.3 7706.2 7713.1 7735.4 7743.3 7787.8 7198.0 7246.0 7337.8 7342.0 7512.6 7155.4 7156.5 7163.1 7182.5 7229.2 6391.4 6507.5 6515.7 6550.8 6598.4 4704.5 4803.1 4805.1 4929.4 4944.8 5013.3 5052.8 5129.2 5144.2 5192.0 21:28:41 INFO - PROCESS | 10777 | 21:28:41 INFO - PROCESS | 10777 | [#4] prototype.html Cycles:180 Average:4829.24 Median:5505.62 stddev:1407.78 (25.6%) stddev-sans-first:1371.74 21:28:41 INFO - PROCESS | 10777 | Values: 390.5 395.3 405.6 410.8 411.2 5490.4 5517.5 5579.3 5587.7 5596.7 5224.0 5455.4 5486.5 5510.5 5515.6 4348.6 4359.6 4361.5 4366.9 4370.2 4361.5 4362.8 4364.0 4414.7 4414.7 3972.8 4118.2 4169.4 4363.8 4374.3 4131.3 4131.5 4146.7 4168.7 4168.7 3672.1 3677.6 3678.4 3678.6 3681.7 5272.3 5354.6 5357.5 5358.0 5382.8 4860.3 4884.5 4897.4 4908.3 4909.7 5748.2 5752.9 5753.0 5786.2 5804.3 3941.9 4082.2 4116.8 4127.8 4132.7 5747.0 5888.4 5928.3 5955.7 5958.2 4239.6 4248.9 4263.8 4265.4 4287.7 4331.1 4336.1 4337.0 4349.6 4350.8 4830.1 4865.6 4912.2 4913.7 4968.7 5710.5 5750.0 5765.9 5794.4 5811.4 1402.5 1424.4 1427.8 1428.0 1430.4 964.7 1004.5 1011.1 1013.8 1025.1 5346.6 5400.7 5442.5 5502.5 5508.8 5666.6 5783.8 5790.7 5811.9 5812.6 5351.8 5433.2 5439.8 5610.9 5669.7 3047.8 3066.7 3069.9 3078.2 3080.9 5696.4 5884.5 5942.3 6006.3 6009.8 5799.6 5806.0 5834.6 5841.8 5846.9 5904.3 5921.6 5953.3 6019.0 6061.8 5638.1 5660.8 5680.4 5782.2 5803.4 5689.3 5700.7 5728.3 5737.9 5742.6 5952.0 5961.9 6137.4 6156.9 6168.8 4281.2 4290.1 4317.1 4323.5 4325.4 5739.3 5909.6 5986.4 5996.3 6004.2 5744.6 5757.3 5762.7 5801.2 5804.9 5747.8 5781.5 5803.4 5805.7 5823.6 5496.4 5727.6 5737.8 5754.7 5773.3 5755.8 5765.1 5839.5 5845.4 5856.6 5570.8 5726.9 5730.8 5735.9 5746.8 21:28:41 INFO - PROCESS | 10777 | 21:28:41 INFO - PROCESS | 10777 | [#5] yui.html Cycles:180 Average:18226.83 Median:45384.43 stddev:23194.35 (51.1%) stddev-sans-first:23222.56 21:28:41 INFO - PROCESS | 10777 | Values: 815.6 829.0 848.5 914.5 952.4 15867.2 16111.8 16529.2 16529.5 17651.2 15681.5 15728.6 15947.2 15983.4 16194.7 820.9 835.0 840.2 840.9 841.2 804.7 826.8 831.3 834.7 840.5 870.6 875.2 878.5 880.6 882.0 877.7 881.6 881.8 882.6 882.7 633.9 635.6 642.4 643.6 644.4 16351.2 16695.8 16822.5 16845.3 16941.0 14890.0 14998.9 15068.2 15094.9 15390.7 11304.9 11330.2 11398.5 11417.5 11424.8 3937.9 3969.4 3980.6 3994.8 4086.6 57762.1 58510.4 68614.3 77257.0 77773.6 11351.8 11612.5 11679.8 12220.8 12339.4 20794.6 23294.9 23666.8 23688.4 23746.2 8505.0 8558.0 8602.5 8669.2 8767.0 4658.6 4678.7 4739.8 4744.1 4771.6 3606.3 3705.1 3724.1 3744.9 3756.5 636.3 640.2 646.5 647.4 657.6 634.5 643.3 655.8 658.7 662.5 10970.2 11068.4 11173.3 11382.8 11407.7 774.5 781.8 792.4 810.2 816.5 5427.2 5478.8 5542.3 5606.9 5635.9 86711.0 86855.0 87887.6 89431.6 89924.2 73664.0 73948.0 75401.0 75842.6 77373.5 61409.4 62431.0 63150.4 64710.7 65221.3 10034.5 10557.8 10579.5 10614.7 10684.8 45250.3 45518.5 46134.0 46205.5 47136.8 57338.0 59126.4 59314.0 59901.0 61822.0 12411.0 12704.9 12739.9 12773.4 13068.5 13185.2 13370.7 13532.0 13858.2 14140.1 13207.2 13646.8 13672.8 13726.5 14125.6 13826.3 13930.4 13953.4 14076.7 14168.4 12783.3 13501.0 13533.8 13538.1 14084.7 11537.8 11574.7 11682.9 11849.9 12271.6 10571.3 10641.3 10797.8 10812.6 10817.9 21:28:41 INFO - PROCESS | 10777 | -------- Summary: end -------- 21:28:41 INFO - PROCESS | 10777 | 21:28:42 INFO - TEST-INFO | 10777: exit 0 21:28:42 INFO - TEST-OK | dromaeo_css | took 1111232ms 21:28:42 INFO - TEST-START | kraken 21:28:42 INFO - operating with platform_type : linux_ 21:28:42 INFO - Initialising browser for kraken test... 21:28:42 INFO - TEST-INFO | started process 11153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2oLFtP/profile http://localhost:33600/getInfo.html) 21:28:46 INFO - PROCESS | 11153 | __metrics Screen width/height:1600/1200 21:28:46 INFO - PROCESS | 11153 | colorDepth:24 21:28:46 INFO - PROCESS | 11153 | Browser inner width/height: 1024/697 21:28:46 INFO - PROCESS | 11153 | __metrics 21:28:47 INFO - PROCESS | 11153 | 1486618127087 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/tmp2oLFtP/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp2oLFtP/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp2oLFtP/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp2oLFtP/profile/extensions/talos-powers@TalosPowersService.js:55:9 21:28:47 ERROR - PROCESS | 11153 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 21:28:47 INFO - TEST-INFO | 11153: exit 0 21:28:47 INFO - Browser initialized. 21:28:47 INFO - Running cycle 1/1 for kraken test... 21:28:47 INFO - TEST-INFO | started process 11279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2oLFtP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:28:59 INFO - PROCESS | 11279 | RSS: Main: 144490496 21:28:59 INFO - PROCESS | 11279 | 21:29:02 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33600/tests/kraken/driver.html?testName=audio-beat-detection) 21:29:03 INFO - PROCESS | 11279 | RSS: Main: 151289856 21:29:03 INFO - PROCESS | 11279 | 21:29:05 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33600/tests/kraken/driver.html?testName=audio-dft) 21:29:06 INFO - PROCESS | 11279 | RSS: Main: 150110208 21:29:06 INFO - PROCESS | 11279 | 21:29:09 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33600/tests/kraken/driver.html?testName=audio-fft) 21:29:09 INFO - PROCESS | 11279 | RSS: Main: 150577152 21:29:09 INFO - PROCESS | 11279 | 21:29:11 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33600/tests/kraken/driver.html?testName=audio-oscillator) 21:29:12 INFO - PROCESS | 11279 | RSS: Main: 150077440 21:29:12 INFO - PROCESS | 11279 | 21:29:14 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33600/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:29:15 INFO - PROCESS | 11279 | RSS: Main: 149680128 21:29:15 INFO - PROCESS | 11279 | 21:29:18 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33600/tests/kraken/driver.html?testName=imaging-darkroom) 21:29:18 INFO - PROCESS | 11279 | RSS: Main: 153325568 21:29:18 INFO - PROCESS | 11279 | 21:29:22 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33600/tests/kraken/driver.html?testName=imaging-desaturate) 21:29:22 INFO - PROCESS | 11279 | RSS: Main: 153411584 21:29:22 INFO - PROCESS | 11279 | 21:29:25 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33600/tests/kraken/driver.html?testName=json-parse-financial) 21:29:26 INFO - PROCESS | 11279 | RSS: Main: 152809472 21:29:26 INFO - PROCESS | 11279 | 21:29:27 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33600/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:29:28 INFO - PROCESS | 11279 | RSS: Main: 152670208 21:29:28 INFO - PROCESS | 11279 | 21:29:30 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33600/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:29:30 INFO - PROCESS | 11279 | RSS: Main: 152657920 21:29:30 INFO - PROCESS | 11279 | 21:29:32 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33600/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:29:33 INFO - PROCESS | 11279 | RSS: Main: 153059328 21:29:33 INFO - PROCESS | 11279 | 21:29:36 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:29:36 INFO - PROCESS | 11279 | RSS: Main: 152780800 21:29:36 INFO - PROCESS | 11279 | 21:29:39 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:29:40 INFO - PROCESS | 11279 | RSS: Main: 153022464 21:29:40 INFO - PROCESS | 11279 | 21:29:41 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:33600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33600/tests/kraken/driver.html?testName=ai-astar) 21:29:42 INFO - PROCESS | 11279 | RSS: Main: 154943488 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | __start_tp_report 21:29:42 INFO - PROCESS | 11279 | _x_x_mozilla_page_load 21:29:42 INFO - PROCESS | 11279 | _x_x_mozilla_page_load_details 21:29:42 INFO - PROCESS | 11279 | |i|pagename|runs| 21:29:42 INFO - PROCESS | 11279 | |0;ai-astar;103;112;113;113;111;112;112;113;112;113 21:29:42 INFO - PROCESS | 11279 | |1;audio-beat-detection;143;124;123;163;120;122;118;119;139;121 21:29:42 INFO - PROCESS | 11279 | |2;audio-dft;161;162;163;164;162;162;163;160;162;169 21:29:42 INFO - PROCESS | 11279 | |3;audio-fft;74;75;78;106;76;76;76;76;93;76 21:29:42 INFO - PROCESS | 11279 | |4;audio-oscillator;82;83;108;82;82;81;92;81;82;110 21:29:42 INFO - PROCESS | 11279 | |5;imaging-gaussian-blur;118;117;118;117;118;117;117;118;118;117 21:29:42 INFO - PROCESS | 11279 | |6;imaging-darkroom;148;148;148;147;146;147;147;147;147;149 21:29:42 INFO - PROCESS | 11279 | |7;imaging-desaturate;96;98;96;96;96;98;97;96;95;96 21:29:42 INFO - PROCESS | 11279 | |8;json-parse-financial;58;55;55;57;56;63;62;55;59;56 21:29:42 INFO - PROCESS | 11279 | |9;json-stringify-tinderbox;65;64;65;64;65;64;65;65;64;66 21:29:42 INFO - PROCESS | 11279 | |10;stanford-crypto-aes;80;84;76;83;76;75;76;84;76;77 21:29:42 INFO - PROCESS | 11279 | |11;stanford-crypto-ccm;130;132;122;122;124;128;121;119;162;124 21:29:42 INFO - PROCESS | 11279 | |12;stanford-crypto-pbkdf2;156;158;166;157;157;161;163;159;158;163 21:29:42 INFO - PROCESS | 11279 | |13;stanford-crypto-sha256-iterative;63;61;62;62;62;61;59;60;59;60 21:29:42 INFO - PROCESS | 11279 | __end_tp_report 21:29:42 INFO - PROCESS | 11279 | __start_cc_report 21:29:42 INFO - PROCESS | 11279 | _x_x_mozilla_cycle_collect,712 21:29:42 INFO - PROCESS | 11279 | __end_cc_report 21:29:42 INFO - PROCESS | 11279 | __startTimestamp1486618182081__endTimestamp 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | ------- Summary: start ------- 21:29:42 INFO - PROCESS | 11279 | Number of tests: 14 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.03 (2.7%) stddev-sans-first:0.71 21:29:42 INFO - PROCESS | 11279 | Values: 103.0 112.0 113.0 113.0 111.0 112.0 112.0 113.0 112.0 113.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:123.50 stddev:14.63 (11.9%) stddev-sans-first:14.65 21:29:42 INFO - PROCESS | 11279 | Values: 143.0 124.0 123.0 163.0 120.0 122.0 118.0 119.0 139.0 121.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.44 (1.5%) stddev-sans-first:2.50 21:29:42 INFO - PROCESS | 11279 | Values: 161.0 162.0 163.0 164.0 162.0 162.0 163.0 160.0 162.0 169.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:10.47 (13.8%) stddev-sans-first:10.83 21:29:42 INFO - PROCESS | 11279 | Values: 74.0 75.0 78.0 106.0 76.0 76.0 76.0 76.0 93.0 76.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:82.00 stddev:11.38 (13.9%) stddev-sans-first:11.84 21:29:42 INFO - PROCESS | 11279 | Values: 82.0 83.0 108.0 82.0 82.0 81.0 92.0 81.0 82.0 110.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:29:42 INFO - PROCESS | 11279 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 21:29:42 INFO - PROCESS | 11279 | Values: 148.0 148.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 149.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 21:29:42 INFO - PROCESS | 11279 | Values: 96.0 98.0 96.0 96.0 96.0 98.0 97.0 96.0 95.0 96.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:2.91 (5.1%) stddev-sans-first:3.09 21:29:42 INFO - PROCESS | 11279 | Values: 58.0 55.0 55.0 57.0 56.0 63.0 62.0 55.0 59.0 56.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 21:29:42 INFO - PROCESS | 11279 | Values: 65.0 64.0 65.0 64.0 65.0 64.0 65.0 65.0 64.0 66.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.50 stddev:3.68 (4.7%) stddev-sans-first:3.88 21:29:42 INFO - PROCESS | 11279 | Values: 80.0 84.0 76.0 83.0 76.0 75.0 76.0 84.0 76.0 77.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:126.00 stddev:12.51 (9.9%) stddev-sans-first:13.25 21:29:42 INFO - PROCESS | 11279 | Values: 130.0 132.0 122.0 122.0 124.0 128.0 121.0 119.0 162.0 124.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.00 stddev:3.29 (2.1%) stddev-sans-first:3.19 21:29:42 INFO - PROCESS | 11279 | Values: 156.0 158.0 166.0 157.0 157.0 161.0 163.0 159.0 158.0 163.0 21:29:42 INFO - PROCESS | 11279 | 21:29:42 INFO - PROCESS | 11279 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.50 stddev:1.37 (2.2%) stddev-sans-first:1.22 21:29:42 INFO - PROCESS | 11279 | Values: 63.0 61.0 62.0 62.0 62.0 61.0 59.0 60.0 59.0 60.0 21:29:42 INFO - PROCESS | 11279 | -------- Summary: end -------- 21:29:42 INFO - PROCESS | 11279 | 21:29:43 INFO - TEST-INFO | 11279: exit 0 21:29:43 INFO - TEST-OK | kraken | took 60815ms 21:29:43 INFO - SUITE-END | took 1172s 21:29:43 INFO - Completed test suite (00:19:32) 21:29:43 INFO - javascript benchmark 21:29:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7554.41976870285, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.9836100819493, 3297.7032067113955, 3328.5839270091255, 3351.111955331836, 3351.145457908236, 5483.424240454755, 5511.3937466878715, 5533.22534845121, 5534.667919924802, 5537.307836520435, 5532.30846144232, 5614.66312021279, 5617.578681598876, 5618.494335509803, 5635.21107045014, 4926.852194434173, 4986.10250154972, 5034.773435195425, 5043.041822053798, 5073.315102461176, 5023.6985780853265, 5069.239614057884, 5070.898582028357, 5075.441701412841, 5097.184450487923, 4875.9756201219125, 4883.731394773286, 5060.089183946907, 5066.6706664066905, 5067.594592432615, 4938.16051271283, 4956.653034287601, 4992.87517812054, 5012.147934851084, 5076.619253555961, 4970.850874473772, 4999.325091112726, 5017.949820501784, 5020.548150666457, 5027.84916452507, 5503.449655034505, 5518.779248830042, 5583.553315734732, 5588.804391846306, 5603.047481928042, 5755.30936287644, 5761.395053519362, 5784.971075144639, 5821.126830975345, 5842.561807864385, 5889.5288376930175, 5906.173135760997, 5909.37951515089, 5914.231149950522, 5953.851153721148, 5502.5597952163735, 5504.532114770249, 5508.008558459475, 5512.724363781795, 5522.861928451821, 5865.090910908816, 5939.346671866091, 5967.582269241198, 5971.4327138921735, 5990.970045149834, 5846.56150788684, 5920.911186332209, 5936.5547583931375, 5937.910931336033, 5961.046232602763, 5901.262342207224, 5940.435658612425, 5955.970220148872, 5962.731677074542, 5964.135200396005, 5773.826785196451, 5776.68228247442, 5809.302883653989, 5926.525877929756, 5933.762649494059, 5811.360750317462, 5864.7947321844385, 5897.823065308047, 5905.527557795452, 5926.140709597084, 4533.342665313511, 4539.319102134707, 4552.294394368878, 4555.043440877453, 4569.13186494565, 3992.1416895367634, 4000.159966407029, 4053.007013281706, 4067.3695577185586, 4079.4288799568085, 5674.631148975303, 5687.146927960756, 5719.7140142992685, 5784.334801497882, 5826.038703613941, 5978.133170690313, 6018.398160184034, 6025.698715064229, 6035.366286539938, 6037.516998640098, 5566.582506312043, 5604.327480702342, 5636.689982051026, 5781.075027995501, 5792.102224155178, 5017.272495488134, 5069.898602028013, 5094.312267843794, 5097.0, 5101.20931255656, 6173.69131543421, 6183.443490085824, 6184.0, 6184.134221208944, 6199.690015499207, 5826.446487583673, 5937.228160339128, 5948.048312270016, 5952.196453478725, 5954.851128721816, 6014.609050411709, 6027.969860150672, 6032.185654936703, 6033.245844269466, 6179.598326108789, 5794.101914203306, 5805.912911306249, 5823.912641310469, 5848.619839710405, 5868.823935281948, 5897.351291357862, 5942.108683697307, 5950.315713692808, 5953.613015154001, 5956.583039187389, 5660.0, 5726.226959360433, 5729.197912292199, 5738.799142030176, 5763.827085187451, 5804.912926306193, 5813.82558523245, 5823.359430462561, 5823.854403639943, 5829.358770535153, 5785.768569257182, 5795.623284486495, 5804.0, 5806.0, 5812.244408226903, 5731.083026715705, 5740.856478588069, 5797.043487824461, 5800.970995144998, 5807.796727114531, 5780.21967034445, 5806.0, 5808.157817116579, 5814.941850581609, 5859.5019423349495], "value": 5468.881647675219, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.7248641080158, 588.8822235552889, 611.9143319935209, 687.3058211206679, 704.5209257704759, 46266.0, 47167.29249061263, 51477.485225147735, 51477.485225147735, 51517.48482515174, 52159.0, 53244.733776331064, 53247.0, 53297.46702532974, 53308.0, 9299.814003719921, 10815.67552973412, 10903.34579925203, 11235.887641123565, 11352.0, 10864.130869530458, 10980.450977451135, 11005.504752286166, 11019.83470247947, 11028.613998510054, 10993.175511836604, 10994.90050994902, 11076.0, 11080.889191108066, 11092.0, 11001.119910407187, 11003.61487347943, 11009.83485247722, 11046.171537134707, 11060.391678457681, 10953.288036277616, 11033.337999720043, 11074.889251107546, 11075.11399088079, 11084.224104312701, 43559.78220108911, 43606.0, 43804.56195438037, 43935.34096988516, 43972.12055758899, 4290.892727681801, 4349.086691794727, 4438.911221775546, 4509.143262780061, 4516.751578663172, 32443.675563244302, 32854.0, 33112.50331245033, 33114.37153993193, 33435.49846752301, 3991.501062367204, 4080.5511393746665, 4169.499660040784, 4194.454720886265, 4263.722858014219, 380563.0, 380867.0, 380997.0, 383158.0, 383622.0, 63217.36782632115, 63550.0, 64166.0, 64178.67910660417, 64180.35819641744, 66395.66802165959, 66955.0, 67086.66456667783, 67155.66422167858, 67330.3266967324, 16837.0, 17238.224279907434, 19300.1314940828, 19750.90124549397, 19891.801081989284, 15000.0, 15330.846691532943, 15336.616584585252, 15782.842171578366, 15839.0, 20189.192432302836, 20543.8972805135, 20601.278955236496, 20625.381238562568, 20695.06872190725, 7165.856682866313, 7266.818329541804, 7280.890786638205, 7416.814579635445, 7534.924650753532, 969.4958621516772, 970.752458123174, 982.0523195116747, 986.2603047714215, 988.584794386345, 33891.32217355688, 34012.0, 34050.14874628154, 34284.314313713585, 34313.48529772055, 1067.4129228924216, 1178.6581891251442, 1183.5088438298183, 1227.4783217132683, 1230.7353918907477, 17794.199261033285, 17883.398531670508, 17885.025544368047, 17937.37219197322, 18022.061506320162, 327493.0, 329902.0, 330383.0, 330960.0, 331082.0, 68802.0, 69443.0, 69597.65201173961, 69739.30260697429, 69851.0, 1548.620587955958, 1550.643352029017, 1556.120791752656, 1568.3412966554074, 1581.1066747287746, 32605.673943260263, 33084.33831323408, 33515.66484335223, 33566.49650255199, 33706.325873482885, 58878.411215887296, 59366.0, 59392.0, 59551.702241488514, 59647.40352596592, 396944.0, 397463.0, 398005.0, 399441.0, 401209.0, 32006.0, 32633.673663263064, 32642.51036234506, 32898.67101329052, 33002.504962425104, 53020.73489632527, 54052.45947540474, 54189.729051356066, 55252.618684533205, 56235.71882140563, 43814.12371752611, 43868.12263754643, 44707.552924470336, 44946.550534494236, 45786.31320530128, 45332.54667453283, 45449.31826022546, 45565.0, 46130.0, 46181.538184617726, 43498.56501434945, 43889.561104389824, 44103.33844992264, 44234.0, 44428.333574995755, 36608.633913660524, 37945.0, 38620.420693690176, 39205.0, 39546.80226598849, 28159.15522534327, 28209.0, 28217.153485395473, 28361.0, 28405.43189136247], "value": 21858.847926482726, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.89527618095474, 420.379939589106, 438.246216507607, 438.2680922858825, 442.8029526860548, 20160.69758953615, 21170.89414552927, 22165.556688866214, 22299.777002229974, 22369.10523579057, 22440.214592489265, 22727.0, 23514.764852351513, 23529.0, 23634.0, 6150.753969841201, 6151.753929842824, 6341.714622841983, 6379.776707815227, 6399.552031357807, 6126.111713801496, 6275.4979601631985, 6281.780137695182, 6295.118683384307, 6305.9684701576425, 6052.818415447521, 6171.969140154293, 6259.624422534663, 6262.248530176385, 6271.404216599439, 6154.230721159855, 6212.0, 6218.471429928439, 6224.937750622481, 6227.688615569226, 5433.212184233304, 5563.109902415594, 5577.749001294951, 5602.411746766572, 5604.635698679614, 25866.96532138712, 25989.610155847677, 26297.3425664358, 26332.0, 26374.340641483923, 3229.257270827723, 3333.749968752353, 3347.330533893207, 3382.3742607617423, 3400.9829950850335, 15954.44159454425, 15956.361745530165, 16209.91895040529, 16395.60637345827, 16495.175241237892, 2031.522592190834, 2077.1587507059667, 2078.844086693504, 2087.332053742803, 2100.6638937769885, 95502.0, 95693.5215323919, 96480.0, 96877.5156124222, 98872.50563747135, 12089.455974481169, 12383.69040773988, 12439.813402798965, 12497.687557811127, 12522.937385313015, 17658.293668253384, 17710.291588336324, 17761.911190443963, 17775.46673599794, 17782.377616783608, 9402.717918462457, 9700.466474343837, 9770.706878793648, 9788.461634610023, 9879.456629885282, 9558.856617150748, 9572.808543829084, 9603.663871764455, 9630.422174669402, 9781.462019588991, 7612.391008719289, 7873.763787086396, 7882.330001949784, 7882.527048377001, 8106.432549721463, 2136.42316574524, 2155.2887547109417, 2161.8594791338514, 2186.4533866533366, 2217.9001944912516, 1169.7774228965034, 1176.1120354132574, 1198.0714945916984, 1198.9880101198876, 1212.442276552778, 20657.380278591667, 21093.472663183544, 21112.78887211139, 21216.78783212179, 21266.680999785014, 1172.8240763885485, 1182.633383651071, 1197.9395439843456, 1208.3112625803208, 1217.2027322104036, 11447.713807154887, 11917.106217033757, 12171.695707607203, 12218.144729868824, 12268.938655306845, 660879.0, 672146.0, 685345.0, 748817.0, 752106.0, 95471.0, 95483.0, 99270.0, 100349.49825250827, 100934.49532752436, 1118.6532175025932, 1119.6641007697658, 1153.9942300288444, 1154.988450115505, 1163.650904728578, 17964.371247006293, 18083.728744069114, 18161.091945402943, 18218.635627287644, 18620.255189792257, 41358.79320603378, 42625.5737442634, 43072.56927430686, 43394.349084763126, 43912.0, 62482.68758656178, 62762.0, 63256.36743632689, 63525.364746351945, 65312.67343663251, 6567.014947757683, 7455.776326710207, 9612.807743845224, 9675.274354423587, 9729.951350243487, 10891.455427228448, 13642.181469111885, 14110.647233819236, 14525.564233073024, 15057.47298844579, 12798.616041518397, 12833.679158021125, 12902.354882256037, 12905.741885162432, 12937.417816198105, 12370.62888113358, 12620.684482887635, 12704.0, 13075.215487070805, 13091.41088651032, 12328.19866708661, 12580.622581322576, 12939.0, 13077.542286019943, 13348.332583370599, 9615.56729947168, 9694.0, 9738.707838764849, 9952.203823693942, 9971.60113595477, 12343.259404435763, 12691.873081269068, 12855.16441431304, 13116.475340986253, 13131.146475479063], "value": 10595.769712155512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.829244636867, 1485.3019081031914, 1493.3056128900066, 1498.61036130606, 1509.0719207687273, 7703.191164927686, 8076.232757888006, 8082.232187942143, 8181.672733090677, 8401.201885820838, 8534.957325213381, 8643.222110010098, 8659.870101948476, 8689.174528419806, 8702.086280940504, 2405.56699794037, 2407.8194135439867, 2416.4200591857916, 2433.051110067075, 2435.025989604155, 2342.847714898535, 2397.1729753235104, 2403.9158629447975, 2408.987955060231, 2411.963820542693, 2307.48081681622, 2317.7102862142233, 2319.257837492003, 2339.847909885852, 2340.953180936389, 2264.4338915271182, 2270.421042634126, 2273.976710480274, 2286.4741109544816, 2290.3815969688176, 2188.3544354415485, 2228.721409823772, 2229.1306390507716, 2229.9665505017438, 2233.6649502574583, 8425.578721063923, 8432.620532076071, 8482.448640838325, 8513.0, 8517.403781735282, 5199.6360254782185, 5327.360716713981, 5334.119870221409, 5340.572754179656, 5347.973260133714, 3217.227865312308, 3362.9406736877804, 3386.9661303386897, 3421.5894092708786, 3461.359648465042, 1382.1361648969394, 1411.4636438153436, 1458.8759955403698, 1475.4762059468842, 1476.2840022589037, 11072.114230861513, 11094.889051109547, 11142.944285278603, 11143.777124457547, 11238.325700458, 4363.759993200341, 4429.114177164515, 4501.662375321864, 4570.314452832035, 4621.560951709582, 9246.676366327147, 9271.860922086174, 9294.302927280345, 9332.300077494216, 9343.159115679622, 5223.190405487156, 5246.4753524647995, 5291.1798671206025, 5294.41761406245, 5295.338082739658, 4669.089527542164, 4822.397200349957, 4845.9030819383415, 4939.135651261086, 4953.6532442729385, 3817.7327587069194, 3933.7443066200603, 3952.604739526082, 3996.680265578747, 4005.639492445694, 1187.7446349035, 1189.0725234317247, 1190.2025642819333, 1194.964151075469, 1195.838561794164, 990.3711143423977, 997.4464172384396, 1003.3428104591504, 1007.5566750629699, 1017.4099022566893, 5325.760340784674, 5433.6196466247775, 5466.3713672928125, 5548.528375088082, 5607.467290607386, 605.7183409714504, 608.9786857459968, 615.1910238036967, 630.4956035171845, 638.3680156644888, 3662.432322989941, 3678.1356381250384, 3775.7734535927934, 3824.674902633252, 4006.358982562776, 9418.199453046567, 9793.21654267657, 9804.460754658563, 9826.312158149003, 9829.262805289489, 9852.359596626196, 9937.602495900082, 9942.950285248528, 9946.45294508809, 9969.501524923724, 7960.2039796019935, 7975.521468711896, 8008.0, 8026.077001144943, 8052.436329456999, 5500.972495137498, 5507.091329930517, 5607.271054763018, 5617.241672374177, 5654.604177707521, 9106.95446522763, 9149.359544832065, 9209.907900920905, 9309.581068851783, 9321.114494123047, 8991.14584114508, 9253.491057991874, 9279.164875161268, 9401.34190606651, 9449.007854175212, 7097.432205423657, 7105.147382314155, 7145.428365730625, 7155.284471552803, 7187.31720486553, 7706.190849960673, 7713.112992005991, 7735.381169506313, 7743.341815945708, 7787.844243115219, 7198.0, 7246.0, 7337.779866604011, 7342.0, 7512.586807725409, 7155.391791697556, 7156.463265255023, 7163.06880105583, 7182.4613154014705, 7229.240929702306, 6391.360863913572, 6507.511936604868, 6515.73937042513, 6550.8362290943105, 6598.37315455031, 4704.482506924304, 4803.1354356214815, 4805.13507568627, 4929.433115191656, 4944.752762361795, 5013.323201367769, 5052.772625231947, 5129.179331306973, 5144.151215049625, 5191.974040129775], "value": 4434.800744055427, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.4923599320883, 395.32991579273136, 405.6065616352141, 410.79870863277006, 411.21252800886305, 5490.368607610126, 5517.503424691777, 5579.2746942897365, 5587.720613969301, 5596.720163991799, 5223.973880130594, 5455.372632147304, 5486.506214440699, 5510.531604813586, 5515.586331025169, 4348.586884246008, 4359.564043595647, 4361.49842768081, 4366.934495982563, 4370.169667763131, 4361.498427680825, 4362.847300344489, 4363.956360436403, 4414.713043652168, 4414.7351158930405, 3972.82122304497, 4118.217538667644, 4169.3954376615375, 4363.8435814509185, 4374.300111982084, 4131.347461015588, 4131.483564554431, 4146.688998325138, 4168.707700612805, 4168.7081904266715, 3672.100335417813, 3677.632236776301, 3678.393065144248, 3678.5769636491877, 3681.742278040538, 5272.314599102092, 5354.625176237665, 5357.491038351351, 5357.973210133963, 5382.838514844561, 4860.343853579792, 4884.487128851455, 4897.3878265216845, 4908.337374454439, 4909.705417674915, 5748.223989761413, 5752.913706294409, 5753.0, 5786.189933409326, 5804.303483581955, 3941.881743547698, 4082.2447847148374, 4116.75299482032, 4127.772972486512, 4132.710710250284, 5746.954114319417, 5888.440598143126, 5928.318243402021, 5955.731992060324, 5958.195643588104, 4239.59723826236, 4248.893777655521, 4263.76549289792, 4265.402843601898, 4287.65698744106, 4331.0904710011255, 4336.132773445261, 4337.0, 4349.630281426114, 4350.847720329773, 4830.106430310334, 4865.635077369211, 4912.238603016467, 4913.729744863996, 4968.677035992649, 5710.486056254957, 5749.981259838618, 5765.85585360361, 5794.391588883191, 5811.418858114154, 1402.5231421316598, 1424.4159894443228, 1427.8220468113848, 1427.9714405711827, 1430.4336751257356, 964.6961207219704, 1004.4525733475127, 1011.1304278320638, 1013.761765984993, 1025.092792878308, 5346.625736198429, 5400.6759594423675, 5442.523651738449, 5502.487959872866, 5508.7521061552325, 5666.603337766317, 5783.826485205451, 5790.681512516852, 5811.883762324815, 5812.593118481665, 5351.759170837322, 5433.239346491494, 5439.755211015514, 5610.85972850682, 5669.744861481243, 3047.756179505634, 3066.6933306669152, 3069.8772049118234, 3078.2150551609197, 3080.922976925595, 5696.3733989261145, 5884.499817515473, 5942.346341902387, 6006.255058503733, 6009.849753756191, 5799.637085284955, 5806.0, 5834.565730045196, 5841.795537156179, 5846.930361560215, 5904.291485021739, 5921.61509501881, 5953.315368732565, 6018.969905150446, 6061.818145455643, 5638.069718496567, 5660.830175094754, 5680.375158732453, 5782.1615865698395, 5803.419658034163, 5689.34572524165, 5700.714964251853, 5728.312602487728, 5737.942620573741, 5742.626729262584, 5952.0, 5961.940380596138, 6137.41694539018, 6156.891759483156, 6168.845778855564, 4281.1651727914, 4290.1205252922455, 4317.136572685413, 4323.52441231458, 4325.447985688459, 5739.253896993364, 5909.645421274738, 5986.401359864153, 5996.2504686914135, 6004.249468816398, 5744.6265992712015, 5757.280339957505, 5762.683052432157, 5801.1878337033695, 5804.920694392406, 5747.827565173052, 5781.479666829838, 5803.448672376117, 5805.709714514173, 5823.5923485355615, 5496.395396506301, 5727.570432217683, 5737.827865164052, 5754.726882881322, 5773.3072031356505, 5755.755255450294, 5765.135229715576, 5839.474447299764, 5845.386234445322, 5856.648601083778, 5570.777168913198, 5726.856828579319, 5730.799422020209, 5735.9388513125205, 5746.7701291949525], "value": 4395.873790798802, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.6452886798166, 828.983420331593, 848.5375470368648, 914.5290175559586, 952.4380615436893, 15867.206639667998, 16111.83888161118, 16529.173541322914, 16529.50411487656, 17651.205695743705, 15681.510256525611, 15728.606784830385, 15947.20263986799, 15983.360665573393, 16194.676106477864, 820.9343252539798, 835.0230230630146, 840.1682334488873, 840.861257892447, 841.1924552429675, 804.7304153108715, 826.8181000179981, 831.3473922970439, 834.7412302186311, 840.504102579478, 870.5516658920629, 875.1817051057282, 878.4992554244084, 880.6125304865839, 881.995590022049, 877.7410663854179, 881.5592203898051, 881.8368601808654, 882.6469412235093, 882.6778225947515, 633.8732253549263, 635.6249812610582, 642.4218203616736, 643.572024603638, 644.4103645164669, 16351.182440878027, 16695.83304166967, 16822.495325140266, 16845.32618695251, 16941.0, 14890.0, 14998.925005375013, 15068.171250581214, 15094.924525377413, 15390.692186156215, 11304.943475282653, 11330.150238732129, 11398.544058237661, 11417.486213120346, 11424.771504569862, 3937.8621748238675, 3969.444277801081, 3980.641742243212, 3994.840206391741, 4086.6322031017053, 57762.13356799651, 58510.414895850925, 68614.31385686129, 77257.0, 77773.61113194398, 11351.772964540663, 11612.535498579962, 11679.766404671858, 12220.816687749691, 12339.383030848421, 20794.584108317747, 23294.883525582263, 23666.7633323668, 23688.40778980505, 23746.168884088973, 8504.957475212585, 8557.957210214034, 8602.483850968962, 8669.21977022071, 8766.95616521926, 4658.604018658452, 4678.719276843401, 4739.834105806281, 4744.122337367598, 4771.570558649738, 3606.2787442511603, 3705.110773414361, 3724.0875985383755, 3744.925101498009, 3756.511653485084, 636.2810024672091, 640.2445114764622, 646.4860435953428, 647.3688154049764, 657.6317262333109, 634.4987459906714, 643.2634633344794, 655.7639249870043, 658.7365053978447, 662.493192707579, 10970.177236707279, 11068.3912384818, 11173.329600224013, 11382.772344553228, 11407.714807129889, 774.4888373673349, 781.800640836583, 792.4096548071724, 810.1736229046339, 816.4529765057307, 5427.240186373911, 5478.808241711521, 5542.251796007487, 5606.887862242814, 5635.8591035224445, 86711.0, 86855.0, 87887.56056219806, 89431.55284223537, 89924.20151597062, 73664.0, 73948.0, 75401.0, 75842.62078689571, 77373.45253094907, 61409.385906140364, 62431.0, 63150.36849631445, 64710.676446617465, 65221.34778652248, 10034.498275086362, 10557.841632375366, 10579.4710264488, 10614.681559553226, 10684.786304273715, 45250.32124518069, 45518.54481455143, 46134.0, 46205.458699771836, 47136.764316178196, 57338.0, 59126.40873591209, 59314.0, 59901.0, 61822.0, 12411.0, 12704.872951270369, 12739.872601273868, 12773.425195866394, 13068.477260909458, 13185.208887466782, 13370.665733356744, 13532.0, 13858.16850988944, 14140.080894741808, 13207.207567545978, 13646.795298070736, 13672.794908076188, 13726.45094196221, 14125.576232713034, 13826.30868456553, 13930.373133209232, 13953.441862325393, 14076.718465630835, 14168.362423690753, 12783.296918669563, 13501.0, 13533.796993044914, 13538.120022198525, 14084.718305633625, 11537.82693259585, 11574.6527604172, 11682.88317116818, 11849.881501184878, 12271.57049503263, 10571.2600117991, 10641.255112142077, 10797.838032429363, 10812.56749730002, 10817.891821081688], "value": 7526.261389328244, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1483.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 113.0, 111.0, 112.0, 112.0, 113.0, 112.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 124.0, 123.0, 163.0, 120.0, 122.0, 118.0, 119.0, 139.0, 121.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 164.0, 162.0, 162.0, 163.0, 160.0, 162.0, 169.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 78.0, 106.0, 76.0, 76.0, 76.0, 76.0, 93.0, 76.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 108.0, 82.0, 82.0, 81.0, 92.0, 81.0, 82.0, 110.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 149.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 98.0, 97.0, 96.0, 95.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 57.0, 56.0, 63.0, 62.0, 55.0, 59.0, 56.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 66.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 76.0, 83.0, 76.0, 75.0, 76.0, 84.0, 76.0, 77.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 122.0, 122.0, 124.0, 128.0, 121.0, 119.0, 162.0, 124.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 166.0, 157.0, 157.0, 161.0, 163.0, 159.0, 158.0, 163.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 62.0, 62.0, 61.0, 59.0, 60.0, 59.0, 60.0], "value": 60.9, "unit": "score"}]}]} 21:29:43 INFO - Return code: 0 21:29:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:29:43 ERROR - # TBPL SUCCESS # 21:29:43 INFO - Running post-action listener: _resource_record_post_action 21:29:43 INFO - [mozharness: 2017-02-09 05:29:43.397378Z] Finished run-tests step (success) 21:29:43 INFO - Running post-run listener: _resource_record_post_run 21:29:43 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 364122112; Read time: 20; Write time: 270720 21:29:43 INFO - TinderboxPrint: CPU usage
13.3% 21:29:43 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 20 21:29:43 INFO - TinderboxPrint: I/O write bytes / time
364,122,112 / 270,720 21:29:43 INFO - TinderboxPrint: CPU idle
8,222.8 (86.7%) 21:29:43 INFO - TinderboxPrint: CPU user
1,207.0 (12.7%) 21:29:43 INFO - TinderboxPrint: Swap in / out
0 / 0 21:29:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110108672; Read time: 0; Write time: 107540 21:29:43 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 254013440; Read time: 20; Write time: 163180 21:29:44 INFO - Running post-run listener: _upload_blobber_files 21:29:44 INFO - Blob upload gear active. 21:29:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:29: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 21:29: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:29: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:29:44 INFO - (blobuploader) - INFO - Open directory for files ... 21:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:29:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:45 INFO - (blobuploader) - INFO - Done attempting. 21:29:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:29:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:29:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:48 INFO - (blobuploader) - INFO - Done attempting. 21:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:49 INFO - (blobuploader) - INFO - Done attempting. 21:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:50 INFO - (blobuploader) - INFO - Done attempting. 21:29:50 INFO - (blobuploader) - INFO - Iteration through files over. 21:29:50 INFO - Return code: 0 21:29:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:29:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:29:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6c91d4dbe98916e15f3da940fdb83be8a9a74f7088195d492cd9df1f574dfc6bb7f69ee8ae4bca3c221885158af371954f9649348a866b0f552386276699da33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/771ecf302932f60c53edf0693ad8c0ed534b0bb09d253f1a8cd64c1c99ef859bbb003fdd8daa403dcc9362550b3901da830ae3cee376cc8d17293109511b4d2b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a6ba45b7e7ceb8154ed365a1dc55dd74e1e84a1732eaa8a92a7b34a69f2e24634a8d478d79cda422088062725bc9eea9d87dd2bb2139810d21c1187a3c293b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b090a02bb68003384d77280fbfa0048a7aa2612028bcbea3616bf8bc22a9b5a60d4e75ccc1dc04537c34f7e8ae9c4884a3decef4d2c1fdb57d952dbbdb8f3ad1"} 21:29:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:29:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:29:50 INFO - Contents: 21:29:50 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6c91d4dbe98916e15f3da940fdb83be8a9a74f7088195d492cd9df1f574dfc6bb7f69ee8ae4bca3c221885158af371954f9649348a866b0f552386276699da33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/771ecf302932f60c53edf0693ad8c0ed534b0bb09d253f1a8cd64c1c99ef859bbb003fdd8daa403dcc9362550b3901da830ae3cee376cc8d17293109511b4d2b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a6ba45b7e7ceb8154ed365a1dc55dd74e1e84a1732eaa8a92a7b34a69f2e24634a8d478d79cda422088062725bc9eea9d87dd2bb2139810d21c1187a3c293b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b090a02bb68003384d77280fbfa0048a7aa2612028bcbea3616bf8bc22a9b5a60d4e75ccc1dc04537c34f7e8ae9c4884a3decef4d2c1fdb57d952dbbdb8f3ad1"} 21:29:50 INFO - Running post-run listener: copy_logs_to_upload_dir 21:29:50 INFO - Copying logs to upload dir... 21:29:50 INFO - mkdir: /builds/slave/test/build/upload/logs 21:29:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.380260 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-08 21:29:49.986116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 21:29:49.989447) ========= 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=20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943 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-Non-PGO/sha512/6c91d4dbe98916e15f3da940fdb83be8a9a74f7088195d492cd9df1f574dfc6bb7f69ee8ae4bca3c221885158af371954f9649348a866b0f552386276699da33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/771ecf302932f60c53edf0693ad8c0ed534b0bb09d253f1a8cd64c1c99ef859bbb003fdd8daa403dcc9362550b3901da830ae3cee376cc8d17293109511b4d2b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a6ba45b7e7ceb8154ed365a1dc55dd74e1e84a1732eaa8a92a7b34a69f2e24634a8d478d79cda422088062725bc9eea9d87dd2bb2139810d21c1187a3c293b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b090a02bb68003384d77280fbfa0048a7aa2612028bcbea3616bf8bc22a9b5a60d4e75ccc1dc04537c34f7e8ae9c4884a3decef4d2c1fdb57d952dbbdb8f3ad1"} build_url:https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011497 build_url: 'https://queue.taskcluster.net/v1/task/e8m8RZB1S36J0OzXvDc99w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6c91d4dbe98916e15f3da940fdb83be8a9a74f7088195d492cd9df1f574dfc6bb7f69ee8ae4bca3c221885158af371954f9649348a866b0f552386276699da33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/771ecf302932f60c53edf0693ad8c0ed534b0bb09d253f1a8cd64c1c99ef859bbb003fdd8daa403dcc9362550b3901da830ae3cee376cc8d17293109511b4d2b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a6ba45b7e7ceb8154ed365a1dc55dd74e1e84a1732eaa8a92a7b34a69f2e24634a8d478d79cda422088062725bc9eea9d87dd2bb2139810d21c1187a3c293b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b090a02bb68003384d77280fbfa0048a7aa2612028bcbea3616bf8bc22a9b5a60d4e75ccc1dc04537c34f7e8ae9c4884a3decef4d2c1fdb57d952dbbdb8f3ad1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 21:29:50.018957) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 21:29:50.019852) ========= 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=20e20d796406ba5117c4a6f1000001ba-1486616953.935504-8533943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 21:29:50.102104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 21:29:50.102863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 21:29:50.103562) ========= ========= Total master_lag: 0.17 =========