builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1486101374.85 results: success (0) revision: b1c08aabf905f83f12afac1ce4e1925add6c9bea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:14.849396) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:14.850470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:14.851245) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:14.868016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:14.868704) ========= 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=836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-02 21:56:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2017-02-02 21:56:15 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:15.017076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:15.017840) ========= 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=836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014344 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:15.077156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 21:56:15.077988) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1c08aabf905f83f12afac1ce4e1925add6c9bea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b1c08aabf905f83f12afac1ce4e1925add6c9bea --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=836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-02 21:56:15,226 truncating revision to first 12 chars 2017-02-02 21:56:15,227 Setting DEBUG logging. 2017-02-02 21:56:15,227 attempt 1/10 2017-02-02 21:56:15,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1c08aabf905?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 21:56:16,424 unpacking tar archive at: mozilla-central-b1c08aabf905/testing/mozharness/ program finished with exit code 0 elapsedTime=1.571385 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 21:56:16.667965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:16.668764) ========= script_repo_revision: b1c08aabf905f83f12afac1ce4e1925add6c9bea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:16.669677) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:16.670360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 21:56:16.680617) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-02-02 21:56:16.681245) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:56:16 INFO - MultiFileLogger online at 20170202 21:56:16 in /builds/slave/test 21:56:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:56:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:56:16 INFO - {'append_to_log': False, 21:56:16 INFO - 'base_work_dir': '/builds/slave/test', 21:56:16 INFO - 'blob_upload_branch': 'Firefox', 21:56:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:56:16 INFO - 'branch': 'Firefox', 21:56:16 INFO - 'buildbot_json_path': 'buildprops.json', 21:56:16 INFO - 'config_files': ('talos/linux_config.py',), 21:56:16 INFO - 'default_actions': ('clobber', 21:56:16 INFO - 'read-buildbot-config', 21:56:16 INFO - 'download-and-extract', 21:56:16 INFO - 'populate-webroot', 21:56:16 INFO - 'create-virtualenv', 21:56:16 INFO - 'install', 21:56:16 INFO - 'run-tests'), 21:56:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:56:16 INFO - 'download_minidump_stackwalk': True, 21:56:16 INFO - 'download_symbols': 'ondemand', 21:56:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:56:16 INFO - 'tooltool.py': '/tools/tooltool.py', 21:56:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:56:16 INFO - '/tools/misc-python/virtualenv.py')}, 21:56:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:56:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:56:16 INFO - 'installer_path': 'installer.exe', 21:56:16 INFO - 'log_level': 'info', 21:56:16 INFO - 'log_name': 'talos', 21:56:16 INFO - 'log_to_console': True, 21:56:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:56:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:56:16 INFO - 'opt_config_files': (), 21:56:16 INFO - 'pip_index': False, 21:56:16 INFO - 'sps_profile': False, 21:56:16 INFO - 'sps_profile_interval': 0, 21:56:16 INFO - 'suite': 'dromaeojs', 21:56:16 INFO - 'system_bits': '32', 21:56:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:56:16 INFO - 'title': 'talos-linux64-ix-028', 21:56:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:56:16 INFO - 'use_talos_json': True, 21:56:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:56:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:56:16 INFO - 'work_dir': 'build'} 21:56:16 INFO - [mozharness: 2017-02-03 05:56:16.925188Z] Running clobber step. 21:56:16 INFO - Running pre-action listener: _resource_record_pre_action 21:56:16 INFO - Running main action method: clobber 21:56:16 INFO - rmtree: /builds/slave/test/build 21:56:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:56:17 INFO - Running post-action listener: _resource_record_post_action 21:56:17 INFO - [mozharness: 2017-02-03 05:56:17.442828Z] Finished clobber step (success) 21:56:17 INFO - [mozharness: 2017-02-03 05:56:17.442930Z] Running read-buildbot-config step. 21:56:17 INFO - Running pre-action listener: _resource_record_pre_action 21:56:17 INFO - Running main action method: read_buildbot_config 21:56:17 INFO - Using buildbot properties: 21:56:17 INFO - { 21:56:17 INFO - "project": "", 21:56:17 INFO - "product": "firefox", 21:56:17 INFO - "who": "philringnalda@gmail.com", 21:56:17 INFO - "installer_path": "public/build/target.tar.bz2", 21:56:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:56:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:56:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:56:17 INFO - "stage_platform": "linux64-pgo", 21:56:17 INFO - "basedir": "/builds/slave/test", 21:56:17 INFO - "buildnumber": 18, 21:56:17 INFO - "platform": "ubuntu64_hw", 21:56:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:56:17 INFO - "slavebuilddir": "test", 21:56:17 INFO - "taskId": "SI2TvZWcTL2Gkz8UAMgxWg", 21:56:17 INFO - "branch": "mozilla-central", 21:56:17 INFO - "script_repo_revision": "production", 21:56:17 INFO - "revision": "b1c08aabf905f83f12afac1ce4e1925add6c9bea", 21:56:17 INFO - "slavename": "talos-linux64-ix-028", 21:56:17 INFO - "repo_path": "mozilla-central" 21:56:17 INFO - } 21:56:17 INFO - Finding installer, test and symbols from parent task. 21:56:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SI2TvZWcTL2Gkz8UAMgxWg'}, attempt #1 21:56:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SI2TvZWcTL2Gkz8UAMgxWg'}, attempt #1 21:56:18 INFO - Task dependencies: bfcZiJQYToiueEisYE4jsQ 21:56:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ'}, attempt #1 21:56:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.tar.bz2 21:56:18 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/test_packages.json 21:56:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.crashreporter-symbols.zip 21:56:18 INFO - Running post-action listener: _resource_record_post_action 21:56:18 INFO - [mozharness: 2017-02-03 05:56:18.855001Z] Finished read-buildbot-config step (success) 21:56:18 INFO - [mozharness: 2017-02-03 05:56:18.855219Z] Running download-and-extract step. 21:56:18 INFO - Running pre-action listener: _resource_record_pre_action 21:56:18 INFO - Running main action method: download_and_extract 21:56:18 INFO - mkdir: /builds/slave/test/build/tests 21:56: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:56:18 INFO - trying https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.test_packages.json 21:56:18 INFO - Downloading https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:56:19 INFO - Downloaded 896 bytes. 21:56:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:56:19 INFO - Using the following test package requirements: 21:56:19 INFO - {u'common': [u'target.common.tests.zip'], 21:56:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:56:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:56:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:56:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:56:19 INFO - u'mozbase': [u'target.common.tests.zip'], 21:56:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:56:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:56:19 INFO - u'web-platform': [u'target.common.tests.zip', 21:56:19 INFO - u'target.web-platform.tests.zip'], 21:56:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:56:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:56:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.common.tests.zip 21:56:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:56:19 INFO - Fetch https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.common.tests.zip into memory 21:56:20 INFO - Expected file size: 41751393 21:56:20 INFO - Obtained file size: 41751393 21:56:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:56:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.common.tests.zip 21:56:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:56:24 INFO - Fetch https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.common.tests.zip into memory 21:56:25 INFO - Expected file size: 41751393 21:56:25 INFO - Obtained file size: 41751393 21:56:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.talos.tests.zip 21:56:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:56:30 INFO - Fetch https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.talos.tests.zip into memory 21:56:31 INFO - Expected file size: 14403454 21:56:31 INFO - Obtained file size: 14403454 21:56:31 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:56:31 INFO - trying https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.tar.bz2 21:56:31 INFO - Downloading https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:56:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:56:32 INFO - Downloaded 61843968 bytes. 21:56:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.tar.bz2 21:56:32 INFO - mkdir: /builds/slave/test/properties 21:56:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:56:32 INFO - Writing to file /builds/slave/test/properties/build_url 21:56:32 INFO - Contents: 21:56:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.tar.bz2 21:56:32 INFO - Running post-action listener: _resource_record_post_action 21:56:32 INFO - Running post-action listener: set_extra_try_arguments 21:56:32 INFO - [mozharness: 2017-02-03 05:56:32.465519Z] Finished download-and-extract step (success) 21:56:32 INFO - [mozharness: 2017-02-03 05:56:32.465617Z] Running populate-webroot step. 21:56:32 INFO - Running pre-action listener: _resource_record_pre_action 21:56:32 INFO - Running main action method: populate_webroot 21:56:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:32 INFO - '--tppagecycles', 21:56:32 INFO - '7'], 21:56:32 INFO - 'tests': ['tsvgm']}}, 21:56:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:56:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:56:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:56:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:56:32 INFO - 'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:56:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:56:32 INFO - 'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['damp', 'tps']}, 21:56:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:56:32 INFO - 'tests': ['damp', 'tps']}, 21:56:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['dromaeo_dom']}, 21:56:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:56:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['basic_compositor_video']}, 21:56:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:56:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['a11yr', 21:56:32 INFO - 'ts_paint', 21:56:32 INFO - 'tpaint', 21:56:32 INFO - 'sessionrestore', 21:56:32 INFO - 'sessionrestore_no_auto_restore', 21:56:32 INFO - 'tabpaint']}, 21:56:32 INFO - 'other-e10s': {'tests': ['a11yr', 21:56:32 INFO - 'ts_paint', 21:56:32 INFO - 'tpaint', 21:56:32 INFO - 'sessionrestore', 21:56:32 INFO - 'sessionrestore_no_auto_restore', 21:56:32 INFO - 'tabpaint']}, 21:56:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:56:32 INFO - 'ts_paint', 21:56:32 INFO - 'tpaint', 21:56:32 INFO - 'sessionrestore', 21:56:32 INFO - 'sessionrestore_no_auto_restore', 21:56:32 INFO - 'tabpaint']}, 21:56:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:56:32 INFO - 'ts_paint', 21:56:32 INFO - 'tpaint', 21:56:32 INFO - 'sessionrestore', 21:56:32 INFO - 'sessionrestore_no_auto_restore', 21:56:32 INFO - 'tabpaint']}, 21:56:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['a11yr', 21:56:32 INFO - 'ts_paint', 21:56:32 INFO - 'tpaint', 21:56:32 INFO - 'sessionrestore', 21:56:32 INFO - 'sessionrestore_no_auto_restore', 21:56:32 INFO - 'tabpaint']}, 21:56:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['a11yr', 21:56:32 INFO - 'ts_paint', 21:56:32 INFO - 'tpaint', 21:56:32 INFO - 'sessionrestore', 21:56:32 INFO - 'sessionrestore_no_auto_restore', 21:56:32 INFO - 'tabpaint']}, 21:56:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['tsvgx', 21:56:32 INFO - 'tsvgr_opacity', 21:56:32 INFO - 'tart', 21:56:32 INFO - 'tscrollx', 21:56:32 INFO - 'cart', 21:56:32 INFO - 'tsvg_static']}, 21:56:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:56:32 INFO - 'tsvgr_opacity', 21:56:32 INFO - 'tart', 21:56:32 INFO - 'tscrollx', 21:56:32 INFO - 'cart', 21:56:32 INFO - 'tsvg_static']}, 21:56:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:56:32 INFO - 'talos_options': ['--disable-e10s'], 21:56:32 INFO - 'tests': ['tp5o']}, 21:56:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:56:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:56:32 INFO - 'talos_options': ['--disable-e10s', 21:56:32 INFO - '--xperf_path', 21:56:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:32 INFO - 'tests': ['tp5n']}, 21:56:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:56:32 INFO - 'talos_options': ['--xperf_path', 21:56:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:32 INFO - 'tests': ['tp5n']}}, 21:56:32 INFO - 'talos.zip': {'path': '', 21:56:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:32 INFO - Running post-action listener: _resource_record_post_action 21:56:32 INFO - [mozharness: 2017-02-03 05:56:32.478724Z] Finished populate-webroot step (success) 21:56:32 INFO - [mozharness: 2017-02-03 05:56:32.478818Z] Running create-virtualenv step. 21:56:32 INFO - Running pre-action listener: _resource_record_pre_action 21:56:32 INFO - Running main action method: create_virtualenv 21:56:32 INFO - Creating virtualenv /builds/slave/test/build/venv 21:56:32 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:56:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:56:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:32 INFO - Using real prefix '/usr' 21:56:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:56:33 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:35 INFO - Installing pip.................done. 21:56:35 INFO - Return code: 0 21:56:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:56:35 INFO - Reading from file tmpfile_stdout 21:56:35 INFO - Output received: 21:56:35 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:56:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:35 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:35 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:56:35 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:56:35 INFO - Using env: {'DISPLAY': ':0', 21:56:35 INFO - 'HOME': '/home/cltbld', 21:56:35 INFO - 'LANG': 'en_US.UTF-8', 21:56:35 INFO - 'LANGUAGE': 'en_US:en', 21:56:35 INFO - 'LOGNAME': 'cltbld', 21:56:35 INFO - 'MAIL': '/var/mail/cltbld', 21:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:35 INFO - 'MOZ_NO_REMOTE': '1', 21:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:35 INFO - 'NO_EM_RESTART': '1', 21:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:35 INFO - 'PWD': '/builds/slave/test', 21:56:35 INFO - 'SHELL': '/bin/bash', 21:56:35 INFO - 'SHLVL': '1', 21:56:35 INFO - 'TERM': 'linux', 21:56:35 INFO - 'TMOUT': '86400', 21:56:35 INFO - 'USER': 'cltbld', 21:56:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:35 INFO - '_': '/tools/buildbot/bin/python'} 21:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:35 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:56:35 INFO - Cleaning up... 21:56:35 INFO - Return code: 0 21:56:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:35 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:35 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:56:35 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:56:35 INFO - Using env: {'DISPLAY': ':0', 21:56:35 INFO - 'HOME': '/home/cltbld', 21:56:35 INFO - 'LANG': 'en_US.UTF-8', 21:56:35 INFO - 'LANGUAGE': 'en_US:en', 21:56:35 INFO - 'LOGNAME': 'cltbld', 21:56:35 INFO - 'MAIL': '/var/mail/cltbld', 21:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:35 INFO - 'MOZ_NO_REMOTE': '1', 21:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:35 INFO - 'NO_EM_RESTART': '1', 21:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:35 INFO - 'PWD': '/builds/slave/test', 21:56:35 INFO - 'SHELL': '/bin/bash', 21:56:35 INFO - 'SHLVL': '1', 21:56:35 INFO - 'TERM': 'linux', 21:56:35 INFO - 'TMOUT': '86400', 21:56:35 INFO - 'USER': 'cltbld', 21:56:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:35 INFO - '_': '/tools/buildbot/bin/python'} 21:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:35 INFO - Downloading/unpacking psutil>=3.1.1 21:56:35 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:56:35 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:56:35 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:56:35 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:56:35 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:56:35 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:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:37 INFO - Installing collected packages: psutil 21:56:37 INFO - Running setup.py install for psutil 21:56:37 INFO - building 'psutil._psutil_linux' extension 21:56:37 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:56:38 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:56:38 INFO - building 'psutil._psutil_posix' extension 21:56:38 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:56:38 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:56:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:38 INFO - Successfully installed psutil 21:56:38 INFO - Cleaning up... 21:56:38 INFO - Return code: 0 21:56:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:56:38 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:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:38 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:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:38 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:38 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:56:38 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:56:38 INFO - Using env: {'DISPLAY': ':0', 21:56:38 INFO - 'HOME': '/home/cltbld', 21:56:38 INFO - 'LANG': 'en_US.UTF-8', 21:56:38 INFO - 'LANGUAGE': 'en_US:en', 21:56:38 INFO - 'LOGNAME': 'cltbld', 21:56:38 INFO - 'MAIL': '/var/mail/cltbld', 21:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:38 INFO - 'MOZ_NO_REMOTE': '1', 21:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:38 INFO - 'NO_EM_RESTART': '1', 21:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:38 INFO - 'PWD': '/builds/slave/test', 21:56:38 INFO - 'SHELL': '/bin/bash', 21:56:38 INFO - 'SHLVL': '1', 21:56:38 INFO - 'TERM': 'linux', 21:56:38 INFO - 'TMOUT': '86400', 21:56:38 INFO - 'USER': 'cltbld', 21:56:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:38 INFO - '_': '/tools/buildbot/bin/python'} 21:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:56:38 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:56:38 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:56:38 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:56:38 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:56:38 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:56:38 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:56:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:56:40 INFO - Installing collected packages: mozsystemmonitor 21:56:40 INFO - Running setup.py install for mozsystemmonitor 21:56:40 INFO - Successfully installed mozsystemmonitor 21:56:40 INFO - Cleaning up... 21:56:40 INFO - Return code: 0 21:56:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:56:40 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:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:40 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:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:40 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:40 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:56:40 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:56:40 INFO - Using env: {'DISPLAY': ':0', 21:56:40 INFO - 'HOME': '/home/cltbld', 21:56:40 INFO - 'LANG': 'en_US.UTF-8', 21:56:40 INFO - 'LANGUAGE': 'en_US:en', 21:56:40 INFO - 'LOGNAME': 'cltbld', 21:56:40 INFO - 'MAIL': '/var/mail/cltbld', 21:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:40 INFO - 'MOZ_NO_REMOTE': '1', 21:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:40 INFO - 'NO_EM_RESTART': '1', 21:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:40 INFO - 'PWD': '/builds/slave/test', 21:56:40 INFO - 'SHELL': '/bin/bash', 21:56:40 INFO - 'SHLVL': '1', 21:56:40 INFO - 'TERM': 'linux', 21:56:40 INFO - 'TMOUT': '86400', 21:56:40 INFO - 'USER': 'cltbld', 21:56:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:40 INFO - '_': '/tools/buildbot/bin/python'} 21:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:41 INFO - Downloading/unpacking jsonschema==2.5.1 21:56: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:56: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:56: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:56: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:56: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:56: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:56:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:56:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:56: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:56: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:56: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:56: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:56: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:56: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:56:43 INFO - Downloading functools32-3.2.3-2.tar.gz 21:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:56:43 INFO - warning: no files found matching '*.txt' 21:56:43 INFO - no previously-included directories found matching 'build' 21:56:43 INFO - no previously-included directories found matching 'dist' 21:56:43 INFO - no previously-included directories found matching '.git*' 21:56:43 INFO - Installing collected packages: jsonschema, functools32 21:56:43 INFO - Running setup.py install for functools32 21:56:43 INFO - warning: no files found matching '*.txt' 21:56:43 INFO - no previously-included directories found matching 'build' 21:56:43 INFO - no previously-included directories found matching 'dist' 21:56:43 INFO - no previously-included directories found matching '.git*' 21:56:43 INFO - Successfully installed jsonschema functools32 21:56:43 INFO - Cleaning up... 21:56:43 INFO - Return code: 0 21:56:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:56:43 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:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:43 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:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:43 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:43 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:56:43 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:56:43 INFO - Using env: {'DISPLAY': ':0', 21:56:43 INFO - 'HOME': '/home/cltbld', 21:56:43 INFO - 'LANG': 'en_US.UTF-8', 21:56:43 INFO - 'LANGUAGE': 'en_US:en', 21:56:43 INFO - 'LOGNAME': 'cltbld', 21:56:43 INFO - 'MAIL': '/var/mail/cltbld', 21:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:43 INFO - 'MOZ_NO_REMOTE': '1', 21:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:43 INFO - 'NO_EM_RESTART': '1', 21:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:43 INFO - 'PWD': '/builds/slave/test', 21:56:43 INFO - 'SHELL': '/bin/bash', 21:56:43 INFO - 'SHLVL': '1', 21:56:43 INFO - 'TERM': 'linux', 21:56:43 INFO - 'TMOUT': '86400', 21:56:43 INFO - 'USER': 'cltbld', 21:56:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:43 INFO - '_': '/tools/buildbot/bin/python'} 21:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:56:43 INFO - Cleaning up... 21:56:43 INFO - Return code: 0 21:56:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:56:43 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:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:43 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:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:43 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:43 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:56:43 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:56:43 INFO - Using env: {'DISPLAY': ':0', 21:56:43 INFO - 'HOME': '/home/cltbld', 21:56:43 INFO - 'LANG': 'en_US.UTF-8', 21:56:43 INFO - 'LANGUAGE': 'en_US:en', 21:56:43 INFO - 'LOGNAME': 'cltbld', 21:56:43 INFO - 'MAIL': '/var/mail/cltbld', 21:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:43 INFO - 'MOZ_NO_REMOTE': '1', 21:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:43 INFO - 'NO_EM_RESTART': '1', 21:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:43 INFO - 'PWD': '/builds/slave/test', 21:56:43 INFO - 'SHELL': '/bin/bash', 21:56:43 INFO - 'SHLVL': '1', 21:56:43 INFO - 'TERM': 'linux', 21:56:43 INFO - 'TMOUT': '86400', 21:56:43 INFO - 'USER': 'cltbld', 21:56:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:43 INFO - '_': '/tools/buildbot/bin/python'} 21:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:43 INFO - Downloading/unpacking blobuploader==1.2.4 21:56:43 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:56:43 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:56:43 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:56:43 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:56:43 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:56:43 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:56:45 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56: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:56: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:56: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:56: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:56: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:56: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:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:56:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56:46 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:56:46 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:56:46 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:56:46 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:56:46 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:56:46 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:56:46 INFO - Downloading docopt-0.6.1.tar.gz 21:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:46 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:46 INFO - Running setup.py install for blobuploader 21:56:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:56:46 INFO - Running setup.py install for requests 21:56:47 INFO - Running setup.py install for docopt 21:56:47 INFO - Successfully installed blobuploader requests docopt 21:56:47 INFO - Cleaning up... 21:56:47 INFO - Return code: 0 21:56:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:47 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:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:47 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:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:47 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:47 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:56:47 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:56:47 INFO - Using env: {'DISPLAY': ':0', 21:56:47 INFO - 'HOME': '/home/cltbld', 21:56:47 INFO - 'LANG': 'en_US.UTF-8', 21:56:47 INFO - 'LANGUAGE': 'en_US:en', 21:56:47 INFO - 'LOGNAME': 'cltbld', 21:56:47 INFO - 'MAIL': '/var/mail/cltbld', 21:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:47 INFO - 'MOZ_NO_REMOTE': '1', 21:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:47 INFO - 'NO_EM_RESTART': '1', 21:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:47 INFO - 'PWD': '/builds/slave/test', 21:56:47 INFO - 'SHELL': '/bin/bash', 21:56:47 INFO - 'SHLVL': '1', 21:56:47 INFO - 'TERM': 'linux', 21:56:47 INFO - 'TMOUT': '86400', 21:56:47 INFO - 'USER': 'cltbld', 21:56:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:47 INFO - '_': '/tools/buildbot/bin/python'} 21:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:47 INFO - Running setup.py (path:/tmp/pip-W6BD1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:47 INFO - Running setup.py (path:/tmp/pip-5kOQ1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:47 INFO - Running setup.py (path:/tmp/pip-e5ivvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:47 INFO - Running setup.py (path:/tmp/pip-9l2MtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:47 INFO - Running setup.py (path:/tmp/pip-fw8lFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:47 INFO - Running setup.py (path:/tmp/pip-VHU7gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:47 INFO - Running setup.py (path:/tmp/pip-TQlnYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:48 INFO - Running setup.py (path:/tmp/pip-FI_p9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:48 INFO - Running setup.py (path:/tmp/pip-gVMhLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:48 INFO - Running setup.py (path:/tmp/pip-aZqHmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:48 INFO - Running setup.py (path:/tmp/pip-2rZDxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:48 INFO - Running setup.py (path:/tmp/pip-QbOHaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:48 INFO - Running setup.py (path:/tmp/pip-T9zqS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:48 INFO - Running setup.py (path:/tmp/pip-BHUPXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:48 INFO - Running setup.py (path:/tmp/pip-Cr1ZYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:48 INFO - Running setup.py (path:/tmp/pip-qsNoG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:48 INFO - Running setup.py (path:/tmp/pip-X1JuJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:48 INFO - Running setup.py install for manifestparser 21:56:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:56:48 INFO - Running setup.py install for mozcrash 21:56:48 INFO - Running setup.py install for mozdebug 21:56:49 INFO - Running setup.py install for mozdevice 21:56:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Running setup.py install for mozfile 21:56:49 INFO - Running setup.py install for mozhttpd 21:56:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Running setup.py install for mozinfo 21:56:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Running setup.py install for mozInstall 21:56:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Running setup.py install for mozleak 21:56:49 INFO - Running setup.py install for mozlog 21:56:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Running setup.py install for moznetwork 21:56:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:56:49 INFO - Running setup.py install for mozprocess 21:56:50 INFO - Running setup.py install for mozprofile 21:56:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:56:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:56:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:56:50 INFO - Running setup.py install for mozrunner 21:56:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:56:50 INFO - Running setup.py install for mozscreenshot 21:56:50 INFO - Running setup.py install for moztest 21:56:50 INFO - Running setup.py install for mozversion 21:56:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:56:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:50 INFO - Cleaning up... 21:56:50 INFO - Return code: 0 21:56:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:50 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:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:50 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:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:50 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:50 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:56:50 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:56:50 INFO - Using env: {'DISPLAY': ':0', 21:56:50 INFO - 'HOME': '/home/cltbld', 21:56:50 INFO - 'LANG': 'en_US.UTF-8', 21:56:50 INFO - 'LANGUAGE': 'en_US:en', 21:56:50 INFO - 'LOGNAME': 'cltbld', 21:56:50 INFO - 'MAIL': '/var/mail/cltbld', 21:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:50 INFO - 'MOZ_NO_REMOTE': '1', 21:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:50 INFO - 'NO_EM_RESTART': '1', 21:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:50 INFO - 'PWD': '/builds/slave/test', 21:56:50 INFO - 'SHELL': '/bin/bash', 21:56:50 INFO - 'SHLVL': '1', 21:56:50 INFO - 'TERM': 'linux', 21:56:50 INFO - 'TMOUT': '86400', 21:56:50 INFO - 'USER': 'cltbld', 21:56:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:50 INFO - '_': '/tools/buildbot/bin/python'} 21:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:50 INFO - Running setup.py (path:/tmp/pip-oTNkhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:50 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:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:50 INFO - Running setup.py (path:/tmp/pip-xKN6rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:50 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:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:50 INFO - Running setup.py (path:/tmp/pip-Xdg7Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:51 INFO - Running setup.py (path:/tmp/pip-RsueaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:51 INFO - Running setup.py (path:/tmp/pip-qxf6hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:51 INFO - Running setup.py (path:/tmp/pip-7bxLXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:51 INFO - Running setup.py (path:/tmp/pip-6TE8Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:51 INFO - Running setup.py (path:/tmp/pip-Kp_WSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:51 INFO - Running setup.py (path:/tmp/pip-_ti3Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:51 INFO - Running setup.py (path:/tmp/pip-w8BVIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:51 INFO - Running setup.py (path:/tmp/pip-iGG3yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:51 INFO - Running setup.py (path:/tmp/pip-qRCnoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:51 INFO - Running setup.py (path:/tmp/pip-B2Gy8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:51 INFO - Running setup.py (path:/tmp/pip-MXPSwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:51 INFO - Running setup.py (path:/tmp/pip-s9rJ0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:51 INFO - Running setup.py (path:/tmp/pip-exxyPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:51 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:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:51 INFO - Running setup.py (path:/tmp/pip-wFpgcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:52 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:56:52 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:56:52 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:56:52 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:56:52 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:56:52 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:56:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:52 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:56:52 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:56:52 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:56:52 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:56:52 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:56:52 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:56:54 INFO - Downloading blessings-1.6.tar.gz 21:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:54 INFO - Installing collected packages: blessings 21:56:54 INFO - Running setup.py install for blessings 21:56:54 INFO - Successfully installed blessings 21:56:54 INFO - Cleaning up... 21:56:54 INFO - Return code: 0 21:56:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:56:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:54 INFO - Reading from file tmpfile_stdout 21:56:54 INFO - Current package versions: 21:56:54 INFO - argparse == 1.2.1 21:56:54 INFO - blessings == 1.6 21:56:54 INFO - blobuploader == 1.2.4 21:56:54 INFO - docopt == 0.6.1 21:56:54 INFO - functools32 == 3.2.3-2 21:56:54 INFO - jsonschema == 2.5.1 21:56:54 INFO - manifestparser == 1.1 21:56:54 INFO - mozInstall == 1.12 21:56:54 INFO - mozcrash == 1.0 21:56:54 INFO - mozdebug == 0.1 21:56:54 INFO - mozdevice == 0.49 21:56:54 INFO - mozfile == 1.2 21:56:54 INFO - mozhttpd == 0.7 21:56:54 INFO - mozinfo == 0.9 21:56:54 INFO - mozleak == 0.1 21:56:54 INFO - mozlog == 3.4 21:56:54 INFO - moznetwork == 0.27 21:56:54 INFO - mozprocess == 0.24 21:56:54 INFO - mozprofile == 0.28 21:56:54 INFO - mozrunner == 6.13 21:56:54 INFO - mozscreenshot == 0.1 21:56:54 INFO - mozsystemmonitor == 0.3 21:56:54 INFO - moztest == 0.8 21:56:54 INFO - mozversion == 1.4 21:56:54 INFO - psutil == 3.1.1 21:56:54 INFO - requests == 1.2.3 21:56:54 INFO - wsgiref == 0.1.2 21:56:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:54 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:56:54 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:56:54 INFO - Using env: {'DISPLAY': ':0', 21:56:54 INFO - 'HOME': '/home/cltbld', 21:56:54 INFO - 'LANG': 'en_US.UTF-8', 21:56:54 INFO - 'LANGUAGE': 'en_US:en', 21:56:54 INFO - 'LOGNAME': 'cltbld', 21:56:54 INFO - 'MAIL': '/var/mail/cltbld', 21:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:54 INFO - 'MOZ_NO_REMOTE': '1', 21:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:54 INFO - 'NO_EM_RESTART': '1', 21:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:54 INFO - 'PWD': '/builds/slave/test', 21:56:54 INFO - 'SHELL': '/bin/bash', 21:56:54 INFO - 'SHLVL': '1', 21:56:54 INFO - 'TERM': 'linux', 21:56:54 INFO - 'TMOUT': '86400', 21:56:54 INFO - 'USER': 'cltbld', 21:56:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:54 INFO - '_': '/tools/buildbot/bin/python'} 21:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:54 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:56:54 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:56:54 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:56:54 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:56:54 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:56:54 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:56:54 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:56:54 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:56:54 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:56:54 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:56:54 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:56:54 INFO - Cleaning up... 21:56:54 INFO - Return code: 0 21:56:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4cc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, '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': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', '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:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:56:54 INFO - Using env: {'DISPLAY': ':0', 21:56:54 INFO - 'HOME': '/home/cltbld', 21:56:54 INFO - 'LANG': 'en_US.UTF-8', 21:56:54 INFO - 'LANGUAGE': 'en_US:en', 21:56:54 INFO - 'LOGNAME': 'cltbld', 21:56:54 INFO - 'MAIL': '/var/mail/cltbld', 21:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:54 INFO - 'MOZ_NO_REMOTE': '1', 21:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:54 INFO - 'NO_EM_RESTART': '1', 21:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:54 INFO - 'PWD': '/builds/slave/test', 21:56:54 INFO - 'SHELL': '/bin/bash', 21:56:54 INFO - 'SHLVL': '1', 21:56:54 INFO - 'TERM': 'linux', 21:56:54 INFO - 'TMOUT': '86400', 21:56:54 INFO - 'USER': 'cltbld', 21:56:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:54 INFO - '_': '/tools/buildbot/bin/python'} 21:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:56:54 INFO - Cleaning up... 21:56:55 INFO - Return code: 0 21:56:55 INFO - Running post-action listener: _resource_record_post_action 21:56:55 INFO - Running post-action listener: _start_resource_monitoring 21:56:55 INFO - Starting resource monitoring. 21:56:55 INFO - [mozharness: 2017-02-03 05:56:55.039236Z] Finished create-virtualenv step (success) 21:56:55 INFO - [mozharness: 2017-02-03 05:56:55.039755Z] Running install step. 21:56:55 INFO - Running pre-action listener: _resource_record_pre_action 21:56:55 INFO - Running main action method: install 21:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:55 INFO - Reading from file tmpfile_stdout 21:56:55 INFO - Detecting whether we're running mozinstall >=1.0... 21:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:56:55 INFO - Reading from file tmpfile_stdout 21:56:55 INFO - Output received: 21:56:55 INFO - Usage: mozinstall [options] installer 21:56:55 INFO - Options: 21:56:55 INFO - -h, --help show this help message and exit 21:56:55 INFO - -d DEST, --destination=DEST 21:56:55 INFO - Directory to install application into. [default: 21:56:55 INFO - "/builds/slave/test"] 21:56:55 INFO - --app=APP Application being installed. [default: firefox] 21:56:55 INFO - mkdir: /builds/slave/test/build/application 21:56:55 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:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:57:13 INFO - Reading from file tmpfile_stdout 21:57:13 INFO - Output received: 21:57:13 INFO - /builds/slave/test/build/application/firefox/firefox 21:57:13 INFO - Running post-action listener: _resource_record_post_action 21:57:13 INFO - [mozharness: 2017-02-03 05:57:13.115073Z] Finished install step (success) 21:57:13 INFO - [mozharness: 2017-02-03 05:57:13.115350Z] Running run-tests step. 21:57:13 INFO - Running pre-action listener: _resource_record_pre_action 21:57:13 INFO - Running main action method: run_tests 21:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:57:13 INFO - Python 2.7.3 21:57:13 INFO - Return code: 0 21:57:13 INFO - grabbing minidump binary from tooltool 21:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:13 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 0xd4a3f0>, '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 0xd4acf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4b1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:57:13 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:57:13 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:57:13 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:57:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:57:13 INFO - Return code: 0 21:57:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:57:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:57:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:57:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:57:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:57:13 INFO - Using env: {'DISPLAY': ':0', 21:57:13 INFO - 'HOME': '/home/cltbld', 21:57:13 INFO - 'LANG': 'en_US.UTF-8', 21:57:13 INFO - 'LANGUAGE': 'en_US:en', 21:57:13 INFO - 'LOGNAME': 'cltbld', 21:57:13 INFO - 'MAIL': '/var/mail/cltbld', 21:57:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:57:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:13 INFO - 'MOZ_NO_REMOTE': '1', 21:57:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:13 INFO - 'NO_EM_RESTART': '1', 21:57:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:13 INFO - 'PWD': '/builds/slave/test', 21:57:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:57:13 INFO - 'SHELL': '/bin/bash', 21:57:13 INFO - 'SHLVL': '1', 21:57:13 INFO - 'TERM': 'linux', 21:57:13 INFO - 'TMOUT': '86400', 21:57:13 INFO - 'USER': 'cltbld', 21:57:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928', 21:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:13 INFO - '_': '/tools/buildbot/bin/python'} 21:57:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:57:13 INFO - mozversion application_buildid: 20170203045258 21:57:13 INFO - mozversion application_changeset: b1c08aabf905f83f12afac1ce4e1925add6c9bea 21:57:13 INFO - mozversion application_display_name: Nightly 21:57:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:57:13 INFO - mozversion application_name: Firefox 21:57:13 INFO - mozversion application_remotingname: firefox 21:57:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:57:13 INFO - mozversion application_vendor: Mozilla 21:57:13 INFO - mozversion application_version: 54.0a1 21:57:13 INFO - mozversion platform_buildid: 20170203045258 21:57:13 INFO - mozversion platform_changeset: b1c08aabf905f83f12afac1ce4e1925add6c9bea 21:57:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:57:13 INFO - mozversion platform_version: 54.0a1 21:57:13 INFO - using testdate: 1486101433 21:57:13 INFO - actual date: 1486101433 21:57:13 INFO - starting webserver on 'localhost:53314' 21:57:13 INFO - SUITE-START | Running 2 tests 21:57:13 INFO - TEST-START | dromaeo_css 21:57:13 INFO - operating with platform_type : linux_ 21:57:13 INFO - Initialising browser for dromaeo_css test... 21:57:13 INFO - TEST-INFO | started process 313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxp0Oe_/profile http://localhost:53314/getInfo.html) 21:57:16 INFO - PROCESS | 313 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 21:57:17 INFO - PROCESS | 313 | __metrics Screen width/height:1600/1200 21:57:17 INFO - PROCESS | 313 | colorDepth:24 21:57:17 INFO - PROCESS | 313 | Browser inner width/height: 1024/697 21:57:17 INFO - PROCESS | 313 | __metrics 21:57:17 INFO - PROCESS | 313 | 1486101437946 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 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 21:57:18 INFO - PROCESS | 313 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:57:18 INFO - PROCESS | 313 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:57:18 INFO - PROCESS | 313 | console.error: PushService: 21:57:18 INFO - PROCESS | 313 | stateChangeProcessEnqueue: Error transitioning state 21:57:18 INFO - PROCESS | 313 | UnknownError 21:57:19 INFO - TEST-INFO | 313: exit 0 21:57:19 INFO - Browser initialized. 21:57:19 INFO - Running cycle 1/1 for dromaeo_css test... 21:57:19 INFO - TEST-INFO | started process 398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxp0Oe_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:31 INFO - PROCESS | 398 | RSS: Main: 149307392 21:57:31 INFO - PROCESS | 398 | 22:00:31 INFO - PROCESS | 398 | Cycle 1(1): loaded http://localhost:53314/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53314/tests/dromaeo/cssquery-ext.html) 22:00:33 INFO - PROCESS | 398 | RSS: Main: 242155520 22:00:33 INFO - PROCESS | 398 | 22:02:21 INFO - PROCESS | 398 | ************************* 22:02:21 INFO - PROCESS | 398 | A coding exception was thrown and uncaught in a Task. 22:02:21 INFO - PROCESS | 398 | 22:02:21 ERROR - PROCESS | 398 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:02:21 INFO - PROCESS | 398 | Full stack: 22:02:21 INFO - PROCESS | 398 | ************************* 22:03:36 INFO - PROCESS | 398 | Cycle 1(1): loaded http://localhost:53314/tests/dromaeo/cssquery-ext.html (next: http://localhost:53314/tests/dromaeo/cssquery-jquery.html) 22:03:36 INFO - PROCESS | 398 | RSS: Main: 245342208 22:03:36 INFO - PROCESS | 398 | 22:06:38 INFO - PROCESS | 398 | Cycle 1(1): loaded http://localhost:53314/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53314/tests/dromaeo/cssquery-mootools.html) 22:06:39 INFO - PROCESS | 398 | RSS: Main: 234139648 22:06:39 INFO - PROCESS | 398 | 22:09:41 INFO - PROCESS | 398 | Cycle 1(1): loaded http://localhost:53314/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53314/tests/dromaeo/cssquery-prototype.html) 22:09:41 INFO - PROCESS | 398 | RSS: Main: 226619392 22:09:41 INFO - PROCESS | 398 | 22:12:44 INFO - PROCESS | 398 | Cycle 1(1): loaded http://localhost:53314/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53314/tests/dromaeo/cssquery-yui.html) 22:12:45 INFO - PROCESS | 398 | RSS: Main: 187699200 22:12:45 INFO - PROCESS | 398 | 22:15:47 INFO - PROCESS | 398 | Cycle 1(1): loaded http://localhost:53314/tests/dromaeo/cssquery-yui.html (next: http://localhost:53314/tests/dromaeo/cssquery-dojo.html) 22:15:48 INFO - PROCESS | 398 | RSS: Main: 258383872 22:15:48 INFO - PROCESS | 398 | 22:15:48 INFO - PROCESS | 398 | __start_tp_report 22:15:48 INFO - PROCESS | 398 | _x_x_mozilla_page_load 22:15:48 INFO - PROCESS | 398 | _x_x_mozilla_page_load_details 22:15:48 INFO - PROCESS | 398 | |i|pagename|runs| 22:15:48 INFO - PROCESS | 398 | |0;dojo.html;3168.5564021037058;3198.1844629619445;3204.0227730542183;3237.5143728440717;3255.8209298488573;5234.842954711356;5247;5257.316548848649;5320.707361095138;5352.384475785281;5264.447233040533;5268.525832675058;5276.314079169712;5306.681599104057;5348.5453736432355;4553.408056952591;4778.259369797678;4912.877178070541;4939.234418665113;4950.207966725325;4644.187267228239;4918.950810491903;4942.233953737176;4955.925661115069;4958.6281028922795;4662.207424737802;4772.904541909143;4790.664653474259;4814.157522433595;4884.218525035977;4813.253945638432;4818.229083346648;4821.5178482151505;4828.951710482886;4863.659543831933;4774.689645173053;4839.7096174229655;4848.903021939576;4854.053459575384;4881.755912204376;5126;5179.870503237412;5249.580033597341;5326.547243484309;5332.626716129873;5745.971270143623;5749.770009199627;5784.074548072288;5789.131630255495;5794.768209271624;5756.5682573807135;5769.5672824537905;5776.508996735282;5777.884442311172;5778.768849246025;5071.594272458195;5094.566961808214;5390.97304513475;5394.379646340682;5396.784128634889;5412.242286079952;5674.574406919415;5739.827805165852;5741.483266505951;5798.478136967608;5269.367675878842;5280.3663560373;5552.639078459887;5554.666719996813;5591.217229587861;5659.603827732101;5714.857128571736;5719.971400142973;5720.971395143081;5723.828285151452;5451.618386712892;5505.862353441196;5622.662640241517;5627.549796016309;5636.887262254732;5524.14375771756;5592.384837667853;5606.971965140148;5641.661500309994;5688.829335119953;4468.932966005513;4476.37330773692;4477.037436951006;4479.10417916418;4481.215787237285;3856.845726170922;3885.9611403886165;3975.264576053439;3977.3238549446664;4015.0765323975065;5397.10947693634;5447;5449.25623800388;5449.945500544944;5512.39363669996;5722.427757224327;5726.541876649858;5728.513076388554;5735.11105778605;5735.942640573624;5256.316678831728;5470.288862447856;5480.314960629921;5481.862953426196;5489.807856724996;4910.386201724785;4965.404151501771;5003.5997120230295;5014.222795466709;5079.034983353225;6093.482054025369;6096.0855871619615;6098.908516372258;6099.69501524922;6103.725332360054;5715.714214289352;5771.307443106854;5777.826665200051;5778.335491418541;5783.306003279633;5705.62913410627;5745.8563535911935;5746.856328591819;5787.450192231731;5817.6509409433875;5370.409254981871;5426.4573542646995;5428.70142142186;5430.212619170277;5434.130539113723;5419.810306639249;5431.945680543144;5438.2386465894015;5459.781608735606;5492.368377636623;5475.917861232005;5491.835244942658;5509.118541033416;5512.503874651301;5598.552115830642;5543.029969755357;5543.417941116125;5544.778208871761;5549.472800083986;5550;5379.488948549882;5517.200005999028;5528.55771538284;5535.640183388228;5587.245721827664;5472.890542189213;5529.225908372911;5558.138488534284;5558.833235002957;5641.435856414326;5469.890602188014;5472.644278121909;5476.17857321405;5478.397376288684;5483.122700367922 22:15:48 INFO - PROCESS | 398 | |1;ext.html;583.8277708076117;600.8167508909784;619.597261779843;644.0210879463216;644.6325594411187;34935.584984327405;38192.427113593316;44672.999999999956;47746.76126619371;47941.52058479414;49980.75009624947;50274.74862625691;50341.74829125849;50382;50455.74772126143;8995.865062024075;9193.494357810318;9197.770055748626;9199.724008279729;9201.769955751093;8510.191531804468;8713.215810577078;9055.954720226422;10665.84001239982;10943.343399396063;10942.398168100752;10976.780464390707;11011.28426652265;11018.614348497764;11021.83467247992;10968.561257549689;10989.560417583287;11047;11051.060659843923;11090.112790976702;10727.946360268226;10789.946050269777;10803.729906752316;10814.405207713573;10816;45523.54476455226;45676.314855277196;45893;45965;46038.079238415376;3820.7707537547835;3890.6498415142773;3953;3982.422548730447;3996.800959712075;28905.56641650377;31551.84224078865;31596.684033159603;31636.683633163604;31680.207994800083;4220.683448741357;4346.282863327548;4375.321825117112;4383.101464199832;4431.748298914875;342107;342521.9999999975;343365;345003;345622;55353.44646553483;56820;56928;56997.715011424676;57165;55792;56059.719701401234;56142.719286403306;56152;62736.68631656813;17303.65392692139;17574;17581.82418175802;17583.824161758475;17588.296468141387;13602.863971360357;13720.382582783799;13729.725405492034;13729.931350343384;13771.793423098661;18519;18662;18759.624807503773;18941.526461838563;18983.240670373307;7053.329933656294;7104.0764700589625;7294.674887332171;7301.744438944612;7340.596267205355;886.7073865624458;913.9618650409624;926.8748718922994;933.272047802715;943.0381011368503;31920.840395797873;32782.18044548905;33413.83293083568;33485.66514334874;33552.496712549335;1021.382063851374;1105.082781291526;1113.7661091170783;1115.275071203724;1117.8267368557886;16335.902903067243;17402.82597174012;17460.563485912953;17528.474145775646;17547.561310967074;525245;529698.1392419038;530467;530813;532163.3391833015;66372;66450.33549664538;66482.66758666176;66744.3325566738;66970.99543506851;1439.3019385597977;1452.0634190946992;1476.4758510728752;1496.6258435391153;1512.0322993284308;29566.704332956397;30578;31014.379712406077;32555.674443255266;32794;55333.44666553444;56075;56100.719496403886;56128;56167;458923;459783;462530;463218;465132;39950.2009959805;40525.7316897165;40738.79630601947;40848.38727419032;41205.793971029954;44448.77775611101;44974.77512612416;45539.772301138284;45796.7710161447;46027.30959035684;38592.22815543617;38763.41854872123;39129.804350979204;40013.39979900246;40180.79909600433;37585.24829503449;38200;38288.42567361436;38724.2255154901;39520.60479395284;38056.238875222894;39432.80283598564;39720.801395992836;41367.793161034;41684.374734378405;32794.83602581972;35639.10902227362;36129.27741445104;36199.27601448009;36329.81835090808;26322.210333690018;26859.32851678724;26952.191434257005;27134.829213663255;27140.592891106255 22:15:48 INFO - PROCESS | 398 | |2;jquery.html;387.7285899870092;428.802750734662;434.7379088519101;436.26489365419263;450.87150162203756;17272.395466158687;19610.313639022635;20870.58258834826;21051;21246.362609121752;20624.793752062513;21174;21437.892810535963;21624.135034598596;22049.669254961187;5688.402717714643;5808.361080281165;5920.911186332198;6030.095485677161;6073.87633287841;5903.763849446017;6017.969910150443;6067.453929146376;6071.848203794918;6078.784243151365;5841.299044114691;5933.465988061073;5977.372375900533;6032.276126864783;6044.425779550936;5967.910481342783;5982.521398288127;6029.035354343284;6029.939700603026;6037.637741735488;5266.8683282917855;5424.566034717213;5486.259354987065;5535.916961245584;5613.494785469286;14605.926970365186;15110.5466835994;15145.545633630898;15163.469278575307;15341.471461563902;2651.6287719719253;2706.580480025599;2727.699953005168;2750.3261700883213;2756.3109222694325;10642.521086551124;10709.196810239264;10800.351978881214;11366.26119302251;11432.142589305753;1927.44104209779;1972.6646470100118;1984.573316736894;1994.9800501995085;2005.398380485863;87516;87799.56100219458;89621.55189224078;89749.10250897473;90677;10766.407847568302;10828.24202305831;11090.944545277383;12020.819687704692;12154.574589889311;15616.76574851378;15730.370785168694;16028.67942641164;16103.919480402757;16166.919165404333;8337.124601916712;8378.874316885129;8581.613827377783;8683.478991260545;8695.695650652196;7846.568438735924;7878.763637090897;7903.84192316162;8097.595120243965;8165.63254653542;5171.198464238049;5231.843044708588;5240.65935714185;5241.24002019705;5349.5720342372515;2064.700618410322;2115.3183219340663;2115.661494160927;2117.8517503774897;2169.4467910682674;853.487907255654;870.7997160652959;872.9781755456038;891.5987805487556;906.2885634776669;19464.610707785763;19953.60092798136;21139.365819025454;21206.638008597358;21406.464838378855;877.7542288159326;880.2517859819103;886.6719313853915;891.6938715861727;896.3053633434141;11396.14528910335;11408.144389170846;11639.418029098511;11654.184207105422;11667.533298667959;286344;374066;693957;720164.9835016561;721367;87350;94480;109608;109856.4507177459;114183.42908285405;527.6543863769238;542.4738004135982;542.5551048140566;542.8127296082845;544.4582640272954;11435.428228588371;11811.350375729073;12204.633860984184;12450;12594.559190428292;31516.369672606877;40808.3878741825;41796;43450.782746086064;43887.29465169635;57765.71117144387;57956.71021644865;61666;62136.378636213056;62902.68548657227;8284.544350060805;8461.153884611489;8766.167214114905;8845.734627961172;9191.172794448532;9783.315167938175;13039.739205216032;14103.576892693236;14124.858751412765;14167.220802855942;11526.538938442704;11578.131640127192;11615.128865334964;11731;11808.82286765682;11560.421978900853;11746.353950532803;11752.412379380825;11925.880741192477;11932.880671193177;11351.489182986621;11604.535818567163;12006.519739210684;12009.519619215484;12124.75750485003;8209.58952052383;8445.493270403795;8471.364647651573;8614.870776938476;8687.609057592297;8813.074627164055;10819.891801081889;11723.589674361698;11891.881081189078;12028.458719357475 22:15:48 INFO - PROCESS | 398 | |3;mootools.html;1433.9713205735893;1453.876420504257;1465.948691795787;1475.7786332050198;1477.4902658582785;8214.630341634625;8734.51960142192;8745.693900713477;8752.606132724026;8757.474551526904;8356.289715374185;8631.136886311366;8662.610182541785;8769.736907892757;8806.20744133028;2262.9886850565767;2300.631898896177;2302.861828290308;2306.527161931808;2308.249818808894;2267.455810605459;2295.6556516522487;2303.4702018535745;2303.7581053989343;2308.365199570115;2318.13070098713;2322.837401381904;2335.369450248432;2341.9414514637183;2344.402177444749;2139.358192542239;2157.7518585362727;2171.9022643981057;2178;2241.7421996470453;2158.3093410108772;2221.389117992549;2225.5326381459913;2226.0428015953134;2226.065052677879;8705.82588348236;8758.824823503557;8765.561721913942;8779.253763430115;8782.38523303369;4984.177610694231;5095;5112.233165025276;5113.258577506241;5118.820841270538;3285.7535684823733;3286.8849590264467;3425.537552430415;3450.5341778860034;3471.1322169457635;1461.6272850423181;1474.6903150338442;1498.625343664084;1524.8475152484773;1542.2751306885746;10619.57521699131;10871.565137394495;11208.607698730586;11654.184207105505;11777.882221177764;4148;4259.190753756776;4288.614024737789;4318.244307246219;4319.827206911751;9577.377470464398;9582.90417095834;9583.856242156373;9589.280803939733;9592.424454532751;4639.141758774637;4794.065157294294;4997.075541024922;5098.311727916758;5101.132807422747;4794.304825800239;4934.950650493449;4936.432310284364;4943.950560494349;4946.3817022872145;3495.1611613212644;3566.5363502744995;3600.369935261371;3624.4382120771324;3732.496113024761;1062.9787404251872;1070.1652710885521;1072.8819829818713;1074.0655629602295;1077.6389909380289;929.0755698080318;931.5016466190556;938.346462563063;943.1747221181329;960.8750862387844;5712.2288491054005;5737.827865164052;5800.1299805029585;6086.147939288503;6096.939030609726;984.718010313726;991.2862738828177;994.9403035817874;1005.703317521333;1022.3354819367471;3836.156045669948;3852.3643598806443;3897.2595206910596;3967.9801600992387;3990.301697203036;10222.897771022195;10503.369797812156;10505.422201778823;10506.947465262778;10514.21143414247;10426.374417534973;10433.739156521147;10469.581216751398;10470.790584188273;10525.789484210272;7710.151883292945;7953.880691789628;8043.959780201179;8164.428490005761;8191.303739182236;5667.724761928533;5749.04532458966;5756.65460072397;5764.481196692318;5812.94187058124;9262.351635385457;9477.857832132386;9515.429074255568;9517.666881659108;9519.00050494688;8343.249107580346;8633.05036445978;9047.321450891079;9424.670136545188;9506.714798556055;7424.071991001125;7657.157712651715;7722.652480638272;7729.884051739116;7738.187490313661;7761;8186.754397368089;8247.752567422987;8261.545614991233;8262.215089566482;7453.366463850417;7481.850362992818;7498.58757768328;7538.773836784905;7566.470347075652;7282.745103921549;7324.194338622854;7327.74352897646;7413.25867413276;7535.944967704416;6152.846178845564;6567.868642627216;6690.498212634169;6697.430718388991;6698.162729658793;4822.638302127284;4998.475160108282;5050.3182070420025;5058.772355244097;5248.60635452335;5103.87240318995;5133.383993920604;5229.581633469237;5233.267342572119;5439.48324909133 22:15:48 INFO - PROCESS | 398 | |4;prototype.html;399.8320705303772;401.821189570641;413.8489451350257;415.7048495568146;424.9298865687161;4912.848642896746;5084.288199652052;5097.515736005078;5122.1292380295345;5162.741862906849;4999.875003124915;5074.213496907985;5110.872228194297;5126.692398456095;5139.922901156477;4137.482814648169;4150.64719498843;4159.984011591595;4167.354060120686;4179.770112643803;3939.5075615548058;4021.537523184842;4175.624193822556;4193.0984838259765;4202.789860506978;4055.756654600719;4077.0826564023155;4077.57284950268;4078.4086307485395;4090.2637525245445;4052.399302275614;4067.410225517313;4076.9592304076878;4088.4889388826396;4111.218868414991;3667.2665466906724;3676.7977761223124;3688.686461650763;3690.3541880171133;3693.519842420495;4986.326845875797;5056.721880296583;5069.909969356606;5091.516305950929;5098.821541246039;4705.800020994659;4706.694064885805;4709.387779588666;4711;4721.881952951169;5432.701201433959;5436.619436639437;5437.918431223535;5439.836804895859;5444.863878403032;3846.3653497173214;3929.214157168578;3983.2431837950985;3984.980075099606;3999.500187429714;5634.098439303762;5639.323281206241;5651.660900345952;5655.8586035349035;5657.9434205658235;4089.670856971496;4099.385092236129;4105.240530501807;4108.404281379183;4108.424820525129;4041.2321658884716;4131.628153466202;4144.181956269766;4150.232207041707;4168.166366726667;4660.790264438108;4664.55686709762;4685.672002959828;4695.835645752382;4697.177993851063;5472.7263636818;5474.890502189934;5481.095619222863;5486.890262194734;5498.697571633518;1308.3131356037966;1331.7269959658247;1342.939567719455;1372.7048684532874;1376.511338474847;948.6008137996538;956.9856452153223;968.6997030920437;972.4748635736764;978.4862946952907;5097.490250974873;5098.362704661918;5102.566281866083;5110.66780659256;5112.137203166239;5281.366236051622;5336.839894803162;5337.653052551572;5347.304850369427;5354;4808.980228304121;5031.974840125776;5086.618503612244;5114.872128196825;5126.53861152498;2824.562192860069;2831.0940499040107;2835.8865645373953;2837.5670286505183;2837.7020412856355;5559.499645031886;5562.135500217391;5622.634528755618;5623.212750214973;5635.239242702265;5218.7559349479325;5432.864178395493;5438;5483.533899618497;5515.420880807537;5684.891446167958;5688.658680479101;5694.544436445157;5700.144978253295;5716.142253767459;5220.451852555579;5388.407275199646;5394;5395.298611180521;5399.649022813504;5269;5269.947300526946;5286.444923283;5296.788128474818;5362.785488580413;5602.691851948019;5607.74765135578;5616.438356164351;5632.704477970172;5632.774689012557;3763.943540846835;3902.3951287550476;3918;3934.8588909216005;3949.380753890891;5227.398849132398;5233.618703489827;5256.579473642023;5256.868578285574;5260.473952604862;5248.553872920845;5312.282841816305;5384.300040994645;5386.111291636836;5399.784008639767;5346.65246758975;5372.462753724596;5383.300170977905;5404.32445944257;5419.376771671308;5171.534561889298;5331.933613277282;5337.626366154332;5412;5435.972820135874;5465.7813687453645;5468.644538105011;5470.8085217017215;5477.424870388551;5491.341039075336;5353.518183363361;5361.973190134025;5366;5369.865753356197;5370.167624018283 22:15:48 INFO - PROCESS | 398 | |5;yui.html;765.1888997662478;793.6111305460322;827.6937533112747;828.0973738624898;855.7475544714316;16379;17357.47927562172;17399.91300043501;17423.390181343657;17547.64904701907;15996.360145594163;16179.676406471863;16188.676226475463;16189.757153642704;16222.513324600252;731.5062332925268;739.9926000740004;758.1395116542736;759.7948553890446;765.5215490318551;752.2477522477523;752.4657493179849;753.7889390970537;754.5321900421746;754.5472716370189;792.5957761541598;797.6291024673526;799.0172088331356;799.5322736199302;799.5762246009624;790.3874497264637;792.0139426414152;793.1869833420732;793.1988691421677;793.2662287384146;577.8699792546686;579.1486514823204;579.2816907035246;579.7420148034126;579.8492391978116;15516;15805.52583422499;16965.982041077576;17418.564535886577;17466;15234.771478427721;15394.538163855103;15487.612809679735;15611.531654050397;15721.528354149394;12113.515459381613;12196.878031219663;12205.20666156697;12255.816162757566;12539;3590.910227244314;3592.2204921203192;3622.464275007479;3624.2207925295925;3632.6367363263726;40693.79653101716;53007.73496132533;66104.6694766528;78688.60655696742;79073.60463197705;11958.40207989597;11964.940175299067;12057.035437165006;12249.755004899853;12252.509899604094;20708.136267735976;21610.891945540487;22283.766084443905;22431;23031.309060728207;8340.082590914995;8527.872081918777;8553.74338769838;8752.21230089295;8861.689840855539;4578.221702310615;4676.766161691902;4697.95302046982;4756.9286460703115;4849.345338379344;3793.3172029034486;3830.8276127574327;3837.501124853751;3857.9807100964317;3885.8834234972996;645.7739791073087;646.0857886091222;662.9525349947072;666.5600703535644;676.8781619308473;733.812877716179;740.256042677106;758.2909979169494;777.2188950105108;785.3010820369875;10245.334053286513;10410.211302800797;10877.619283325046;11210.383428911326;11501.13741469393;750.6697053296532;752.6838727734365;770.2899562970197;771.7568965775763;779.3609240422912;4736.4316282046375;5074.644774865797;5107.131787596118;5123.462036486189;5144.871378215575;62290;63662;66571.33428665748;79066.20933790703;83582.16417835745;68081.31918680848;68134;68408.6579567099;69272;69842;61244.69377653083;61398.0790288146;61637.38362616406;62392.37607623956;62760.68619656964;9960.352577082467;10200.540975655966;10363.896361036293;10389.9480502597;10406.427646479517;40838.79580602078;42273.15453690848;42425.5757442434;42979.35530966976;43329;51377;51580.74209628928;53747.46252537425;53795.73102134621;54001.45998539964;13324.666883327995;13583.93208033993;13704.539355326111;13880.652983675489;14191.07757995727;15095.39618415251;15583.142927138662;15931.840681593036;16474.917625412276;16647.75028374551;13293.66765830862;13438.529651462151;13621.25083120438;13984;14289.714205716036;13612.183269003892;13816.378262977989;14085.08446950945;14165.858341416453;14300.35648395804;13240.20558766477;14165.716685666435;14335.713285734435;14434.350454229794;14558.781618275523;11588.478518466858;11603.825942610698;11785.410729463663;11950.223235489666;11957.880421195676;10186.337888037255;11033.071259203794;11225.326480411202;11243.156763242952;11250.549978000789 22:15:48 INFO - PROCESS | 398 | __end_tp_report 22:15:48 INFO - PROCESS | 398 | __start_cc_report 22:15:48 INFO - PROCESS | 398 | _x_x_mozilla_cycle_collect,1850 22:15:48 INFO - PROCESS | 398 | __end_cc_report 22:15:48 INFO - PROCESS | 398 | __startTimestamp1486102548158__endTimestamp 22:15:48 INFO - PROCESS | 398 | 22:15:48 INFO - PROCESS | 398 | ------- Summary: start ------- 22:15:48 INFO - PROCESS | 398 | Number of tests: 6 22:15:48 INFO - PROCESS | 398 | 22:15:48 INFO - PROCESS | 398 | [#0] dojo.html Cycles:165 Average:5277.04 Median:5451.62 stddev:571.90 (10.5%) stddev-sans-first:549.22 22:15:48 INFO - PROCESS | 398 | Values: 3168.6 3198.2 3204.0 3237.5 3255.8 5234.8 5247.0 5257.3 5320.7 5352.4 5264.4 5268.5 5276.3 5306.7 5348.5 4553.4 4778.3 4912.9 4939.2 4950.2 4644.2 4919.0 4942.2 4955.9 4958.6 4662.2 4772.9 4790.7 4814.2 4884.2 4813.3 4818.2 4821.5 4829.0 4863.7 4774.7 4839.7 4848.9 4854.1 4881.8 5126.0 5179.9 5249.6 5326.5 5332.6 5746.0 5749.8 5784.1 5789.1 5794.8 5756.6 5769.6 5776.5 5777.9 5778.8 5071.6 5094.6 5391.0 5394.4 5396.8 5412.2 5674.6 5739.8 5741.5 5798.5 5269.4 5280.4 5552.6 5554.7 5591.2 5659.6 5714.9 5720.0 5721.0 5723.8 5451.6 5505.9 5622.7 5627.5 5636.9 5524.1 5592.4 5607.0 5641.7 5688.8 4468.9 4476.4 4477.0 4479.1 4481.2 3856.8 3886.0 3975.3 3977.3 4015.1 5397.1 5447.0 5449.3 5449.9 5512.4 5722.4 5726.5 5728.5 5735.1 5735.9 5256.3 5470.3 5480.3 5481.9 5489.8 4910.4 4965.4 5003.6 5014.2 5079.0 6093.5 6096.1 6098.9 6099.7 6103.7 5715.7 5771.3 5777.8 5778.3 5783.3 5705.6 5745.9 5746.9 5787.5 5817.7 5370.4 5426.5 5428.7 5430.2 5434.1 5419.8 5431.9 5438.2 5459.8 5492.4 5475.9 5491.8 5509.1 5512.5 5598.6 5543.0 5543.4 5544.8 5549.5 5550.0 5379.5 5517.2 5528.6 5535.6 5587.2 5472.9 5529.2 5558.1 5558.8 5641.4 5469.9 5472.6 5476.2 5478.4 5483.1 22:15:48 INFO - PROCESS | 398 | 22:15:48 INFO - PROCESS | 398 | [#1] ext.html Cycles:180 Average:61408.62 Median:21736.80 stddev:119591.76 (550.2%) stddev-sans-first:119840.05 22:15:48 INFO - PROCESS | 398 | Values: 583.8 600.8 619.6 644.0 644.6 34935.6 38192.4 44673.0 47746.8 47941.5 49980.8 50274.7 50341.7 50382.0 50455.7 8995.9 9193.5 9197.8 9199.7 9201.8 8510.2 8713.2 9056.0 10665.8 10943.3 10942.4 10976.8 11011.3 11018.6 11021.8 10968.6 10989.6 11047.0 11051.1 11090.1 10727.9 10789.9 10803.7 10814.4 10816.0 45523.5 45676.3 45893.0 45965.0 46038.1 3820.8 3890.6 3953.0 3982.4 3996.8 28905.6 31551.8 31596.7 31636.7 31680.2 4220.7 4346.3 4375.3 4383.1 4431.7 342107.0 342522.0 343365.0 345003.0 345622.0 55353.4 56820.0 56928.0 56997.7 57165.0 55792.0 56059.7 56142.7 56152.0 62736.7 17303.7 17574.0 17581.8 17583.8 17588.3 13602.9 13720.4 13729.7 13729.9 13771.8 18519.0 18662.0 18759.6 18941.5 18983.2 7053.3 7104.1 7294.7 7301.7 7340.6 886.7 914.0 926.9 933.3 943.0 31920.8 32782.2 33413.8 33485.7 33552.5 1021.4 1105.1 1113.8 1115.3 1117.8 16335.9 17402.8 17460.6 17528.5 17547.6 525245.0 529698.1 530467.0 530813.0 532163.3 66372.0 66450.3 66482.7 66744.3 66971.0 1439.3 1452.1 1476.5 1496.6 1512.0 29566.7 30578.0 31014.4 32555.7 32794.0 55333.4 56075.0 56100.7 56128.0 56167.0 458923.0 459783.0 462530.0 463218.0 465132.0 39950.2 40525.7 40738.8 40848.4 41205.8 44448.8 44974.8 45539.8 45796.8 46027.3 38592.2 38763.4 39129.8 40013.4 40180.8 37585.2 38200.0 38288.4 38724.2 39520.6 38056.2 39432.8 39720.8 41367.8 41684.4 32794.8 35639.1 36129.3 36199.3 36329.8 26322.2 26859.3 26952.2 27134.8 27140.6 22:15:48 INFO - PROCESS | 398 | 22:15:48 INFO - PROCESS | 398 | [#2] jquery.html Cycles:180 Average:31344.37 Median:41302.19 stddev:97542.62 (236.2%) stddev-sans-first:97788.56 22:15:48 INFO - PROCESS | 398 | Values: 387.7 428.8 434.7 436.3 450.9 17272.4 19610.3 20870.6 21051.0 21246.4 20624.8 21174.0 21437.9 21624.1 22049.7 5688.4 5808.4 5920.9 6030.1 6073.9 5903.8 6018.0 6067.5 6071.8 6078.8 5841.3 5933.5 5977.4 6032.3 6044.4 5967.9 5982.5 6029.0 6029.9 6037.6 5266.9 5424.6 5486.3 5535.9 5613.5 14605.9 15110.5 15145.5 15163.5 15341.5 2651.6 2706.6 2727.7 2750.3 2756.3 10642.5 10709.2 10800.4 11366.3 11432.1 1927.4 1972.7 1984.6 1995.0 2005.4 87516.0 87799.6 89621.6 89749.1 90677.0 10766.4 10828.2 11090.9 12020.8 12154.6 15616.8 15730.4 16028.7 16103.9 16166.9 8337.1 8378.9 8581.6 8683.5 8695.7 7846.6 7878.8 7903.8 8097.6 8165.6 5171.2 5231.8 5240.7 5241.2 5349.6 2064.7 2115.3 2115.7 2117.9 2169.4 853.5 870.8 873.0 891.6 906.3 19464.6 19953.6 21139.4 21206.6 21406.5 877.8 880.3 886.7 891.7 896.3 11396.1 11408.1 11639.4 11654.2 11667.5 286344.0 374066.0 693957.0 720165.0 721367.0 87350.0 94480.0 109608.0 109856.5 114183.4 527.7 542.5 542.6 542.8 544.5 11435.4 11811.4 12204.6 12450.0 12594.6 31516.4 40808.4 41796.0 43450.8 43887.3 57765.7 57956.7 61666.0 62136.4 62902.7 8284.5 8461.2 8766.2 8845.7 9191.2 9783.3 13039.7 14103.6 14124.9 14167.2 11526.5 11578.1 11615.1 11731.0 11808.8 11560.4 11746.4 11752.4 11925.9 11932.9 11351.5 11604.5 12006.5 12009.5 12124.8 8209.6 8445.5 8471.4 8614.9 8687.6 8813.1 10819.9 11723.6 11891.9 12028.5 22:15:48 INFO - PROCESS | 398 | 22:15:48 INFO - PROCESS | 398 | [#3] mootools.html Cycles:180 Average:5576.43 Median:5096.66 stddev:3094.84 (60.7%) stddev-sans-first:3087.86 22:15:48 INFO - PROCESS | 398 | Values: 1434.0 1453.9 1465.9 1475.8 1477.5 8214.6 8734.5 8745.7 8752.6 8757.5 8356.3 8631.1 8662.6 8769.7 8806.2 2263.0 2300.6 2302.9 2306.5 2308.2 2267.5 2295.7 2303.5 2303.8 2308.4 2318.1 2322.8 2335.4 2341.9 2344.4 2139.4 2157.8 2171.9 2178.0 2241.7 2158.3 2221.4 2225.5 2226.0 2226.1 8705.8 8758.8 8765.6 8779.3 8782.4 4984.2 5095.0 5112.2 5113.3 5118.8 3285.8 3286.9 3425.5 3450.5 3471.1 1461.6 1474.7 1498.6 1524.8 1542.3 10619.6 10871.6 11208.6 11654.2 11777.9 4148.0 4259.2 4288.6 4318.2 4319.8 9577.4 9582.9 9583.9 9589.3 9592.4 4639.1 4794.1 4997.1 5098.3 5101.1 4794.3 4935.0 4936.4 4944.0 4946.4 3495.2 3566.5 3600.4 3624.4 3732.5 1063.0 1070.2 1072.9 1074.1 1077.6 929.1 931.5 938.3 943.2 960.9 5712.2 5737.8 5800.1 6086.1 6096.9 984.7 991.3 994.9 1005.7 1022.3 3836.2 3852.4 3897.3 3968.0 3990.3 10222.9 10503.4 10505.4 10506.9 10514.2 10426.4 10433.7 10469.6 10470.8 10525.8 7710.2 7953.9 8044.0 8164.4 8191.3 5667.7 5749.0 5756.7 5764.5 5812.9 9262.4 9477.9 9515.4 9517.7 9519.0 8343.2 8633.1 9047.3 9424.7 9506.7 7424.1 7657.2 7722.7 7729.9 7738.2 7761.0 8186.8 8247.8 8261.5 8262.2 7453.4 7481.9 7498.6 7538.8 7566.5 7282.7 7324.2 7327.7 7413.3 7535.9 6152.8 6567.9 6690.5 6697.4 6698.2 4822.6 4998.5 5050.3 5058.8 5248.6 5103.9 5133.4 5229.6 5233.3 5439.5 22:15:48 INFO - PROCESS | 398 | 22:15:48 INFO - PROCESS | 398 | [#4] prototype.html Cycles:180 Average:4542.62 Median:5124.33 stddev:1298.47 (25.3%) stddev-sans-first:1264.34 22:15:48 INFO - PROCESS | 398 | Values: 399.8 401.8 413.8 415.7 424.9 4912.8 5084.3 5097.5 5122.1 5162.7 4999.9 5074.2 5110.9 5126.7 5139.9 4137.5 4150.6 4160.0 4167.4 4179.8 3939.5 4021.5 4175.6 4193.1 4202.8 4055.8 4077.1 4077.6 4078.4 4090.3 4052.4 4067.4 4077.0 4088.5 4111.2 3667.3 3676.8 3688.7 3690.4 3693.5 4986.3 5056.7 5069.9 5091.5 5098.8 4705.8 4706.7 4709.4 4711.0 4721.9 5432.7 5436.6 5437.9 5439.8 5444.9 3846.4 3929.2 3983.2 3985.0 3999.5 5634.1 5639.3 5651.7 5655.9 5657.9 4089.7 4099.4 4105.2 4108.4 4108.4 4041.2 4131.6 4144.2 4150.2 4168.2 4660.8 4664.6 4685.7 4695.8 4697.2 5472.7 5474.9 5481.1 5486.9 5498.7 1308.3 1331.7 1342.9 1372.7 1376.5 948.6 957.0 968.7 972.5 978.5 5097.5 5098.4 5102.6 5110.7 5112.1 5281.4 5336.8 5337.7 5347.3 5354.0 4809.0 5032.0 5086.6 5114.9 5126.5 2824.6 2831.1 2835.9 2837.6 2837.7 5559.5 5562.1 5622.6 5623.2 5635.2 5218.8 5432.9 5438.0 5483.5 5515.4 5684.9 5688.7 5694.5 5700.1 5716.1 5220.5 5388.4 5394.0 5395.3 5399.6 5269.0 5269.9 5286.4 5296.8 5362.8 5602.7 5607.7 5616.4 5632.7 5632.8 3763.9 3902.4 3918.0 3934.9 3949.4 5227.4 5233.6 5256.6 5256.9 5260.5 5248.6 5312.3 5384.3 5386.1 5399.8 5346.7 5372.5 5383.3 5404.3 5419.4 5171.5 5331.9 5337.6 5412.0 5436.0 5465.8 5468.6 5470.8 5477.4 5491.3 5353.5 5362.0 5366.0 5369.9 5370.2 22:15:48 INFO - PROCESS | 398 | 22:15:48 INFO - PROCESS | 398 | [#5] yui.html Cycles:180 Average:17228.78 Median:41555.98 stddev:20717.55 (49.9%) stddev-sans-first:20738.78 22:15:48 INFO - PROCESS | 398 | Values: 765.2 793.6 827.7 828.1 855.7 16379.0 17357.5 17399.9 17423.4 17547.6 15996.4 16179.7 16188.7 16189.8 16222.5 731.5 740.0 758.1 759.8 765.5 752.2 752.5 753.8 754.5 754.5 792.6 797.6 799.0 799.5 799.6 790.4 792.0 793.2 793.2 793.3 577.9 579.1 579.3 579.7 579.8 15516.0 15805.5 16966.0 17418.6 17466.0 15234.8 15394.5 15487.6 15611.5 15721.5 12113.5 12196.9 12205.2 12255.8 12539.0 3590.9 3592.2 3622.5 3624.2 3632.6 40693.8 53007.7 66104.7 78688.6 79073.6 11958.4 11964.9 12057.0 12249.8 12252.5 20708.1 21610.9 22283.8 22431.0 23031.3 8340.1 8527.9 8553.7 8752.2 8861.7 4578.2 4676.8 4698.0 4756.9 4849.3 3793.3 3830.8 3837.5 3858.0 3885.9 645.8 646.1 663.0 666.6 676.9 733.8 740.3 758.3 777.2 785.3 10245.3 10410.2 10877.6 11210.4 11501.1 750.7 752.7 770.3 771.8 779.4 4736.4 5074.6 5107.1 5123.5 5144.9 62290.0 63662.0 66571.3 79066.2 83582.2 68081.3 68134.0 68408.7 69272.0 69842.0 61244.7 61398.1 61637.4 62392.4 62760.7 9960.4 10200.5 10363.9 10389.9 10406.4 40838.8 42273.2 42425.6 42979.4 43329.0 51377.0 51580.7 53747.5 53795.7 54001.5 13324.7 13583.9 13704.5 13880.7 14191.1 15095.4 15583.1 15931.8 16474.9 16647.8 13293.7 13438.5 13621.3 13984.0 14289.7 13612.2 13816.4 14085.1 14165.9 14300.4 13240.2 14165.7 14335.7 14434.4 14558.8 11588.5 11603.8 11785.4 11950.2 11957.9 10186.3 11033.1 11225.3 11243.2 11250.5 22:15:48 INFO - PROCESS | 398 | -------- Summary: end -------- 22:15:48 INFO - PROCESS | 398 | 22:15:48 INFO - TEST-INFO | 398: exit 0 22:15:48 INFO - TEST-OK | dromaeo_css | took 1115534ms 22:15:48 INFO - TEST-START | kraken 22:15:48 INFO - operating with platform_type : linux_ 22:15:48 INFO - Initialising browser for kraken test... 22:15:48 INFO - TEST-INFO | started process 706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx59ae6/profile http://localhost:53314/getInfo.html) 22:15:52 INFO - PROCESS | 706 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 22:15:52 INFO - PROCESS | 706 | __metrics Screen width/height:1600/1200 22:15:52 INFO - PROCESS | 706 | colorDepth:24 22:15:52 INFO - PROCESS | 706 | Browser inner width/height: 1024/697 22:15:52 INFO - PROCESS | 706 | __metrics 22:15:53 INFO - PROCESS | 706 | 1486102553391 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 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 22:15:53 INFO - PROCESS | 706 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:15:53 INFO - PROCESS | 706 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:15:54 INFO - PROCESS | 706 | console.error: PushService: 22:15:54 INFO - PROCESS | 706 | stateChangeProcessEnqueue: Error transitioning state 22:15:54 INFO - PROCESS | 706 | UnknownError 22:15:54 INFO - TEST-INFO | 706: exit 0 22:15:54 INFO - Browser initialized. 22:15:54 INFO - Running cycle 1/1 for kraken test... 22:15:54 INFO - TEST-INFO | started process 794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx59ae6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:16:06 INFO - PROCESS | 794 | RSS: Main: 149061632 22:16:06 INFO - PROCESS | 794 | 22:16:09 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53314/tests/kraken/driver.html?testName=audio-beat-detection) 22:16:10 INFO - PROCESS | 794 | RSS: Main: 204902400 22:16:10 INFO - PROCESS | 794 | 22:16:12 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53314/tests/kraken/driver.html?testName=audio-dft) 22:16:13 INFO - PROCESS | 794 | RSS: Main: 183738368 22:16:13 INFO - PROCESS | 794 | 22:16:16 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53314/tests/kraken/driver.html?testName=audio-fft) 22:16:16 INFO - PROCESS | 794 | RSS: Main: 265588736 22:16:16 INFO - PROCESS | 794 | 22:16:18 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53314/tests/kraken/driver.html?testName=audio-oscillator) 22:16:19 INFO - PROCESS | 794 | RSS: Main: 177221632 22:16:19 INFO - PROCESS | 794 | 22:16:21 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53314/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:16:22 INFO - PROCESS | 794 | RSS: Main: 181022720 22:16:22 INFO - PROCESS | 794 | 22:16:25 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53314/tests/kraken/driver.html?testName=imaging-darkroom) 22:16:25 INFO - PROCESS | 794 | RSS: Main: 220569600 22:16:25 INFO - PROCESS | 794 | 22:16:29 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53314/tests/kraken/driver.html?testName=imaging-desaturate) 22:16:29 INFO - PROCESS | 794 | RSS: Main: 220680192 22:16:29 INFO - PROCESS | 794 | 22:16:32 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53314/tests/kraken/driver.html?testName=json-parse-financial) 22:16:33 INFO - PROCESS | 794 | RSS: Main: 219119616 22:16:33 INFO - PROCESS | 794 | 22:16:34 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53314/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:35 INFO - PROCESS | 794 | RSS: Main: 181153792 22:16:35 INFO - PROCESS | 794 | 22:16:37 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53314/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:37 INFO - PROCESS | 794 | RSS: Main: 188293120 22:16:37 INFO - PROCESS | 794 | 22:16:39 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53314/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:40 INFO - PROCESS | 794 | RSS: Main: 196460544 22:16:40 INFO - PROCESS | 794 | 22:16:42 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:43 INFO - PROCESS | 794 | RSS: Main: 206065664 22:16:43 INFO - PROCESS | 794 | 22:16:46 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:47 INFO - PROCESS | 794 | RSS: Main: 202903552 22:16:47 INFO - PROCESS | 794 | 22:16:48 INFO - PROCESS | 794 | Cycle 1(1): loaded http://localhost:53314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53314/tests/kraken/driver.html?testName=ai-astar) 22:16:48 INFO - PROCESS | 794 | RSS: Main: 254025728 22:16:48 INFO - PROCESS | 794 | 22:16:48 INFO - PROCESS | 794 | __start_tp_report 22:16:48 INFO - PROCESS | 794 | _x_x_mozilla_page_load 22:16:48 INFO - PROCESS | 794 | _x_x_mozilla_page_load_details 22:16:48 INFO - PROCESS | 794 | |i|pagename|runs| 22:16:48 INFO - PROCESS | 794 | |0;ai-astar;110;111;111;112;112;112;111;111;113;111 22:16:48 INFO - PROCESS | 794 | |1;audio-beat-detection;145;124;122;164;121;122;119;120;140;118 22:16:48 INFO - PROCESS | 794 | |2;audio-dft;161;161;159;160;161;161;162;160;161;161 22:16:48 INFO - PROCESS | 794 | |3;audio-fft;75;75;75;108;75;77;75;76;98;76 22:16:48 INFO - PROCESS | 794 | |4;audio-oscillator;82;82;114;83;82;83;99;83;82;122 22:16:48 INFO - PROCESS | 794 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 22:16:48 INFO - PROCESS | 794 | |6;imaging-darkroom;146;146;146;147;147;147;147;147;146;148 22:16:48 INFO - PROCESS | 794 | |7;imaging-desaturate;95;95;95;96;96;96;95;95;96;95 22:16:48 INFO - PROCESS | 794 | |8;json-parse-financial;56;56;57;55;56;57;55;56;56;56 22:16:48 INFO - PROCESS | 794 | |9;json-stringify-tinderbox;67;68;68;68;69;69;67;67;68;67 22:16:48 INFO - PROCESS | 794 | |10;stanford-crypto-aes;87;84;82;84;82;82;83;82;81;83 22:16:48 INFO - PROCESS | 794 | |11;stanford-crypto-ccm;129;127;135;126;137;125;125;133;170;138 22:16:48 INFO - PROCESS | 794 | |12;stanford-crypto-pbkdf2;167;174;171;167;171;171;170;175;170;172 22:16:48 INFO - PROCESS | 794 | |13;stanford-crypto-sha256-iterative;63;64;62;63;63;71;63;63;64;61 22:16:48 INFO - PROCESS | 794 | __end_tp_report 22:16:48 INFO - PROCESS | 794 | __start_cc_report 22:16:48 INFO - PROCESS | 794 | _x_x_mozilla_cycle_collect,1615 22:16:48 INFO - PROCESS | 794 | __end_cc_report 22:16:48 INFO - PROCESS | 794 | __startTimestamp1486102608992__endTimestamp 22:16:48 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | ------- Summary: start ------- 22:16:49 INFO - PROCESS | 794 | Number of tests: 14 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:0.84 (0.8%) stddev-sans-first:0.73 22:16:49 INFO - PROCESS | 794 | Values: 110.0 111.0 111.0 112.0 112.0 112.0 111.0 111.0 113.0 111.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:123.00 stddev:15.23 (12.4%) stddev-sans-first:15.09 22:16:49 INFO - PROCESS | 794 | Values: 145.0 124.0 122.0 164.0 121.0 122.0 119.0 120.0 140.0 118.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 22:16:49 INFO - PROCESS | 794 | Values: 161.0 161.0 159.0 160.0 161.0 161.0 162.0 160.0 161.0 161.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:11.85 (15.7%) stddev-sans-first:12.37 22:16:49 INFO - PROCESS | 794 | Values: 75.0 75.0 75.0 108.0 75.0 77.0 75.0 76.0 98.0 76.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.50 stddev:15.16 (18.4%) stddev-sans-first:15.71 22:16:49 INFO - PROCESS | 794 | Values: 82.0 82.0 114.0 83.0 82.0 83.0 99.0 83.0 82.0 122.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:16:49 INFO - PROCESS | 794 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 22:16:49 INFO - PROCESS | 794 | Values: 146.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 148.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:16:49 INFO - PROCESS | 794 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 22:16:49 INFO - PROCESS | 794 | Values: 56.0 56.0 57.0 55.0 56.0 57.0 55.0 56.0 56.0 56.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 22:16:49 INFO - PROCESS | 794 | Values: 67.0 68.0 68.0 68.0 69.0 69.0 67.0 67.0 68.0 67.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:1.70 (2.0%) stddev-sans-first:1.01 22:16:49 INFO - PROCESS | 794 | Values: 87.0 84.0 82.0 84.0 82.0 82.0 83.0 82.0 81.0 83.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:134.00 stddev:13.42 (10.0%) stddev-sans-first:14.08 22:16:49 INFO - PROCESS | 794 | Values: 129.0 127.0 135.0 126.0 137.0 125.0 125.0 133.0 170.0 138.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.00 stddev:2.57 (1.5%) stddev-sans-first:2.33 22:16:49 INFO - PROCESS | 794 | Values: 167.0 174.0 171.0 167.0 171.0 171.0 170.0 175.0 170.0 172.0 22:16:49 INFO - PROCESS | 794 | 22:16:49 INFO - PROCESS | 794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.00 stddev:2.71 (4.3%) stddev-sans-first:2.86 22:16:49 INFO - PROCESS | 794 | Values: 63.0 64.0 62.0 63.0 63.0 71.0 63.0 63.0 64.0 61.0 22:16:49 INFO - PROCESS | 794 | -------- Summary: end -------- 22:16:49 INFO - PROCESS | 794 | 22:16:50 INFO - TEST-INFO | 794: exit 0 22:16:50 INFO - TEST-OK | kraken | took 61206ms 22:16:50 INFO - SUITE-END | took 1176s 22:16:50 INFO - Completed test suite (00:19:36) 22:16:50 INFO - javascript benchmark 22:16:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7190.288326914892, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3168.5564021037058, 3198.1844629619445, 3204.0227730542183, 3237.5143728440717, 3255.8209298488573, 5234.842954711356, 5247.0, 5257.316548848649, 5320.707361095138, 5352.384475785281, 5264.447233040533, 5268.525832675058, 5276.314079169712, 5306.681599104057, 5348.5453736432355, 4553.408056952591, 4778.259369797678, 4912.877178070541, 4939.234418665113, 4950.207966725325, 4644.187267228239, 4918.950810491903, 4942.233953737176, 4955.925661115069, 4958.6281028922795, 4662.207424737802, 4772.904541909143, 4790.664653474259, 4814.157522433595, 4884.218525035977, 4813.253945638432, 4818.229083346648, 4821.5178482151505, 4828.951710482886, 4863.659543831933, 4774.689645173053, 4839.7096174229655, 4848.903021939576, 4854.053459575384, 4881.755912204376, 5126.0, 5179.870503237412, 5249.580033597341, 5326.547243484309, 5332.626716129873, 5745.971270143623, 5749.770009199627, 5784.074548072288, 5789.131630255495, 5794.768209271624, 5756.5682573807135, 5769.5672824537905, 5776.508996735282, 5777.884442311172, 5778.768849246025, 5071.594272458195, 5094.566961808214, 5390.97304513475, 5394.379646340682, 5396.784128634889, 5412.242286079952, 5674.574406919415, 5739.827805165852, 5741.483266505951, 5798.478136967608, 5269.367675878842, 5280.3663560373, 5552.639078459887, 5554.666719996813, 5591.217229587861, 5659.603827732101, 5714.857128571736, 5719.971400142973, 5720.971395143081, 5723.828285151452, 5451.618386712892, 5505.862353441196, 5622.662640241517, 5627.549796016309, 5636.887262254732, 5524.14375771756, 5592.384837667853, 5606.971965140148, 5641.661500309994, 5688.829335119953, 4468.932966005513, 4476.37330773692, 4477.037436951006, 4479.10417916418, 4481.215787237285, 3856.845726170922, 3885.9611403886165, 3975.264576053439, 3977.3238549446664, 4015.0765323975065, 5397.10947693634, 5447.0, 5449.25623800388, 5449.945500544944, 5512.39363669996, 5722.427757224327, 5726.541876649858, 5728.513076388554, 5735.11105778605, 5735.942640573624, 5256.316678831728, 5470.288862447856, 5480.314960629921, 5481.862953426196, 5489.807856724996, 4910.386201724785, 4965.404151501771, 5003.5997120230295, 5014.222795466709, 5079.034983353225, 6093.482054025369, 6096.0855871619615, 6098.908516372258, 6099.69501524922, 6103.725332360054, 5715.714214289352, 5771.307443106854, 5777.826665200051, 5778.335491418541, 5783.306003279633, 5705.62913410627, 5745.8563535911935, 5746.856328591819, 5787.450192231731, 5817.6509409433875, 5370.409254981871, 5426.4573542646995, 5428.70142142186, 5430.212619170277, 5434.130539113723, 5419.810306639249, 5431.945680543144, 5438.2386465894015, 5459.781608735606, 5492.368377636623, 5475.917861232005, 5491.835244942658, 5509.118541033416, 5512.503874651301, 5598.552115830642, 5543.029969755357, 5543.417941116125, 5544.778208871761, 5549.472800083986, 5550.0, 5379.488948549882, 5517.200005999028, 5528.55771538284, 5535.640183388228, 5587.245721827664, 5472.890542189213, 5529.225908372911, 5558.138488534284, 5558.833235002957, 5641.435856414326, 5469.890602188014, 5472.644278121909, 5476.17857321405, 5478.397376288684, 5483.122700367922], "value": 5241.271666456243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.8277708076117, 600.8167508909784, 619.597261779843, 644.0210879463216, 644.6325594411187, 34935.584984327405, 38192.427113593316, 44672.999999999956, 47746.76126619371, 47941.52058479414, 49980.75009624947, 50274.74862625691, 50341.74829125849, 50382.0, 50455.74772126143, 8995.865062024075, 9193.494357810318, 9197.770055748626, 9199.724008279729, 9201.769955751093, 8510.191531804468, 8713.215810577078, 9055.954720226422, 10665.84001239982, 10943.343399396063, 10942.398168100752, 10976.780464390707, 11011.28426652265, 11018.614348497764, 11021.83467247992, 10968.561257549689, 10989.560417583287, 11047.0, 11051.060659843923, 11090.112790976702, 10727.946360268226, 10789.946050269777, 10803.729906752316, 10814.405207713573, 10816.0, 45523.54476455226, 45676.314855277196, 45893.0, 45965.0, 46038.079238415376, 3820.7707537547835, 3890.6498415142773, 3953.0, 3982.422548730447, 3996.800959712075, 28905.56641650377, 31551.84224078865, 31596.684033159603, 31636.683633163604, 31680.207994800083, 4220.683448741357, 4346.282863327548, 4375.321825117112, 4383.101464199832, 4431.748298914875, 342107.0, 342521.9999999975, 343365.0, 345003.0, 345622.0, 55353.44646553483, 56820.0, 56928.0, 56997.715011424676, 57165.0, 55792.0, 56059.719701401234, 56142.719286403306, 56152.0, 62736.68631656813, 17303.65392692139, 17574.0, 17581.82418175802, 17583.824161758475, 17588.296468141387, 13602.863971360357, 13720.382582783799, 13729.725405492034, 13729.931350343384, 13771.793423098661, 18519.0, 18662.0, 18759.624807503773, 18941.526461838563, 18983.240670373307, 7053.329933656294, 7104.0764700589625, 7294.674887332171, 7301.744438944612, 7340.596267205355, 886.7073865624458, 913.9618650409624, 926.8748718922994, 933.272047802715, 943.0381011368503, 31920.840395797873, 32782.18044548905, 33413.83293083568, 33485.66514334874, 33552.496712549335, 1021.382063851374, 1105.082781291526, 1113.7661091170783, 1115.275071203724, 1117.8267368557886, 16335.902903067243, 17402.82597174012, 17460.563485912953, 17528.474145775646, 17547.561310967074, 525245.0, 529698.1392419038, 530467.0, 530813.0, 532163.3391833015, 66372.0, 66450.33549664538, 66482.66758666176, 66744.3325566738, 66970.99543506851, 1439.3019385597977, 1452.0634190946992, 1476.4758510728752, 1496.6258435391153, 1512.0322993284308, 29566.704332956397, 30578.0, 31014.379712406077, 32555.674443255266, 32794.0, 55333.44666553444, 56075.0, 56100.719496403886, 56128.0, 56167.0, 458923.0, 459783.0, 462530.0, 463218.0, 465132.0, 39950.2009959805, 40525.7316897165, 40738.79630601947, 40848.38727419032, 41205.793971029954, 44448.77775611101, 44974.77512612416, 45539.772301138284, 45796.7710161447, 46027.30959035684, 38592.22815543617, 38763.41854872123, 39129.804350979204, 40013.39979900246, 40180.79909600433, 37585.24829503449, 38200.0, 38288.42567361436, 38724.2255154901, 39520.60479395284, 38056.238875222894, 39432.80283598564, 39720.801395992836, 41367.793161034, 41684.374734378405, 32794.83602581972, 35639.10902227362, 36129.27741445104, 36199.27601448009, 36329.81835090808, 26322.210333690018, 26859.32851678724, 26952.191434257005, 27134.829213663255, 27140.592891106255], "value": 20923.4386437576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.7285899870092, 428.802750734662, 434.7379088519101, 436.26489365419263, 450.87150162203756, 17272.395466158687, 19610.313639022635, 20870.58258834826, 21051.0, 21246.362609121752, 20624.793752062513, 21174.0, 21437.892810535963, 21624.135034598596, 22049.669254961187, 5688.402717714643, 5808.361080281165, 5920.911186332198, 6030.095485677161, 6073.87633287841, 5903.763849446017, 6017.969910150443, 6067.453929146376, 6071.848203794918, 6078.784243151365, 5841.299044114691, 5933.465988061073, 5977.372375900533, 6032.276126864783, 6044.425779550936, 5967.910481342783, 5982.521398288127, 6029.035354343284, 6029.939700603026, 6037.637741735488, 5266.8683282917855, 5424.566034717213, 5486.259354987065, 5535.916961245584, 5613.494785469286, 14605.926970365186, 15110.5466835994, 15145.545633630898, 15163.469278575307, 15341.471461563902, 2651.6287719719253, 2706.580480025599, 2727.699953005168, 2750.3261700883213, 2756.3109222694325, 10642.521086551124, 10709.196810239264, 10800.351978881214, 11366.26119302251, 11432.142589305753, 1927.44104209779, 1972.6646470100118, 1984.573316736894, 1994.9800501995085, 2005.398380485863, 87516.0, 87799.56100219458, 89621.55189224078, 89749.10250897473, 90677.0, 10766.407847568302, 10828.24202305831, 11090.944545277383, 12020.819687704692, 12154.574589889311, 15616.76574851378, 15730.370785168694, 16028.67942641164, 16103.919480402757, 16166.919165404333, 8337.124601916712, 8378.874316885129, 8581.613827377783, 8683.478991260545, 8695.695650652196, 7846.568438735924, 7878.763637090897, 7903.84192316162, 8097.595120243965, 8165.63254653542, 5171.198464238049, 5231.843044708588, 5240.65935714185, 5241.24002019705, 5349.5720342372515, 2064.700618410322, 2115.3183219340663, 2115.661494160927, 2117.8517503774897, 2169.4467910682674, 853.487907255654, 870.7997160652959, 872.9781755456038, 891.5987805487556, 906.2885634776669, 19464.610707785763, 19953.60092798136, 21139.365819025454, 21206.638008597358, 21406.464838378855, 877.7542288159326, 880.2517859819103, 886.6719313853915, 891.6938715861727, 896.3053633434141, 11396.14528910335, 11408.144389170846, 11639.418029098511, 11654.184207105422, 11667.533298667959, 286344.0, 374066.0, 693957.0, 720164.9835016561, 721367.0, 87350.0, 94480.0, 109608.0, 109856.4507177459, 114183.42908285405, 527.6543863769238, 542.4738004135982, 542.5551048140566, 542.8127296082845, 544.4582640272954, 11435.428228588371, 11811.350375729073, 12204.633860984184, 12450.0, 12594.559190428292, 31516.369672606877, 40808.3878741825, 41796.0, 43450.782746086064, 43887.29465169635, 57765.71117144387, 57956.71021644865, 61666.0, 62136.378636213056, 62902.68548657227, 8284.544350060805, 8461.153884611489, 8766.167214114905, 8845.734627961172, 9191.172794448532, 9783.315167938175, 13039.739205216032, 14103.576892693236, 14124.858751412765, 14167.220802855942, 11526.538938442704, 11578.131640127192, 11615.128865334964, 11731.0, 11808.82286765682, 11560.421978900853, 11746.353950532803, 11752.412379380825, 11925.880741192477, 11932.880671193177, 11351.489182986621, 11604.535818567163, 12006.519739210684, 12009.519619215484, 12124.75750485003, 8209.58952052383, 8445.493270403795, 8471.364647651573, 8614.870776938476, 8687.609057592297, 8813.074627164055, 10819.891801081889, 11723.589674361698, 11891.881081189078, 12028.458719357475], "value": 9151.927499985242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.9713205735893, 1453.876420504257, 1465.948691795787, 1475.7786332050198, 1477.4902658582785, 8214.630341634625, 8734.51960142192, 8745.693900713477, 8752.606132724026, 8757.474551526904, 8356.289715374185, 8631.136886311366, 8662.610182541785, 8769.736907892757, 8806.20744133028, 2262.9886850565767, 2300.631898896177, 2302.861828290308, 2306.527161931808, 2308.249818808894, 2267.455810605459, 2295.6556516522487, 2303.4702018535745, 2303.7581053989343, 2308.365199570115, 2318.13070098713, 2322.837401381904, 2335.369450248432, 2341.9414514637183, 2344.402177444749, 2139.358192542239, 2157.7518585362727, 2171.9022643981057, 2178.0, 2241.7421996470453, 2158.3093410108772, 2221.389117992549, 2225.5326381459913, 2226.0428015953134, 2226.065052677879, 8705.82588348236, 8758.824823503557, 8765.561721913942, 8779.253763430115, 8782.38523303369, 4984.177610694231, 5095.0, 5112.233165025276, 5113.258577506241, 5118.820841270538, 3285.7535684823733, 3286.8849590264467, 3425.537552430415, 3450.5341778860034, 3471.1322169457635, 1461.6272850423181, 1474.6903150338442, 1498.625343664084, 1524.8475152484773, 1542.2751306885746, 10619.57521699131, 10871.565137394495, 11208.607698730586, 11654.184207105505, 11777.882221177764, 4148.0, 4259.190753756776, 4288.614024737789, 4318.244307246219, 4319.827206911751, 9577.377470464398, 9582.90417095834, 9583.856242156373, 9589.280803939733, 9592.424454532751, 4639.141758774637, 4794.065157294294, 4997.075541024922, 5098.311727916758, 5101.132807422747, 4794.304825800239, 4934.950650493449, 4936.432310284364, 4943.950560494349, 4946.3817022872145, 3495.1611613212644, 3566.5363502744995, 3600.369935261371, 3624.4382120771324, 3732.496113024761, 1062.9787404251872, 1070.1652710885521, 1072.8819829818713, 1074.0655629602295, 1077.6389909380289, 929.0755698080318, 931.5016466190556, 938.346462563063, 943.1747221181329, 960.8750862387844, 5712.2288491054005, 5737.827865164052, 5800.1299805029585, 6086.147939288503, 6096.939030609726, 984.718010313726, 991.2862738828177, 994.9403035817874, 1005.703317521333, 1022.3354819367471, 3836.156045669948, 3852.3643598806443, 3897.2595206910596, 3967.9801600992387, 3990.301697203036, 10222.897771022195, 10503.369797812156, 10505.422201778823, 10506.947465262778, 10514.21143414247, 10426.374417534973, 10433.739156521147, 10469.581216751398, 10470.790584188273, 10525.789484210272, 7710.151883292945, 7953.880691789628, 8043.959780201179, 8164.428490005761, 8191.303739182236, 5667.724761928533, 5749.04532458966, 5756.65460072397, 5764.481196692318, 5812.94187058124, 9262.351635385457, 9477.857832132386, 9515.429074255568, 9517.666881659108, 9519.00050494688, 8343.249107580346, 8633.05036445978, 9047.321450891079, 9424.670136545188, 9506.714798556055, 7424.071991001125, 7657.157712651715, 7722.652480638272, 7729.884051739116, 7738.187490313661, 7761.0, 8186.754397368089, 8247.752567422987, 8261.545614991233, 8262.215089566482, 7453.366463850417, 7481.850362992818, 7498.58757768328, 7538.773836784905, 7566.470347075652, 7282.745103921549, 7324.194338622854, 7327.74352897646, 7413.25867413276, 7535.944967704416, 6152.846178845564, 6567.868642627216, 6690.498212634169, 6697.430718388991, 6698.162729658793, 4822.638302127284, 4998.475160108282, 5050.3182070420025, 5058.772355244097, 5248.60635452335, 5103.87240318995, 5133.383993920604, 5229.581633469237, 5233.267342572119, 5439.48324909133], "value": 4507.354016230517, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.8320705303772, 401.821189570641, 413.8489451350257, 415.7048495568146, 424.9298865687161, 4912.848642896746, 5084.288199652052, 5097.515736005078, 5122.1292380295345, 5162.741862906849, 4999.875003124915, 5074.213496907985, 5110.872228194297, 5126.692398456095, 5139.922901156477, 4137.482814648169, 4150.64719498843, 4159.984011591595, 4167.354060120686, 4179.770112643803, 3939.5075615548058, 4021.537523184842, 4175.624193822556, 4193.0984838259765, 4202.789860506978, 4055.756654600719, 4077.0826564023155, 4077.57284950268, 4078.4086307485395, 4090.2637525245445, 4052.399302275614, 4067.410225517313, 4076.9592304076878, 4088.4889388826396, 4111.218868414991, 3667.2665466906724, 3676.7977761223124, 3688.686461650763, 3690.3541880171133, 3693.519842420495, 4986.326845875797, 5056.721880296583, 5069.909969356606, 5091.516305950929, 5098.821541246039, 4705.800020994659, 4706.694064885805, 4709.387779588666, 4711.0, 4721.881952951169, 5432.701201433959, 5436.619436639437, 5437.918431223535, 5439.836804895859, 5444.863878403032, 3846.3653497173214, 3929.214157168578, 3983.2431837950985, 3984.980075099606, 3999.500187429714, 5634.098439303762, 5639.323281206241, 5651.660900345952, 5655.8586035349035, 5657.9434205658235, 4089.670856971496, 4099.385092236129, 4105.240530501807, 4108.404281379183, 4108.424820525129, 4041.2321658884716, 4131.628153466202, 4144.181956269766, 4150.232207041707, 4168.166366726667, 4660.790264438108, 4664.55686709762, 4685.672002959828, 4695.835645752382, 4697.177993851063, 5472.7263636818, 5474.890502189934, 5481.095619222863, 5486.890262194734, 5498.697571633518, 1308.3131356037966, 1331.7269959658247, 1342.939567719455, 1372.7048684532874, 1376.511338474847, 948.6008137996538, 956.9856452153223, 968.6997030920437, 972.4748635736764, 978.4862946952907, 5097.490250974873, 5098.362704661918, 5102.566281866083, 5110.66780659256, 5112.137203166239, 5281.366236051622, 5336.839894803162, 5337.653052551572, 5347.304850369427, 5354.0, 4808.980228304121, 5031.974840125776, 5086.618503612244, 5114.872128196825, 5126.53861152498, 2824.562192860069, 2831.0940499040107, 2835.8865645373953, 2837.5670286505183, 2837.7020412856355, 5559.499645031886, 5562.135500217391, 5622.634528755618, 5623.212750214973, 5635.239242702265, 5218.7559349479325, 5432.864178395493, 5438.0, 5483.533899618497, 5515.420880807537, 5684.891446167958, 5688.658680479101, 5694.544436445157, 5700.144978253295, 5716.142253767459, 5220.451852555579, 5388.407275199646, 5394.0, 5395.298611180521, 5399.649022813504, 5269.0, 5269.947300526946, 5286.444923283, 5296.788128474818, 5362.785488580413, 5602.691851948019, 5607.74765135578, 5616.438356164351, 5632.704477970172, 5632.774689012557, 3763.943540846835, 3902.3951287550476, 3918.0, 3934.8588909216005, 3949.380753890891, 5227.398849132398, 5233.618703489827, 5256.579473642023, 5256.868578285574, 5260.473952604862, 5248.553872920845, 5312.282841816305, 5384.300040994645, 5386.111291636836, 5399.784008639767, 5346.65246758975, 5372.462753724596, 5383.300170977905, 5404.32445944257, 5419.376771671308, 5171.534561889298, 5331.933613277282, 5337.626366154332, 5412.0, 5435.972820135874, 5465.7813687453645, 5468.644538105011, 5470.8085217017215, 5477.424870388551, 5491.341039075336, 5353.518183363361, 5361.973190134025, 5366.0, 5369.865753356197, 5370.167624018283], "value": 4151.124861359904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.1888997662478, 793.6111305460322, 827.6937533112747, 828.0973738624898, 855.7475544714316, 16379.0, 17357.47927562172, 17399.91300043501, 17423.390181343657, 17547.64904701907, 15996.360145594163, 16179.676406471863, 16188.676226475463, 16189.757153642704, 16222.513324600252, 731.5062332925268, 739.9926000740004, 758.1395116542736, 759.7948553890446, 765.5215490318551, 752.2477522477523, 752.4657493179849, 753.7889390970537, 754.5321900421746, 754.5472716370189, 792.5957761541598, 797.6291024673526, 799.0172088331356, 799.5322736199302, 799.5762246009624, 790.3874497264637, 792.0139426414152, 793.1869833420732, 793.1988691421677, 793.2662287384146, 577.8699792546686, 579.1486514823204, 579.2816907035246, 579.7420148034126, 579.8492391978116, 15516.0, 15805.52583422499, 16965.982041077576, 17418.564535886577, 17466.0, 15234.771478427721, 15394.538163855103, 15487.612809679735, 15611.531654050397, 15721.528354149394, 12113.515459381613, 12196.878031219663, 12205.20666156697, 12255.816162757566, 12539.0, 3590.910227244314, 3592.2204921203192, 3622.464275007479, 3624.2207925295925, 3632.6367363263726, 40693.79653101716, 53007.73496132533, 66104.6694766528, 78688.60655696742, 79073.60463197705, 11958.40207989597, 11964.940175299067, 12057.035437165006, 12249.755004899853, 12252.509899604094, 20708.136267735976, 21610.891945540487, 22283.766084443905, 22431.0, 23031.309060728207, 8340.082590914995, 8527.872081918777, 8553.74338769838, 8752.21230089295, 8861.689840855539, 4578.221702310615, 4676.766161691902, 4697.95302046982, 4756.9286460703115, 4849.345338379344, 3793.3172029034486, 3830.8276127574327, 3837.501124853751, 3857.9807100964317, 3885.8834234972996, 645.7739791073087, 646.0857886091222, 662.9525349947072, 666.5600703535644, 676.8781619308473, 733.812877716179, 740.256042677106, 758.2909979169494, 777.2188950105108, 785.3010820369875, 10245.334053286513, 10410.211302800797, 10877.619283325046, 11210.383428911326, 11501.13741469393, 750.6697053296532, 752.6838727734365, 770.2899562970197, 771.7568965775763, 779.3609240422912, 4736.4316282046375, 5074.644774865797, 5107.131787596118, 5123.462036486189, 5144.871378215575, 62290.0, 63662.0, 66571.33428665748, 79066.20933790703, 83582.16417835745, 68081.31918680848, 68134.0, 68408.6579567099, 69272.0, 69842.0, 61244.69377653083, 61398.0790288146, 61637.38362616406, 62392.37607623956, 62760.68619656964, 9960.352577082467, 10200.540975655966, 10363.896361036293, 10389.9480502597, 10406.427646479517, 40838.79580602078, 42273.15453690848, 42425.5757442434, 42979.35530966976, 43329.0, 51377.0, 51580.74209628928, 53747.46252537425, 53795.73102134621, 54001.45998539964, 13324.666883327995, 13583.93208033993, 13704.539355326111, 13880.652983675489, 14191.07757995727, 15095.39618415251, 15583.142927138662, 15931.840681593036, 16474.917625412276, 16647.75028374551, 13293.66765830862, 13438.529651462151, 13621.25083120438, 13984.0, 14289.714205716036, 13612.183269003892, 13816.378262977989, 14085.08446950945, 14165.858341416453, 14300.35648395804, 13240.20558766477, 14165.716685666435, 14335.713285734435, 14434.350454229794, 14558.781618275523, 11588.478518466858, 11603.825942610698, 11785.410729463663, 11950.223235489666, 11957.880421195676, 10186.337888037255, 11033.071259203794, 11225.326480411202, 11243.156763242952, 11250.549978000789], "value": 7357.993718387053, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 112.0, 112.0, 112.0, 111.0, 111.0, 113.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 122.0, 164.0, 121.0, 122.0, 119.0, 120.0, 140.0, 118.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 160.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 108.0, 75.0, 77.0, 75.0, 76.0, 98.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 114.0, 83.0, 82.0, 83.0, 99.0, 83.0, 82.0, 122.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 55.0, 56.0, 57.0, 55.0, 56.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 69.0, 69.0, 67.0, 67.0, 68.0, 67.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 82.0, 84.0, 82.0, 82.0, 83.0, 82.0, 81.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 135.0, 126.0, 137.0, 125.0, 125.0, 133.0, 170.0, 138.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 174.0, 171.0, 167.0, 171.0, 171.0, 170.0, 175.0, 170.0, 172.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 63.0, 71.0, 63.0, 63.0, 64.0, 61.0], "value": 63.7, "unit": "score"}]}]} 22:16:50 INFO - Return code: 0 22:16:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:16:50 ERROR - # TBPL SUCCESS # 22:16:50 INFO - Running post-action listener: _resource_record_post_action 22:16:50 INFO - [mozharness: 2017-02-03 06:16:50.303934Z] Finished run-tests step (success) 22:16:50 INFO - Running post-run listener: _resource_record_post_run 22:16:50 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 12288; Write bytes: 404819968; Read time: 296; Write time: 355088 22:16:50 INFO - TinderboxPrint: CPU usage
13.1% 22:16:50 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 296 22:16:50 INFO - TinderboxPrint: I/O write bytes / time
404,819,968 / 355,088 22:16:50 INFO - TinderboxPrint: CPU idle
8,286.6 (86.9%) 22:16:50 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 22:16:50 INFO - TinderboxPrint: Swap in / out
0 / 0 22:16:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 110379008; Read time: 0; Write time: 127388 22:16:50 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293998592; Read time: 284; Write time: 227604 22:16:50 INFO - Running post-run listener: _upload_blobber_files 22:16:50 INFO - Blob upload gear active. 22:16:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:16:50 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 22:16:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:16:51 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:16:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:52 INFO - (blobuploader) - INFO - Done attempting. 22:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:16:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:53 INFO - (blobuploader) - INFO - Done attempting. 22:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:56 INFO - (blobuploader) - INFO - Done attempting. 22:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:16:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:57 INFO - (blobuploader) - INFO - Done attempting. 22:16:57 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:57 INFO - Return code: 0 22:16:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:16:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45785b1db21136c4aaceff8da6e43e9de9d3d4a04dfa49727f3bedf0b14dcf94d17c65f8fb63e043c68627838713449b086609f6b5d35510603b533a21ff03ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b907abbd7c3537ceb87b716fa4713fd061b6f3505a0c2187e2f1d4306f4896c5b62ac93884e6c98172f03a18f223e47aac487cf32e449444bf4cd6fa523664d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6304579b8fb50a0a583ea3acbff67e58ed19814f22b69b2f0c79e6c3dd279f3b8296ace60e695acfaa6d495d250d6332124092db37066a45af523989bba34528", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f2bca7ac5ec013f0286589fa75cc4712d364a13ad4ec6ba06aa8bff127d03b0204cca29f8e7f4f713c365f290fdec6f0817f653227e1ed9106ec56b5259a3fa"} 22:16:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:16:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:16:57 INFO - Contents: 22:16:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45785b1db21136c4aaceff8da6e43e9de9d3d4a04dfa49727f3bedf0b14dcf94d17c65f8fb63e043c68627838713449b086609f6b5d35510603b533a21ff03ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b907abbd7c3537ceb87b716fa4713fd061b6f3505a0c2187e2f1d4306f4896c5b62ac93884e6c98172f03a18f223e47aac487cf32e449444bf4cd6fa523664d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6304579b8fb50a0a583ea3acbff67e58ed19814f22b69b2f0c79e6c3dd279f3b8296ace60e695acfaa6d495d250d6332124092db37066a45af523989bba34528", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f2bca7ac5ec013f0286589fa75cc4712d364a13ad4ec6ba06aa8bff127d03b0204cca29f8e7f4f713c365f290fdec6f0817f653227e1ed9106ec56b5259a3fa"} 22:16:57 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:57 INFO - Copying logs to upload dir... 22:16:57 INFO - mkdir: /builds/slave/test/build/upload/logs 22:16:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.468608 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-02-02 22:16:57.160537) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 22:16:57.164087) ========= 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=836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45785b1db21136c4aaceff8da6e43e9de9d3d4a04dfa49727f3bedf0b14dcf94d17c65f8fb63e043c68627838713449b086609f6b5d35510603b533a21ff03ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b907abbd7c3537ceb87b716fa4713fd061b6f3505a0c2187e2f1d4306f4896c5b62ac93884e6c98172f03a18f223e47aac487cf32e449444bf4cd6fa523664d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6304579b8fb50a0a583ea3acbff67e58ed19814f22b69b2f0c79e6c3dd279f3b8296ace60e695acfaa6d495d250d6332124092db37066a45af523989bba34528", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f2bca7ac5ec013f0286589fa75cc4712d364a13ad4ec6ba06aa8bff127d03b0204cca29f8e7f4f713c365f290fdec6f0817f653227e1ed9106ec56b5259a3fa"} build_url:https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/bfcZiJQYToiueEisYE4jsQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45785b1db21136c4aaceff8da6e43e9de9d3d4a04dfa49727f3bedf0b14dcf94d17c65f8fb63e043c68627838713449b086609f6b5d35510603b533a21ff03ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b907abbd7c3537ceb87b716fa4713fd061b6f3505a0c2187e2f1d4306f4896c5b62ac93884e6c98172f03a18f223e47aac487cf32e449444bf4cd6fa523664d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6304579b8fb50a0a583ea3acbff67e58ed19814f22b69b2f0c79e6c3dd279f3b8296ace60e695acfaa6d495d250d6332124092db37066a45af523989bba34528", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f2bca7ac5ec013f0286589fa75cc4712d364a13ad4ec6ba06aa8bff127d03b0204cca29f8e7f4f713c365f290fdec6f0817f653227e1ed9106ec56b5259a3fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 22:16:57.189404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 22:16:57.189868) ========= 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=836cfdc75598d54cb747368e000001a9-1486101374.307809-1639246928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 22:16:57.276531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 22:16:57.277146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 22:16:57.277480) ========= ========= Total master_lag: 0.19 =========