builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1485876722.69 results: success (0) revision: b47946b2076f6ac3ffd2cb72367f789237a11ab6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:02.686712) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:02.687134) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:02.687405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:02.703677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:02.703944) ========= 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=5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-31 07:32:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-01-31 07:32:03 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:02.830134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:02.830408) ========= 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=5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015183 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:02.879652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 07:32:02.879982) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b47946b2076f6ac3ffd2cb72367f789237a11ab6 --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 b47946b2076f6ac3ffd2cb72367f789237a11ab6 --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=5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-31 07:32:03,354 truncating revision to first 12 chars 2017-01-31 07:32:03,354 Setting DEBUG logging. 2017-01-31 07:32:03,354 attempt 1/10 2017-01-31 07:32:03,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b47946b2076f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 07:32:04,615 unpacking tar archive at: mozilla-central-b47946b2076f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.563658 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 07:32:04.456187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:04.456502) ========= script_repo_revision: b47946b2076f6ac3ffd2cb72367f789237a11ab6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:04.456906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:04.457174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 07:32:04.466368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-31 07:32:04.466759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:32:05 INFO - MultiFileLogger online at 20170131 07:32:05 in /builds/slave/test 07:32:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:32:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:32:05 INFO - {'append_to_log': False, 07:32:05 INFO - 'base_work_dir': '/builds/slave/test', 07:32:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:32:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:32:05 INFO - 'branch': 'Firefox-Non-PGO', 07:32:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:32:05 INFO - 'config_files': ('talos/linux_config.py',), 07:32:05 INFO - 'default_actions': ('clobber', 07:32:05 INFO - 'read-buildbot-config', 07:32:05 INFO - 'download-and-extract', 07:32:05 INFO - 'populate-webroot', 07:32:05 INFO - 'create-virtualenv', 07:32:05 INFO - 'install', 07:32:05 INFO - 'run-tests'), 07:32:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:32:05 INFO - 'download_minidump_stackwalk': True, 07:32:05 INFO - 'download_symbols': 'ondemand', 07:32:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:32:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:32:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:32:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:32:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:32:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:32:05 INFO - 'installer_path': 'installer.exe', 07:32:05 INFO - 'log_level': 'info', 07:32:05 INFO - 'log_name': 'talos', 07:32:05 INFO - 'log_to_console': True, 07:32:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:32:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:32:05 INFO - 'opt_config_files': (), 07:32:05 INFO - 'pip_index': False, 07:32:05 INFO - 'sps_profile': False, 07:32:05 INFO - 'sps_profile_interval': 0, 07:32:05 INFO - 'suite': 'dromaeojs-e10s', 07:32:05 INFO - 'system_bits': '32', 07:32:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:32:05 INFO - 'title': 'talos-linux64-ix-011', 07:32:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:32:05 INFO - 'use_talos_json': True, 07:32:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:32:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:32:05 INFO - 'work_dir': 'build'} 07:32:05 INFO - [mozharness: 2017-01-31 15:32:05.040037Z] Running clobber step. 07:32:05 INFO - Running pre-action listener: _resource_record_pre_action 07:32:05 INFO - Running main action method: clobber 07:32:05 INFO - rmtree: /builds/slave/test/build 07:32:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:32:06 INFO - Running post-action listener: _resource_record_post_action 07:32:06 INFO - [mozharness: 2017-01-31 15:32:06.031948Z] Finished clobber step (success) 07:32:06 INFO - [mozharness: 2017-01-31 15:32:06.032048Z] Running read-buildbot-config step. 07:32:06 INFO - Running pre-action listener: _resource_record_pre_action 07:32:06 INFO - Running main action method: read_buildbot_config 07:32:06 INFO - Using buildbot properties: 07:32:06 INFO - { 07:32:06 INFO - "project": "", 07:32:06 INFO - "product": "firefox", 07:32:06 INFO - "who": "cbook@mozilla.com", 07:32:06 INFO - "installer_path": "public/build/target.tar.bz2", 07:32:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:32:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:32:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:32:06 INFO - "stage_platform": "linux64", 07:32:06 INFO - "basedir": "/builds/slave/test", 07:32:06 INFO - "buildnumber": 674, 07:32:06 INFO - "platform": "ubuntu64_hw", 07:32:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:32:06 INFO - "slavebuilddir": "test", 07:32:06 INFO - "taskId": "BzBILRqATdCa30wUUt90KA", 07:32:06 INFO - "branch": "mozilla-central", 07:32:06 INFO - "script_repo_revision": "production", 07:32:06 INFO - "revision": "b47946b2076f6ac3ffd2cb72367f789237a11ab6", 07:32:06 INFO - "slavename": "talos-linux64-ix-011", 07:32:06 INFO - "repo_path": "mozilla-central" 07:32:06 INFO - } 07:32:06 INFO - Finding installer, test and symbols from parent task. 07:32:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BzBILRqATdCa30wUUt90KA'}, attempt #1 07:32:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BzBILRqATdCa30wUUt90KA'}, attempt #1 07:32:06 INFO - Task dependencies: OBbgE_NrTWWYQNczn6-_GQ 07:32:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ'}, attempt #1 07:32:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.tar.bz2 07:32:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/test_packages.json 07:32:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.crashreporter-symbols.zip 07:32:07 INFO - Running post-action listener: _resource_record_post_action 07:32:07 INFO - [mozharness: 2017-01-31 15:32:07.464416Z] Finished read-buildbot-config step (success) 07:32:07 INFO - [mozharness: 2017-01-31 15:32:07.464634Z] Running download-and-extract step. 07:32:07 INFO - Running pre-action listener: _resource_record_pre_action 07:32:07 INFO - Running main action method: download_and_extract 07:32:07 INFO - mkdir: /builds/slave/test/build/tests 07:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:07 INFO - trying https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.test_packages.json 07:32:07 INFO - Downloading https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:32:08 INFO - Downloaded 896 bytes. 07:32:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:32:08 INFO - Using the following test package requirements: 07:32:08 INFO - {u'common': [u'target.common.tests.zip'], 07:32:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:32:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:32:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:32:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:32:08 INFO - u'mozbase': [u'target.common.tests.zip'], 07:32:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:32:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:32:08 INFO - u'web-platform': [u'target.common.tests.zip', 07:32:08 INFO - u'target.web-platform.tests.zip'], 07:32:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:32:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:32:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.common.tests.zip 07:32:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:32:08 INFO - Fetch https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.common.tests.zip into memory 07:32:08 INFO - Expected file size: 20360631 07:32:08 INFO - Obtained file size: 20360631 07:32:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:32:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.common.tests.zip 07:32:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:32:13 INFO - Fetch https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.common.tests.zip into memory 07:32:13 INFO - Expected file size: 20360631 07:32:13 INFO - Obtained file size: 20360631 07:32:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.talos.tests.zip 07:32:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:32:18 INFO - Fetch https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.talos.tests.zip into memory 07:32:19 INFO - Expected file size: 14403454 07:32:19 INFO - Obtained file size: 14403454 07:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:19 INFO - trying https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.tar.bz2 07:32:19 INFO - Downloading https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:32:20 INFO - Downloaded 56093169 bytes. 07:32:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.tar.bz2 07:32:20 INFO - mkdir: /builds/slave/test/properties 07:32:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:20 INFO - Contents: 07:32:20 INFO - build_url:https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.tar.bz2 07:32:20 INFO - Running post-action listener: _resource_record_post_action 07:32:20 INFO - Running post-action listener: set_extra_try_arguments 07:32:20 INFO - [mozharness: 2017-01-31 15:32:20.527991Z] Finished download-and-extract step (success) 07:32:20 INFO - [mozharness: 2017-01-31 15:32:20.528089Z] Running populate-webroot step. 07:32:20 INFO - Running pre-action listener: _resource_record_pre_action 07:32:20 INFO - Running main action method: populate_webroot 07:32:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:20 INFO - '--tppagecycles', 07:32:20 INFO - '7'], 07:32:20 INFO - 'tests': ['tsvgm']}}, 07:32:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:32:20 INFO - 'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:32:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:32:20 INFO - 'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['damp', 'tps']}, 07:32:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:32:20 INFO - 'tests': ['damp', 'tps']}, 07:32:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['dromaeo_dom']}, 07:32:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['basic_compositor_video']}, 07:32:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:32:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['a11yr', 07:32:20 INFO - 'ts_paint', 07:32:20 INFO - 'tpaint', 07:32:20 INFO - 'sessionrestore', 07:32:20 INFO - 'sessionrestore_no_auto_restore', 07:32:20 INFO - 'tabpaint']}, 07:32:20 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:20 INFO - 'ts_paint', 07:32:20 INFO - 'tpaint', 07:32:20 INFO - 'sessionrestore', 07:32:20 INFO - 'sessionrestore_no_auto_restore', 07:32:20 INFO - 'tabpaint']}, 07:32:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:20 INFO - 'ts_paint', 07:32:20 INFO - 'tpaint', 07:32:20 INFO - 'sessionrestore', 07:32:20 INFO - 'sessionrestore_no_auto_restore', 07:32:20 INFO - 'tabpaint']}, 07:32:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:20 INFO - 'ts_paint', 07:32:20 INFO - 'tpaint', 07:32:20 INFO - 'sessionrestore', 07:32:20 INFO - 'sessionrestore_no_auto_restore', 07:32:20 INFO - 'tabpaint']}, 07:32:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['a11yr', 07:32:20 INFO - 'ts_paint', 07:32:20 INFO - 'tpaint', 07:32:20 INFO - 'sessionrestore', 07:32:20 INFO - 'sessionrestore_no_auto_restore', 07:32:20 INFO - 'tabpaint']}, 07:32:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['a11yr', 07:32:20 INFO - 'ts_paint', 07:32:20 INFO - 'tpaint', 07:32:20 INFO - 'sessionrestore', 07:32:20 INFO - 'sessionrestore_no_auto_restore', 07:32:20 INFO - 'tabpaint']}, 07:32:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['tsvgx', 07:32:20 INFO - 'tsvgr_opacity', 07:32:20 INFO - 'tart', 07:32:20 INFO - 'tscrollx', 07:32:20 INFO - 'cart', 07:32:20 INFO - 'tsvg_static']}, 07:32:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:20 INFO - 'tsvgr_opacity', 07:32:20 INFO - 'tart', 07:32:20 INFO - 'tscrollx', 07:32:20 INFO - 'cart', 07:32:20 INFO - 'tsvg_static']}, 07:32:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:32:20 INFO - 'talos_options': ['--disable-e10s'], 07:32:20 INFO - 'tests': ['tp5o']}, 07:32:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:32:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:32:20 INFO - 'talos_options': ['--disable-e10s', 07:32:20 INFO - '--xperf_path', 07:32:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:20 INFO - 'tests': ['tp5n']}, 07:32:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:32:20 INFO - 'talos_options': ['--xperf_path', 07:32:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:20 INFO - 'tests': ['tp5n']}}, 07:32:20 INFO - 'talos.zip': {'path': '', 07:32:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:20 INFO - Running post-action listener: _resource_record_post_action 07:32:20 INFO - [mozharness: 2017-01-31 15:32:20.541324Z] Finished populate-webroot step (success) 07:32:20 INFO - [mozharness: 2017-01-31 15:32:20.541415Z] Running create-virtualenv step. 07:32:20 INFO - Running pre-action listener: _resource_record_pre_action 07:32:20 INFO - Running main action method: create_virtualenv 07:32:20 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:20 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 07:32:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:20 INFO - Using real prefix '/usr' 07:32:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:21 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:23 INFO - Installing pip.................done. 07:32:23 INFO - Return code: 0 07:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:32:23 INFO - Reading from file tmpfile_stdout 07:32:23 INFO - Output received: 07:32:23 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) 07:32:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:23 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 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32:23 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 07:32:23 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 07:32:23 INFO - Using env: {'DISPLAY': ':0', 07:32:23 INFO - 'HOME': '/home/cltbld', 07:32:23 INFO - 'LANG': 'en_US.UTF-8', 07:32:23 INFO - 'LANGUAGE': 'en_US:en', 07:32:23 INFO - 'LOGNAME': 'cltbld', 07:32:23 INFO - 'MAIL': '/var/mail/cltbld', 07:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:23 INFO - 'MOZ_NO_REMOTE': '1', 07:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:23 INFO - 'NO_EM_RESTART': '1', 07:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:23 INFO - 'PWD': '/builds/slave/test', 07:32:23 INFO - 'SHELL': '/bin/bash', 07:32:23 INFO - 'SHLVL': '1', 07:32:23 INFO - 'TERM': 'linux', 07:32:23 INFO - 'TMOUT': '86400', 07:32:23 INFO - 'USER': 'cltbld', 07:32:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:23 INFO - '_': '/tools/buildbot/bin/python'} 07:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:23 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 07:32:23 INFO - Cleaning up... 07:32:23 INFO - Return code: 0 07:32:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:23 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 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32:23 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 07:32:23 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 07:32:23 INFO - Using env: {'DISPLAY': ':0', 07:32:23 INFO - 'HOME': '/home/cltbld', 07:32:23 INFO - 'LANG': 'en_US.UTF-8', 07:32:23 INFO - 'LANGUAGE': 'en_US:en', 07:32:23 INFO - 'LOGNAME': 'cltbld', 07:32:23 INFO - 'MAIL': '/var/mail/cltbld', 07:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:23 INFO - 'MOZ_NO_REMOTE': '1', 07:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:23 INFO - 'NO_EM_RESTART': '1', 07:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:23 INFO - 'PWD': '/builds/slave/test', 07:32:23 INFO - 'SHELL': '/bin/bash', 07:32:23 INFO - 'SHLVL': '1', 07:32:23 INFO - 'TERM': 'linux', 07:32:23 INFO - 'TMOUT': '86400', 07:32:23 INFO - 'USER': 'cltbld', 07:32:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:23 INFO - '_': '/tools/buildbot/bin/python'} 07:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:23 INFO - Downloading/unpacking psutil>=3.1.1 07:32:23 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 07:32:23 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 07:32:23 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 07:32:23 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 07:32:23 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 07:32:23 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 07:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:25 INFO - Installing collected packages: psutil 07:32:25 INFO - Running setup.py install for psutil 07:32:25 INFO - building 'psutil._psutil_linux' extension 07:32:25 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 07:32:26 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 07:32:26 INFO - building 'psutil._psutil_posix' extension 07:32:26 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 07:32:26 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 07:32:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:26 INFO - Successfully installed psutil 07:32:26 INFO - Cleaning up... 07:32:26 INFO - Return code: 0 07:32:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:32:26 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')]} 07:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:26 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')]} 07:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:26 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 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32:26 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 07:32:26 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 07:32:26 INFO - Using env: {'DISPLAY': ':0', 07:32:26 INFO - 'HOME': '/home/cltbld', 07:32:26 INFO - 'LANG': 'en_US.UTF-8', 07:32:26 INFO - 'LANGUAGE': 'en_US:en', 07:32:26 INFO - 'LOGNAME': 'cltbld', 07:32:26 INFO - 'MAIL': '/var/mail/cltbld', 07:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:26 INFO - 'MOZ_NO_REMOTE': '1', 07:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:26 INFO - 'NO_EM_RESTART': '1', 07:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:26 INFO - 'PWD': '/builds/slave/test', 07:32:26 INFO - 'SHELL': '/bin/bash', 07:32:26 INFO - 'SHLVL': '1', 07:32:26 INFO - 'TERM': 'linux', 07:32:26 INFO - 'TMOUT': '86400', 07:32:26 INFO - 'USER': 'cltbld', 07:32:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:26 INFO - '_': '/tools/buildbot/bin/python'} 07:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:32:26 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 07:32:26 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 07:32:26 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 07:32:26 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 07:32:26 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 07:32:26 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 07:32:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:32:28 INFO - Installing collected packages: mozsystemmonitor 07:32:28 INFO - Running setup.py install for mozsystemmonitor 07:32:28 INFO - Successfully installed mozsystemmonitor 07:32:28 INFO - Cleaning up... 07:32:28 INFO - Return code: 0 07:32:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:32:28 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')]} 07:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:28 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')]} 07:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:28 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 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32:28 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 07:32:28 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 07:32:28 INFO - Using env: {'DISPLAY': ':0', 07:32:28 INFO - 'HOME': '/home/cltbld', 07:32:28 INFO - 'LANG': 'en_US.UTF-8', 07:32:28 INFO - 'LANGUAGE': 'en_US:en', 07:32:28 INFO - 'LOGNAME': 'cltbld', 07:32:28 INFO - 'MAIL': '/var/mail/cltbld', 07:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:28 INFO - 'MOZ_NO_REMOTE': '1', 07:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:28 INFO - 'NO_EM_RESTART': '1', 07:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:28 INFO - 'PWD': '/builds/slave/test', 07:32:28 INFO - 'SHELL': '/bin/bash', 07:32:28 INFO - 'SHLVL': '1', 07:32:28 INFO - 'TERM': 'linux', 07:32:28 INFO - 'TMOUT': '86400', 07:32:28 INFO - 'USER': 'cltbld', 07:32:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:28 INFO - '_': '/tools/buildbot/bin/python'} 07:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:29 INFO - Downloading/unpacking jsonschema==2.5.1 07:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:32:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:32:31 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 07:32:31 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 07:32:31 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 07:32:31 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 07:32:31 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 07:32:31 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 07:32:31 INFO - Downloading functools32-3.2.3-2.tar.gz 07:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:32:31 INFO - warning: no files found matching '*.txt' 07:32:31 INFO - no previously-included directories found matching 'build' 07:32:31 INFO - no previously-included directories found matching 'dist' 07:32:31 INFO - no previously-included directories found matching '.git*' 07:32:31 INFO - Installing collected packages: jsonschema, functools32 07:32:31 INFO - Running setup.py install for functools32 07:32:31 INFO - warning: no files found matching '*.txt' 07:32:31 INFO - no previously-included directories found matching 'build' 07:32:31 INFO - no previously-included directories found matching 'dist' 07:32:31 INFO - no previously-included directories found matching '.git*' 07:32:31 INFO - Successfully installed jsonschema functools32 07:32:31 INFO - Cleaning up... 07:32:31 INFO - Return code: 0 07:32:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:31 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 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32:31 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 07:32:31 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 07:32:31 INFO - Using env: {'DISPLAY': ':0', 07:32:31 INFO - 'HOME': '/home/cltbld', 07:32:31 INFO - 'LANG': 'en_US.UTF-8', 07:32:31 INFO - 'LANGUAGE': 'en_US:en', 07:32:31 INFO - 'LOGNAME': 'cltbld', 07:32:31 INFO - 'MAIL': '/var/mail/cltbld', 07:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:31 INFO - 'MOZ_NO_REMOTE': '1', 07:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:31 INFO - 'NO_EM_RESTART': '1', 07:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:31 INFO - 'PWD': '/builds/slave/test', 07:32:31 INFO - 'SHELL': '/bin/bash', 07:32:31 INFO - 'SHLVL': '1', 07:32:31 INFO - 'TERM': 'linux', 07:32:31 INFO - 'TMOUT': '86400', 07:32:31 INFO - 'USER': 'cltbld', 07:32:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:31 INFO - '_': '/tools/buildbot/bin/python'} 07:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:32:31 INFO - Cleaning up... 07:32:31 INFO - Return code: 0 07:32:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:31 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 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32:31 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 07:32:31 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 07:32:31 INFO - Using env: {'DISPLAY': ':0', 07:32:31 INFO - 'HOME': '/home/cltbld', 07:32:31 INFO - 'LANG': 'en_US.UTF-8', 07:32:31 INFO - 'LANGUAGE': 'en_US:en', 07:32:31 INFO - 'LOGNAME': 'cltbld', 07:32:31 INFO - 'MAIL': '/var/mail/cltbld', 07:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:31 INFO - 'MOZ_NO_REMOTE': '1', 07:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:31 INFO - 'NO_EM_RESTART': '1', 07:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:31 INFO - 'PWD': '/builds/slave/test', 07:32:31 INFO - 'SHELL': '/bin/bash', 07:32:31 INFO - 'SHLVL': '1', 07:32:31 INFO - 'TERM': 'linux', 07:32:31 INFO - 'TMOUT': '86400', 07:32:31 INFO - 'USER': 'cltbld', 07:32:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:31 INFO - '_': '/tools/buildbot/bin/python'} 07:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:32:32 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 07:32:32 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 07:32:32 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 07:32:32 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 07:32:32 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 07:32:32 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 07:32:33 INFO - Downloading blobuploader-1.2.4.tar.gz 07:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:32:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:32:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:34 INFO - Downloading docopt-0.6.1.tar.gz 07:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:32:34 INFO - Installing collected packages: blobuploader, requests, docopt 07:32:34 INFO - Running setup.py install for blobuploader 07:32:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:32:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:32:34 INFO - Running setup.py install for requests 07:32:35 INFO - Running setup.py install for docopt 07:32:35 INFO - Successfully installed blobuploader requests docopt 07:32:35 INFO - Cleaning up... 07:32:35 INFO - Return code: 0 07:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:35 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 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32:35 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 07:32:35 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 07:32:35 INFO - Using env: {'DISPLAY': ':0', 07:32:35 INFO - 'HOME': '/home/cltbld', 07:32:35 INFO - 'LANG': 'en_US.UTF-8', 07:32:35 INFO - 'LANGUAGE': 'en_US:en', 07:32:35 INFO - 'LOGNAME': 'cltbld', 07:32:35 INFO - 'MAIL': '/var/mail/cltbld', 07:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:35 INFO - 'MOZ_NO_REMOTE': '1', 07:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:35 INFO - 'NO_EM_RESTART': '1', 07:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:35 INFO - 'PWD': '/builds/slave/test', 07:32:35 INFO - 'SHELL': '/bin/bash', 07:32:35 INFO - 'SHLVL': '1', 07:32:35 INFO - 'TERM': 'linux', 07:32:35 INFO - 'TMOUT': '86400', 07:32:35 INFO - 'USER': 'cltbld', 07:32:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:35 INFO - '_': '/tools/buildbot/bin/python'} 07:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:35 INFO - Running setup.py (path:/tmp/pip-vDKbCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:35 INFO - Running setup.py (path:/tmp/pip-cmbdgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:35 INFO - Running setup.py (path:/tmp/pip-Oil9Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:35 INFO - Running setup.py (path:/tmp/pip-mVh5Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:35 INFO - Running setup.py (path:/tmp/pip-g1OZwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:35 INFO - Running setup.py (path:/tmp/pip-BA8E8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:36 INFO - Running setup.py (path:/tmp/pip-LG7TkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:36 INFO - Running setup.py (path:/tmp/pip-Zdsjsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:36 INFO - Running setup.py (path:/tmp/pip-UTtON7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:36 INFO - Running setup.py (path:/tmp/pip-J7UFWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:36 INFO - Running setup.py (path:/tmp/pip-3GWf60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:36 INFO - Running setup.py (path:/tmp/pip-lMVSWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:36 INFO - Running setup.py (path:/tmp/pip-s7e5r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:36 INFO - Running setup.py (path:/tmp/pip-mMKw5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:36 INFO - Running setup.py (path:/tmp/pip-sTMyTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:36 INFO - Running setup.py (path:/tmp/pip-u2u1KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:36 INFO - Running setup.py (path:/tmp/pip-fyl3cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:32:36 INFO - Running setup.py install for manifestparser 07:32:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:32:36 INFO - Running setup.py install for mozcrash 07:32:37 INFO - Running setup.py install for mozdebug 07:32:37 INFO - Running setup.py install for mozdevice 07:32:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:32:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:32:37 INFO - Running setup.py install for mozfile 07:32:37 INFO - Running setup.py install for mozhttpd 07:32:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:32:37 INFO - Running setup.py install for mozinfo 07:32:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:32:37 INFO - Running setup.py install for mozInstall 07:32:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:32:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:32:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:32:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:32:37 INFO - Running setup.py install for mozleak 07:32:37 INFO - Running setup.py install for mozlog 07:32:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:32:37 INFO - Running setup.py install for moznetwork 07:32:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:32:38 INFO - Running setup.py install for mozprocess 07:32:38 INFO - Running setup.py install for mozprofile 07:32:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:32:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:32:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:32:38 INFO - Running setup.py install for mozrunner 07:32:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:32:38 INFO - Running setup.py install for mozscreenshot 07:32:38 INFO - Running setup.py install for moztest 07:32:38 INFO - Running setup.py install for mozversion 07:32:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:32:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:32:38 INFO - Cleaning up... 07:32:38 INFO - Return code: 0 07:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:32:38 INFO - Using env: {'DISPLAY': ':0', 07:32:38 INFO - 'HOME': '/home/cltbld', 07:32:38 INFO - 'LANG': 'en_US.UTF-8', 07:32:38 INFO - 'LANGUAGE': 'en_US:en', 07:32:38 INFO - 'LOGNAME': 'cltbld', 07:32:38 INFO - 'MAIL': '/var/mail/cltbld', 07:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:38 INFO - 'MOZ_NO_REMOTE': '1', 07:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:38 INFO - 'NO_EM_RESTART': '1', 07:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:38 INFO - 'PWD': '/builds/slave/test', 07:32:38 INFO - 'SHELL': '/bin/bash', 07:32:38 INFO - 'SHLVL': '1', 07:32:38 INFO - 'TERM': 'linux', 07:32:38 INFO - 'TMOUT': '86400', 07:32:38 INFO - 'USER': 'cltbld', 07:32:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:38 INFO - '_': '/tools/buildbot/bin/python'} 07:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:38 INFO - Running setup.py (path:/tmp/pip-7gXZl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:38 INFO - Running setup.py (path:/tmp/pip-4jLB74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:39 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)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:39 INFO - Running setup.py (path:/tmp/pip-PSGZmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:39 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)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:39 INFO - Running setup.py (path:/tmp/pip-qLaDq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:39 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)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:39 INFO - Running setup.py (path:/tmp/pip-p8Cg4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:39 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)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:39 INFO - Running setup.py (path:/tmp/pip-3dMAj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:39 INFO - Running setup.py (path:/tmp/pip-69PpS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:39 INFO - Running setup.py (path:/tmp/pip-onxw9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:39 INFO - Running setup.py (path:/tmp/pip-DADgRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:39 INFO - Running setup.py (path:/tmp/pip-CNrzpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:39 INFO - Running setup.py (path:/tmp/pip-M3w2Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:39 INFO - Running setup.py (path:/tmp/pip-dMF434-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:39 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)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:39 INFO - Running setup.py (path:/tmp/pip-nbdKJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:39 INFO - Running setup.py (path:/tmp/pip-2aj_sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:39 INFO - Running setup.py (path:/tmp/pip-bZ8vud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:39 INFO - Running setup.py (path:/tmp/pip-QJSleh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:40 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)) 07:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:40 INFO - Running setup.py (path:/tmp/pip-R_gK0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:40 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)) 07:32:40 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)) 07:32:40 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)) 07:32:40 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)) 07:32:40 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)) 07:32:40 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)) 07:32:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:40 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 07:32:40 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 07:32:40 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 07:32:40 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 07:32:40 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 07:32:40 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 07:32:42 INFO - Downloading blessings-1.6.tar.gz 07:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:32:42 INFO - Installing collected packages: blessings 07:32:42 INFO - Running setup.py install for blessings 07:32:42 INFO - Successfully installed blessings 07:32:42 INFO - Cleaning up... 07:32:42 INFO - Return code: 0 07:32:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:42 INFO - Reading from file tmpfile_stdout 07:32:42 INFO - Current package versions: 07:32:42 INFO - argparse == 1.2.1 07:32:42 INFO - blessings == 1.6 07:32:42 INFO - blobuploader == 1.2.4 07:32:42 INFO - docopt == 0.6.1 07:32:42 INFO - functools32 == 3.2.3-2 07:32:42 INFO - jsonschema == 2.5.1 07:32:42 INFO - manifestparser == 1.1 07:32:42 INFO - mozInstall == 1.12 07:32:42 INFO - mozcrash == 1.0 07:32:42 INFO - mozdebug == 0.1 07:32:42 INFO - mozdevice == 0.49 07:32:42 INFO - mozfile == 1.2 07:32:42 INFO - mozhttpd == 0.7 07:32:42 INFO - mozinfo == 0.9 07:32:42 INFO - mozleak == 0.1 07:32:42 INFO - mozlog == 3.4 07:32:42 INFO - moznetwork == 0.27 07:32:42 INFO - mozprocess == 0.24 07:32:42 INFO - mozprofile == 0.28 07:32:42 INFO - mozrunner == 6.13 07:32:42 INFO - mozscreenshot == 0.1 07:32:42 INFO - mozsystemmonitor == 0.3 07:32:42 INFO - moztest == 0.8 07:32:42 INFO - mozversion == 1.4 07:32:42 INFO - psutil == 3.1.1 07:32:42 INFO - requests == 1.2.3 07:32:42 INFO - wsgiref == 0.1.2 07:32:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:42 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 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32:42 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 07:32:42 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 07:32:42 INFO - Using env: {'DISPLAY': ':0', 07:32:42 INFO - 'HOME': '/home/cltbld', 07:32:42 INFO - 'LANG': 'en_US.UTF-8', 07:32:42 INFO - 'LANGUAGE': 'en_US:en', 07:32:42 INFO - 'LOGNAME': 'cltbld', 07:32:42 INFO - 'MAIL': '/var/mail/cltbld', 07:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:42 INFO - 'MOZ_NO_REMOTE': '1', 07:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:42 INFO - 'NO_EM_RESTART': '1', 07:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:42 INFO - 'PWD': '/builds/slave/test', 07:32:42 INFO - 'SHELL': '/bin/bash', 07:32:42 INFO - 'SHLVL': '1', 07:32:42 INFO - 'TERM': 'linux', 07:32:42 INFO - 'TMOUT': '86400', 07:32:42 INFO - 'USER': 'cltbld', 07:32:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:42 INFO - '_': '/tools/buildbot/bin/python'} 07:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:43 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)) 07:32:43 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)) 07:32:43 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)) 07:32:43 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)) 07:32:43 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)) 07:32:43 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)) 07:32:43 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)) 07:32:43 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)) 07:32:43 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)) 07:32:43 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)) 07:32:43 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)) 07:32:43 INFO - Cleaning up... 07:32:43 INFO - Return code: 0 07:32:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, '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': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', '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 07:32: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', 'jsonschema'] in /builds/slave/test/build 07:32: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 jsonschema 07:32:43 INFO - Using env: {'DISPLAY': ':0', 07:32:43 INFO - 'HOME': '/home/cltbld', 07:32:43 INFO - 'LANG': 'en_US.UTF-8', 07:32:43 INFO - 'LANGUAGE': 'en_US:en', 07:32:43 INFO - 'LOGNAME': 'cltbld', 07:32:43 INFO - 'MAIL': '/var/mail/cltbld', 07:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:43 INFO - 'MOZ_NO_REMOTE': '1', 07:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:43 INFO - 'NO_EM_RESTART': '1', 07:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:43 INFO - 'PWD': '/builds/slave/test', 07:32:43 INFO - 'SHELL': '/bin/bash', 07:32:43 INFO - 'SHLVL': '1', 07:32:43 INFO - 'TERM': 'linux', 07:32:43 INFO - 'TMOUT': '86400', 07:32:43 INFO - 'USER': 'cltbld', 07:32:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:43 INFO - '_': '/tools/buildbot/bin/python'} 07:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:32:43 INFO - Cleaning up... 07:32:43 INFO - Return code: 0 07:32:43 INFO - Running post-action listener: _resource_record_post_action 07:32:43 INFO - Running post-action listener: _start_resource_monitoring 07:32:43 INFO - Starting resource monitoring. 07:32:43 INFO - [mozharness: 2017-01-31 15:32:43.325971Z] Finished create-virtualenv step (success) 07:32:43 INFO - [mozharness: 2017-01-31 15:32:43.326488Z] Running install step. 07:32:43 INFO - Running pre-action listener: _resource_record_pre_action 07:32:43 INFO - Running main action method: install 07:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:43 INFO - Reading from file tmpfile_stdout 07:32:43 INFO - Detecting whether we're running mozinstall >=1.0... 07:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:32:43 INFO - Reading from file tmpfile_stdout 07:32:43 INFO - Output received: 07:32:43 INFO - Usage: mozinstall [options] installer 07:32:43 INFO - Options: 07:32:43 INFO - -h, --help show this help message and exit 07:32:43 INFO - -d DEST, --destination=DEST 07:32:43 INFO - Directory to install application into. [default: 07:32:43 INFO - "/builds/slave/test"] 07:32:43 INFO - --app=APP Application being installed. [default: firefox] 07:32:43 INFO - mkdir: /builds/slave/test/build/application 07:32:43 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'] 07:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:32:59 INFO - Reading from file tmpfile_stdout 07:32:59 INFO - Output received: 07:32:59 INFO - /builds/slave/test/build/application/firefox/firefox 07:32:59 INFO - Running post-action listener: _resource_record_post_action 07:32:59 INFO - [mozharness: 2017-01-31 15:32:59.809988Z] Finished install step (success) 07:32:59 INFO - [mozharness: 2017-01-31 15:32:59.810264Z] Running run-tests step. 07:32:59 INFO - Running pre-action listener: _resource_record_pre_action 07:32:59 INFO - Running main action method: run_tests 07:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:32:59 INFO - Python 2.7.3 07:32:59 INFO - Return code: 0 07:32:59 INFO - grabbing minidump binary from tooltool 07:32:59 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')]} 07:32:59 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 0x119d820>, '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 0x119e520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119e9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:32:59 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 07:32:59 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 07:32:59 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 07:32:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:32:59 INFO - Return code: 0 07:32:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:32:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:32:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:32:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:32:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:32:59 INFO - Using env: {'DISPLAY': ':0', 07:32:59 INFO - 'HOME': '/home/cltbld', 07:32:59 INFO - 'LANG': 'en_US.UTF-8', 07:32:59 INFO - 'LANGUAGE': 'en_US:en', 07:32:59 INFO - 'LOGNAME': 'cltbld', 07:32:59 INFO - 'MAIL': '/var/mail/cltbld', 07:32:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:32:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:59 INFO - 'MOZ_NO_REMOTE': '1', 07:32:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:59 INFO - 'NO_EM_RESTART': '1', 07:32:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:59 INFO - 'PWD': '/builds/slave/test', 07:32:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:32:59 INFO - 'SHELL': '/bin/bash', 07:32:59 INFO - 'SHLVL': '1', 07:32:59 INFO - 'TERM': 'linux', 07:32:59 INFO - 'TMOUT': '86400', 07:32:59 INFO - 'USER': 'cltbld', 07:32:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784', 07:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:59 INFO - '_': '/tools/buildbot/bin/python'} 07:32:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:33:00 INFO - mozversion application_buildid: 20170131145446 07:33:00 INFO - mozversion application_changeset: b47946b2076f6ac3ffd2cb72367f789237a11ab6 07:33:00 INFO - mozversion application_display_name: Nightly 07:33:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:00 INFO - mozversion application_name: Firefox 07:33:00 INFO - mozversion application_remotingname: firefox 07:33:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:33:00 INFO - mozversion application_vendor: Mozilla 07:33:00 INFO - mozversion application_version: 54.0a1 07:33:00 INFO - mozversion platform_buildid: 20170131145446 07:33:00 INFO - mozversion platform_changeset: b47946b2076f6ac3ffd2cb72367f789237a11ab6 07:33:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:33:00 INFO - mozversion platform_version: 54.0a1 07:33:00 INFO - using testdate: 1485876780 07:33:00 INFO - actual date: 1485876780 07:33:00 INFO - starting webserver on 'localhost:43377' 07:33:00 INFO - SUITE-START | Running 2 tests 07:33:00 INFO - TEST-START | dromaeo_css 07:33:00 INFO - operating with platform_type : linux_ 07:33:00 INFO - Initialising browser for dromaeo_css test... 07:33:00 INFO - TEST-INFO | started process 7745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaGkwgx/profile http://localhost:43377/getInfo.html) 07:33:04 INFO - PROCESS | 7745 | 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] 07:33:04 INFO - PROCESS | 7745 | __metrics Screen width/height:1600/1200 07:33:04 INFO - PROCESS | 7745 | colorDepth:24 07:33:04 INFO - PROCESS | 7745 | Browser inner width/height: 1024/697 07:33:04 INFO - PROCESS | 7745 | __metrics 07:33:05 INFO - PROCESS | 7745 | 1485876785331 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6274:36 < canClose@browser.js:5140:12 < forceQuit@jar:file:///tmp/tmpaGkwgx/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpaGkwgx/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpaGkwgx/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpaGkwgx/profile/extensions/talos-powers@TalosPowersService.js:55:9 07:33:05 ERROR - PROCESS | 7745 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3284: TypeError: this.tabs is undefined 07:33:06 INFO - TEST-INFO | 7745: exit 0 07:33:06 INFO - Browser initialized. 07:33:06 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:06 INFO - TEST-INFO | started process 7866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaGkwgx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:18 INFO - PROCESS | 7866 | RSS: Main: 159322112 07:33:18 INFO - PROCESS | 7866 | 07:36:22 INFO - PROCESS | 7866 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43377/tests/dromaeo/cssquery-ext.html) 07:36:24 INFO - PROCESS | 7866 | RSS: Main: 169775104 07:36:24 INFO - PROCESS | 7866 | 07:38:06 INFO - PROCESS | 7866 | ************************* 07:38:06 INFO - PROCESS | 7866 | A coding exception was thrown and uncaught in a Task. 07:38:06 INFO - PROCESS | 7866 | 07:38:06 ERROR - PROCESS | 7866 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:38:06 INFO - PROCESS | 7866 | Full stack: 07:38:06 INFO - PROCESS | 7866 | ************************* 07:39:26 INFO - PROCESS | 7866 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-ext.html (next: http://localhost:43377/tests/dromaeo/cssquery-jquery.html) 07:39:27 INFO - PROCESS | 7866 | RSS: Main: 164306944 07:39:27 INFO - PROCESS | 7866 | 07:42:29 INFO - PROCESS | 7866 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43377/tests/dromaeo/cssquery-mootools.html) 07:42:29 INFO - PROCESS | 7866 | RSS: Main: 171646976 07:42:29 INFO - PROCESS | 7866 | 07:45:31 INFO - PROCESS | 7866 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43377/tests/dromaeo/cssquery-prototype.html) 07:45:32 INFO - PROCESS | 7866 | RSS: Main: 164777984 07:45:32 INFO - PROCESS | 7866 | 07:48:35 INFO - PROCESS | 7866 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43377/tests/dromaeo/cssquery-yui.html) 07:48:36 INFO - PROCESS | 7866 | RSS: Main: 168493056 07:48:36 INFO - PROCESS | 7866 | 07:51:38 INFO - PROCESS | 7866 | Cycle 1(1): loaded http://localhost:43377/tests/dromaeo/cssquery-yui.html (next: http://localhost:43377/tests/dromaeo/cssquery-dojo.html) 07:51:38 INFO - PROCESS | 7866 | RSS: Main: 168292352 07:51:38 INFO - PROCESS | 7866 | 07:51:38 INFO - PROCESS | 7866 | __start_tp_report 07:51:38 INFO - PROCESS | 7866 | _x_x_mozilla_page_load 07:51:38 INFO - PROCESS | 7866 | _x_x_mozilla_page_load_details 07:51:38 INFO - PROCESS | 7866 | |i|pagename|runs| 07:51:38 INFO - PROCESS | 7866 | |0;dojo.html;2602.648642433271;2603.375189954411;2616.005917751255;2625.8161928665;2644.5372059889514;4722.527747225285;4837.274408838676;4856.150173719599;4861.197902346117;4879.926801097987;4766.189747742884;4800.879978000552;4833.178359678855;4871.244957031657;4879.3656824612835;4356.3465480178065;4470.396496472983;4478.283474644058;4534.6372290216705;4545.227311357061;4486.214912390335;4525.366448697185;4529.841455549056;4534.478534968488;4546.522615125414;4325.286327755916;4364.301711726141;4377.6935614507;4489.46126464823;4508.954910450886;4415.845445409427;4426.667999900021;4455.1535208310315;4475.7985890635;4485.035717320791;4380.7152535085115;4415.116976604692;4416.447944006999;4419.491758447755;4424.314231294123;4709.152352576535;4737;4780.139574876521;4800.855974320741;4842.515748425165;5070.873228169288;5093.821716239914;5102.464241254652;5118.385793704742;5169.069567477853;5113.360829896263;5113.795448182068;5115.437301896788;5118.6416950813455;5131.743412829381;4810.326554282403;4824.589909857701;4826.613870890355;4865.56209941107;4874.683145595596;5136.897262054813;5166.121759300928;5169.534741873174;5186.5850731941355;5239.030779305841;4964.255361695775;5023.8492845214705;5025.924611130836;5026.170681837529;5027.346444962204;5078.7460626968505;5088.465711100355;5090.949090509122;5095.133827249377;5114.258432527263;5081.923771143436;5100.1074811907765;5101.795928162906;5122.308488354024;5124.615653825978;5140.588752899759;5141.562967147759;5153.665011774297;5159.329287192641;5178.378594568676;3972.781497017692;4004.479417675742;4010.318245898204;4031.475908131924;4058.188362327546;3541.805200713934;3545.663161999606;3556.519869817593;3576.159602493412;3584.0860580551794;4399.406080179135;4411.073674528385;4412.117576484652;4430.977845110819;4454.131444368382;5077.923831142536;5136.383633963948;5140.1004824155625;5147.948520514822;5163.044836705147;4441.467023957146;4443.755593442392;4447.977760111179;4456.398386217819;4462.286034234572;4680.15757163707;4720.504347043579;4727.149113159596;4746.952530474651;4757.072370887713;4824.228123500223;4848.95151048485;4857.975710121426;4867.537583929521;4895.339129217653;5047.772850221675;5070.721110338966;5213.504717051874;5220.269162317202;5264.236685680631;4756.667033307635;4797.856064318076;4808.879778005438;4818.277258411266;4864.294677271847;4936.062148191832;5000.4749501303295;5045.899082018413;5109.5912327013;5110.080185566485;5179.45615710345;5223.4776522347465;5235.790568377222;5256.9737151314;5258;5051.797928082836;5053.267276244997;5055.418626857959;5064.316317297118;5105.387353517602;4906.190478571139;4940.407151141886;4951.603871690329;4991.9500804991485;5015.874603134805;4795.784189711541;4969.950300496948;4970.229614409773;4973.850784476472;4974.104661161025;5041.117804384291;5053.393592768891;5056.949430505648;5072.619553533574;5085;4815.783289752039;4833.323334733211;4877.414710234652;4915.557599816034;4989.201727723546 07:51:38 INFO - PROCESS | 7866 | |1;ext.html;513.1199992013696;524.8582882621693;533.3679589686224;542.9737795566383;568.2640979930989;38782.61217387825;41185.3822192667;41273;44355.33466997997;44492.77753611228;41407.79296103515;41513.16973660525;41722.37416438748;41825.7908710456;41845.58154418455;7721.9227807722045;7855.332296754783;7891.644875980566;9677;9998.750031249205;9860.802783944317;9946.35348702332;9956.103950644441;9962.701118966443;9976;9944.5524951377;9980.850287245661;9989.850152247722;9990.400575965428;10003.149732272766;9875.160611348045;9909.702708918743;9946.20430365569;9954.352967057119;9960.80078398428;9854.50727463624;9870.259730520167;9871.309008369417;9905.20758339331;9917.454540000297;35711.10722231965;35799.284014319564;35800.462993055124;36102.097447563756;36182.276354473026;3458.429359155736;3487.7035451986612;3488.66857648523;3522.894313170609;3533.1343820764077;23829.642555361683;24058.759412405827;24181.274561763174;26319;26709.19872403831;3386.4243078676436;3431.897043088711;3439.0886415099767;3451.913702157466;3462.9480557791653;244972;245220;246906;247445;247843;48094.27858582124;48210.758946205046;48258.758706206245;48323;48417.273740893914;50768.238476422885;50796.492035079915;50813.49186508162;50943.49056509462;50988.74505627522;12130.45412956419;12135.817962730565;12219.26684398939;12314.076444266715;12315.13794034427;8474.237318641352;8741.956290218508;9733.172680322252;10024.448655324028;10079.59681612742;16139.515814525583;16266.268017939221;16312.836871631369;16365.83634163667;16561.83438165603;6699.76550820719;6713.530052896251;6758.695858686371;6836.726530938707;6954.374106330454;786.8898354230412;795.2842441802309;809.0897740042452;817.6606708216143;830.7632324787406;27809.304767380978;27812.304692382448;27924.58113128305;28256.29359266035;28729.138125856258;932.8274269260208;934.4720233068294;942.2791564453199;950.2303134461108;959.3236768078488;14636.87538060122;15117.244137793066;15300.234988250542;15485.612859678598;15577.766333505006;364939;366063;367306;367451;369337;50957.49042509602;51223.7438812811;51418;51828.48171518312;51848.74075629598;1204.4827535514648;1205.9638210853689;1223.5839814463125;1226.7301193737542;1228.619128070301;25734.356641084123;26749;27453.862730686218;27701.30746731348;27781.305467363476;33276.500852486744;33382;33398.499022514196;33495;33603.327933440705;231141;231447;232052;232223;232982;23451.530969380176;24268.393290167885;24384.51230975406;25399.746002539738;25529.489410212063;36752.96226227265;36975.26049479049;37168.93387381584;37639.62360376361;37773.81113094417;31984.200394990312;31996.52005219877;32246.35507289888;32350.676493234765;32561;31823.36353272968;32241.838790805898;32321.838390807894;32355.35289294248;33119.50320745239;31107.37785244328;31595;31630.209244769067;31747.206319841265;32023.359532808747;28286.15141545757;28894.71105289004;29601.85199073991;29743.25641858971;29761.25596860096;22637.547249055257;22801.657975130056;22808.771912280667;23028.884855575616;23046.884765576066 07:51:38 INFO - PROCESS | 7866 | |2;jquery.html;383.14546949833095;383.4650662326054;385.21608526648276;385.41994298580613;414.34533437169273;15092.47176348828;16583.66832663346;17132.143392830356;18719.625607487844;18758.90620546897;11016.944915275413;12269.079819013565;16317.428889988852;17424.041677707723;17430.912845435785;4598.678092533524;4721.834735784249;4727.3618061561765;4742;4776.522347765231;4608.377868987677;4719.575238228559;4761;5132.692038477703;5158.045761534109;5098.923516147261;5141.357330333708;5144.742762861842;5154.74226288686;5164.457731938149;4714.95285047152;4731.550502702238;4897.094037603037;5110.872228194306;5143.331366922295;4646.210144275481;4647.18674232008;4653.837115700934;4661.09108723799;4670.416197975253;12488;12575.93712031434;21479.355619331443;21586.35240942774;21679.24122655715;2194.5391467791783;2234.162189179058;2250.0437314141423;2261.9434514137115;2272.2047283450825;9367.53162341887;9817.950910245474;10044;13577;14010.649733756636;1732.3676857946884;1749.6063385738107;1770.0707128757376;1798.5413719501573;1830.9084545772657;70956;71377.28622713758;71404;72353.2764672357;72712.27287727108;10339.483025848678;10463.790724185474;10513.684589462327;10790.946045269724;10810.0270975611;14710.33803478846;14762.409503619734;14786.186759728103;14798.48205312809;14826.92586537082;6654.367835055662;6871.759488417882;6913.827154321182;6989.580625162506;7096.432285417154;6212.596181248205;6257.624542527463;6442;6455.61266324022;6457.031445283245;4422.778861056934;4481.775911204427;4483.641308695362;4555.63554915606;4625.074985002945;1872.6629206742916;1940.5924755801157;1955.2081407030175;1967.2426115945464;1971.9112639931238;800.1478425476848;808.5068108453838;823.0164952881249;837.7696133563197;852.7654894903951;16800.663986720443;17028.57428564271;18263.72604410935;18339.093433485836;18421.63156736858;823.9505629662119;827.3009307135461;836.3601844588894;839.1063517353998;840.5083026429608;9420.717378478657;10021.849672254923;10033.247506437046;10064.748381290527;10123.64567240143;504854;508086;508650;521985;525191;67127;67382;88674.55662721774;91178;93467.53266233625;897.228383590112;913.0914739833908;916.6333466613274;922.6632279218037;924.066692640438;14747;15140.772888406462;15845.445409411077;15952.122633254818;16117.758233626271;38149.80925095357;38863.80568097141;38919.63781267642;39054.80472597619;39624.207515850096;55081.1737823941;55219;55465.44534554603;56694.716526417105;56898.14652780294;7705.22947705225;7718.6140692964;7855.646495907584;7871.448998570274;8010.078840933367;8482.406231563731;11545.826812597987;11790;11868.881311186778;11926.165168438127;9587.760305992406;9961.950190249003;10158.238132140266;10309.278350515391;10653.254272200871;9863;9940.900590993997;10392.116670083127;10427.68716938493;10741;10043.497825108569;10465.319754216256;10593.258471906893;10679.89320106789;11040.558377664804;6527;6665.800025999228;6773.796786096425;7081.752138675121;8234.135415781257;10050.69847904564;10140.442275674908;10298.433586152534;10429.269951103654;10464.581416743245 07:51:38 INFO - PROCESS | 7866 | |3;mootools.html;1293.5084667826225;1313.4746101559374;1318.0707601141196;1324.5761356365954;1339.524468813571;6161.137440758297;6476.1257230273895;6640.966795166029;7079.398251148652;7105.573665580069;6709.329067093288;6854.0404343391965;6968.860622787553;6982.16214054313;7055.259197784236;2036.4603380104284;2072.29541955735;2073.5749171419825;2077.480629842539;2082.021449918536;2073.8444616653737;2083.468715477551;2116.0689296709397;2119.8940052997364;2148.731408573928;2124.2777455665073;2131.9040643171093;2140.5076832328573;2143.710599069121;2145.7961493658077;2086.6348389031937;2096.6330892093824;2113.3765539165984;2114.5242320477923;2115.2279418012467;2065.297798748418;2086.7078608994752;2094.8009939055764;2100.2649072824543;2129.1802655977403;6922.7923162304705;6944.236134025253;6961.895571566431;6964.721411143548;6971.337722916315;4250.574942505756;4363.192809330284;4369.257226271541;4370.628496577795;4381.233284175289;2713.3759235375974;2856.871440785149;2897.4350001749667;2919.2409973406857;2923.0938409093037;1020.7601213714771;1052.9947350263276;1092.5302120088359;1101.3997371432588;1113.2318700096907;8951.149640784115;9054.5925433355;9116.58975346111;9122.498262595554;9149.451032938112;3662.1760103976926;3745.3258413485833;3799.2021675447913;3829.8659546915724;3853.499045124172;7301.08736407949;7316.853662926712;7342.082239720035;7343.88984165238;7368.189499155089;4273.102648443862;4280.422143010654;4283.914321713548;4286.87139385819;4289.914201715948;3890.3386424307937;3962.1481381503113;4043.7978101094827;4071.572484889044;4084.2852500812833;3151.4327421064427;3157.952630710541;3210.5184222366365;3220.790648607833;3253.4469140246215;928.3408779766306;937.5640327247726;973.352720440913;1000.1998401278947;1010.1766311807258;759.1383779410298;760.7679657704454;770.7880332908495;771.3559178086249;774.795430288173;4563.087382523442;4581.312803079565;4623.514530974267;4680.227762419231;4786.904261914742;846.3229416466925;880.8898887639045;887.1084560017271;889.2397000564554;889.3374436045187;3058.113147187291;3065.4788685923445;3125.6561778204377;3184.6496885342594;3211.5066494080365;7924.366050715929;8134;8135.959320203361;8143.022837259448;8161.836763264701;8094.392920530984;8117.797055073553;8121.715739949073;8128.227818357246;8144.104148543655;6533.346665333524;6539.738410463623;6639.170103737033;6646.335366463411;6660.067590537328;4331.566843315643;4524.547545245581;4575.3137029444515;4620.075984802986;4652.046330502307;7366.926330736838;7517.661705223388;7552.697892084255;7566.924330756622;7572.545647261182;7560.130584982578;7671.07947046358;7745.419093568117;7748.57382843949;7749.845003100019;5934.169216309807;6138.508919286535;6143.293521245114;6263.6241825490615;6265.937340626535;6577.112089867998;6658.76694315716;6672.399484046459;6711.46308295345;6714.294999025227;6060.606060606046;6110.663913484801;6120.908186377297;6124.755009799736;6283.685815709105;5849.64902105875;5921.496672782861;5989.460948514655;6036.8188954331445;6087.634741915499;5403.351597808288;5520.1167813149705;5552.52803511706;5554.50009499147;5564.916526252028;3988.581198974182;4025.6578190854107;4066.755994640331;4085.264652362603;4120.299549076604;3944.1914407546956;3969.92060158801;3976.085500334997;4047.494063242095;4092.447519584818 07:51:38 INFO - PROCESS | 7866 | |4;prototype.html;325.1140641751227;333.51640121823357;338.6748721227621;341.5252798609931;343.92180514088335;4813.518648135185;4943.777530011149;4983.312348861843;5046.798128074877;5055.747212639362;4764.285357196422;4894.192458244385;4948.876278093049;4969.726665033421;4970.304157417955;3940.5271367435803;3992.0618654616214;3995.7602543847315;4000.3999400090074;4006.135613036678;3915.9804200978956;3981.6217459341315;4009.7594144351287;4022.919541609166;4031.3549832026883;3946.7237293389476;3948.960510394888;3966.226585815767;3973.9801300993454;3982.9601703983026;3954.387070004154;3956.980215098935;3962.434838238894;3965.6827453803626;3968.8412463501427;3545.982270088659;3564.41187204111;3571.839152275521;3574.6246644102257;3577.481265216555;4676.936606522733;4843.58829499493;4854;4918.729469879156;4959.876003099916;4428.136513379892;4486.304622783474;4488.41650585425;4492.483364413101;4524.547545245449;5211.296474975906;5224.216367544861;5239.921401178985;5246.554042906358;5246.737663116829;3416.121133376658;3582.960941327038;3860.305145073886;3862;3884.4173373994126;5440.4287549807095;5448.37343705475;5452.809151679672;5456.508914197741;5456.7544460499375;3694.3350196964802;3696.7042636589545;3697.1126929536717;3711.870084547028;3716.832742526593;3733.775973441602;3751.1934933988778;3756.323861704919;3760.511133552621;3777.3956167013694;4147.668186545069;4302.419173411612;4309.978450107729;4312.094460163401;4313.374560688682;5185.196294574347;5197.24639927216;5213.791448342024;5219.791208351623;5223.791048358099;1212.5089338817793;1236.3509157692283;1236.8021116621298;1239.2254840724547;1251.7621651886295;810.8986376702912;821.572782153277;826.1944604011161;828.4201059258543;832.1137988042715;4372.650187984954;4417;4420.270655341897;4427.822887084545;4434.179676759745;5163.4114290567695;5163.8381364192755;5168.080034780337;5170.6122040847085;5189.351331083614;4412.124846940038;4423.301785910592;4429.867103986821;4431.578999994996;4435;2613.9480507801286;2736.86315684215;2750.917472475829;2754.394033312668;2764.9170524884285;4763.1426343258545;4798.776312040407;4810.42274927004;4818.012307477029;4854.660173787872;5026.748662566857;5319.255304257407;5320.627556071116;5322.467753224647;5332.173513105475;4781.163296423112;4792.496787837227;4801.7995501124715;4819.59033482158;4834.516548345278;5187.870303242449;5202.127234195762;5205.92191117126;5206.349206349207;5208.661437006583;4895.290182923527;4984.925226121539;5123.205903085028;5126.4360920297995;5146;4788.569028787426;4817.098150498107;4839.685420447659;4848.321235027029;4878.463369029475;3609.296187243462;3612.8438899551893;3615.222727113683;3615.584207816135;3621.8732344367822;5009.396992962363;5194.506521880416;5214.001948879334;5264.894702106013;5322.733863306742;4978.303037574815;5036.992601479792;5043.268726034631;5043.747812609428;5060.2156665716875;4980.676256043345;5009.323741294878;5068.265101560327;5078.441371449064;5081.415637201769;4726.598239149574;4929.383827021622;4940.851774446773;4952.7771250294545;4995.700257984533;5042.621803364689;5066.544011039025;5075.365579302587;5097.923531146962;5106.770195341144;4829.323894654681;4870.488598697086;4881.487443818348;4886.340344053508;4896.828610998598 07:51:38 INFO - PROCESS | 7866 | |5;yui.html;667.459357920085;690.9343612356824;729.595074733523;743.9628018599069;755.8148253677849;12283.324417157053;12456.31490268036;12457.875421245784;12463.937680311608;12553.309567973769;13156.276404797733;13275.40260688269;13282.933585332059;13311.600651980456;13374.331283435813;649.5907578225734;666.2138676361891;790.0835031363605;791.3392317414965;814.352589691197;807.4711064252924;808.5633757770826;811.2455416462687;812.0742353716768;813.2843098073716;858.7080392666492;862.7368652560998;865.8095219051798;868.0928429790883;868.2619773192768;855.1448551448551;858.3948316436897;858.8024754306482;858.845407826591;859.2138193552892;622.2004723929729;625.3808729357949;626.6240255846501;626.8401557602828;627.9152314437538;13671.453141874412;13723.1079979801;13746.312684365741;13772;14015.29923503831;13631.318434078355;14482.782758258634;14493.637659058608;14545.27273636314;14559.126452412784;10434;10491.370517768959;10504.212184086224;10509.106725928305;10683.14534837211;3274.5743053402907;3304.1574398528223;3314.5359649649067;3324.2188085799817;3342.615599206098;62702.37297627056;62933.37066629321;63508.682456587885;64100.35899640991;64509.67745161291;10310.639127630497;10360.948195258976;10443.164546836388;10615.363078215178;10867.239293249397;19643.803561964483;19652.11565479557;19687.114079866442;19700.507487312647;19764.90117549403;6751.763688270887;6770.93229067703;6895.620740859201;7109.680064397115;7138.179109402381;3604.621514740967;3661.2494438640547;3708.8331025103935;3718.6095459976855;3731.9440208396895;2849.928751781222;2894.623698919127;2902.6081479000486;2905.302727345464;2913.898013569515;466.10042617747393;474.71517089745873;476.0194000359271;482.4307317365472;483.6469377354551;540.2733323679645;564.6640249051808;566.8526183192399;567.1379503155181;570.0707846210732;8144.348452123816;8855.114488551093;8968.242879099289;9204.861927070966;9517.666881659108;622.5299898576545;637.9872402551923;640.5164101103637;644.6422235659254;650.177525430331;4024.71826972115;4335.783210839445;4362.454693163355;4372.890677733082;4406.757628330409;64727;66324.33675663278;66826.66586667036;67636.6618166906;70196.29803702;57807.42192578105;58143.709281453324;58875.41124588785;62577;63070.684646576476;54070.918581628146;54672.17991730127;54814.72592637011;55028;55243.447565524635;8163.877541836759;8509.74470765878;8523.95738021306;8560.48637081777;8727.952645682559;36861.26277474489;37598.43602346021;37927.62072379241;38005.80997095107;38381.80809095937;44501;44997.55002450065;46549.767251163525;47144.528554714016;48727.756361217966;10232.283740138417;10367.118794902217;10591;10633.574657013942;10679.786404272027;11592.88407115918;11598.594049208237;11676.88323116758;12095.274283543016;12504.937475312565;10880.129589632968;10953.945230273797;11117.833232501358;11166.44167791591;11523.596674116367;10343.741406464898;10348.637797677045;10783.19126065564;10798.298110622783;11132.109431245319;10157.339772914736;10172;10176.796464070825;10206.336588121749;10356.378617282988;8772.56137193125;9044.81910361776;9385;9400.623975040922;9633.32566720323;7856.882146767917;8601.526916019679;8874.955625221832;8931.330150238888;9011.188992990663 07:51:38 INFO - PROCESS | 7866 | __end_tp_report 07:51:38 INFO - PROCESS | 7866 | __start_cc_report 07:51:38 INFO - PROCESS | 7866 | _x_x_mozilla_cycle_collect,345 07:51:38 INFO - PROCESS | 7866 | __end_cc_report 07:51:38 INFO - PROCESS | 7866 | __startTimestamp1485877898949__endTimestamp 07:51:38 INFO - PROCESS | 7866 | 07:51:38 INFO - PROCESS | 7866 | ------- Summary: start ------- 07:51:38 INFO - PROCESS | 7866 | Number of tests: 6 07:51:38 INFO - PROCESS | 7866 | 07:51:38 INFO - PROCESS | 7866 | [#0] dojo.html Cycles:165 Average:4735.49 Median:4867.54 stddev:526.04 (10.8%) stddev-sans-first:500.34 07:51:38 INFO - PROCESS | 7866 | Values: 2602.6 2603.4 2616.0 2625.8 2644.5 4722.5 4837.3 4856.2 4861.2 4879.9 4766.2 4800.9 4833.2 4871.2 4879.4 4356.3 4470.4 4478.3 4534.6 4545.2 4486.2 4525.4 4529.8 4534.5 4546.5 4325.3 4364.3 4377.7 4489.5 4509.0 4415.8 4426.7 4455.2 4475.8 4485.0 4380.7 4415.1 4416.4 4419.5 4424.3 4709.2 4737.0 4780.1 4800.9 4842.5 5070.9 5093.8 5102.5 5118.4 5169.1 5113.4 5113.8 5115.4 5118.6 5131.7 4810.3 4824.6 4826.6 4865.6 4874.7 5136.9 5166.1 5169.5 5186.6 5239.0 4964.3 5023.8 5025.9 5026.2 5027.3 5078.7 5088.5 5090.9 5095.1 5114.3 5081.9 5100.1 5101.8 5122.3 5124.6 5140.6 5141.6 5153.7 5159.3 5178.4 3972.8 4004.5 4010.3 4031.5 4058.2 3541.8 3545.7 3556.5 3576.2 3584.1 4399.4 4411.1 4412.1 4431.0 4454.1 5077.9 5136.4 5140.1 5147.9 5163.0 4441.5 4443.8 4448.0 4456.4 4462.3 4680.2 4720.5 4727.1 4747.0 4757.1 4824.2 4849.0 4858.0 4867.5 4895.3 5047.8 5070.7 5213.5 5220.3 5264.2 4756.7 4797.9 4808.9 4818.3 4864.3 4936.1 5000.5 5045.9 5109.6 5110.1 5179.5 5223.5 5235.8 5257.0 5258.0 5051.8 5053.3 5055.4 5064.3 5105.4 4906.2 4940.4 4951.6 4992.0 5015.9 4795.8 4970.0 4970.2 4973.9 4974.1 5041.1 5053.4 5056.9 5072.6 5085.0 4815.8 4833.3 4877.4 4915.6 4989.2 07:51:38 INFO - PROCESS | 7866 | 07:51:38 INFO - PROCESS | 7866 | [#1] ext.html Cycles:180 Average:43285.50 Median:3505.78 stddev:75706.63 (2159.5%) stddev-sans-first:75850.89 07:51:38 INFO - PROCESS | 7866 | Values: 513.1 524.9 533.4 543.0 568.3 38782.6 41185.4 41273.0 44355.3 44492.8 41407.8 41513.2 41722.4 41825.8 41845.6 7721.9 7855.3 7891.6 9677.0 9998.8 9860.8 9946.4 9956.1 9962.7 9976.0 9944.6 9980.9 9989.9 9990.4 10003.1 9875.2 9909.7 9946.2 9954.4 9960.8 9854.5 9870.3 9871.3 9905.2 9917.5 35711.1 35799.3 35800.5 36102.1 36182.3 3458.4 3487.7 3488.7 3522.9 3533.1 23829.6 24058.8 24181.3 26319.0 26709.2 3386.4 3431.9 3439.1 3451.9 3462.9 244972.0 245220.0 246906.0 247445.0 247843.0 48094.3 48210.8 48258.8 48323.0 48417.3 50768.2 50796.5 50813.5 50943.5 50988.7 12130.5 12135.8 12219.3 12314.1 12315.1 8474.2 8742.0 9733.2 10024.4 10079.6 16139.5 16266.3 16312.8 16365.8 16561.8 6699.8 6713.5 6758.7 6836.7 6954.4 786.9 795.3 809.1 817.7 830.8 27809.3 27812.3 27924.6 28256.3 28729.1 932.8 934.5 942.3 950.2 959.3 14636.9 15117.2 15300.2 15485.6 15577.8 364939.0 366063.0 367306.0 367451.0 369337.0 50957.5 51223.7 51418.0 51828.5 51848.7 1204.5 1206.0 1223.6 1226.7 1228.6 25734.4 26749.0 27453.9 27701.3 27781.3 33276.5 33382.0 33398.5 33495.0 33603.3 231141.0 231447.0 232052.0 232223.0 232982.0 23451.5 24268.4 24384.5 25399.7 25529.5 36753.0 36975.3 37168.9 37639.6 37773.8 31984.2 31996.5 32246.4 32350.7 32561.0 31823.4 32241.8 32321.8 32355.4 33119.5 31107.4 31595.0 31630.2 31747.2 32023.4 28286.2 28894.7 29601.9 29743.3 29761.3 22637.5 22801.7 22808.8 23028.9 23046.9 07:51:38 INFO - PROCESS | 7866 | 07:51:38 INFO - PROCESS | 7866 | [#2] jquery.html Cycles:180 Average:28062.36 Median:4577.16 stddev:84419.67 (1844.4%) stddev-sans-first:84630.91 07:51:38 INFO - PROCESS | 7866 | Values: 383.1 383.5 385.2 385.4 414.3 15092.5 16583.7 17132.1 18719.6 18758.9 11016.9 12269.1 16317.4 17424.0 17430.9 4598.7 4721.8 4727.4 4742.0 4776.5 4608.4 4719.6 4761.0 5132.7 5158.0 5098.9 5141.4 5144.7 5154.7 5164.5 4715.0 4731.6 4897.1 5110.9 5143.3 4646.2 4647.2 4653.8 4661.1 4670.4 12488.0 12575.9 21479.4 21586.4 21679.2 2194.5 2234.2 2250.0 2261.9 2272.2 9367.5 9818.0 10044.0 13577.0 14010.6 1732.4 1749.6 1770.1 1798.5 1830.9 70956.0 71377.3 71404.0 72353.3 72712.3 10339.5 10463.8 10513.7 10790.9 10810.0 14710.3 14762.4 14786.2 14798.5 14826.9 6654.4 6871.8 6913.8 6989.6 7096.4 6212.6 6257.6 6442.0 6455.6 6457.0 4422.8 4481.8 4483.6 4555.6 4625.1 1872.7 1940.6 1955.2 1967.2 1971.9 800.1 808.5 823.0 837.8 852.8 16800.7 17028.6 18263.7 18339.1 18421.6 824.0 827.3 836.4 839.1 840.5 9420.7 10021.8 10033.2 10064.7 10123.6 504854.0 508086.0 508650.0 521985.0 525191.0 67127.0 67382.0 88674.6 91178.0 93467.5 897.2 913.1 916.6 922.7 924.1 14747.0 15140.8 15845.4 15952.1 16117.8 38149.8 38863.8 38919.6 39054.8 39624.2 55081.2 55219.0 55465.4 56694.7 56898.1 7705.2 7718.6 7855.6 7871.4 8010.1 8482.4 11545.8 11790.0 11868.9 11926.2 9587.8 9962.0 10158.2 10309.3 10653.3 9863.0 9940.9 10392.1 10427.7 10741.0 10043.5 10465.3 10593.3 10679.9 11040.6 6527.0 6665.8 6773.8 7081.8 8234.1 10050.7 10140.4 10298.4 10429.3 10464.6 07:51:38 INFO - PROCESS | 7866 | 07:51:38 INFO - PROCESS | 7866 | [#3] mootools.html Cycles:180 Average:4551.22 Median:4733.57 stddev:2402.17 (50.7%) stddev-sans-first:2396.43 07:51:38 INFO - PROCESS | 7866 | Values: 1293.5 1313.5 1318.1 1324.6 1339.5 6161.1 6476.1 6641.0 7079.4 7105.6 6709.3 6854.0 6968.9 6982.2 7055.3 2036.5 2072.3 2073.6 2077.5 2082.0 2073.8 2083.5 2116.1 2119.9 2148.7 2124.3 2131.9 2140.5 2143.7 2145.8 2086.6 2096.6 2113.4 2114.5 2115.2 2065.3 2086.7 2094.8 2100.3 2129.2 6922.8 6944.2 6961.9 6964.7 6971.3 4250.6 4363.2 4369.3 4370.6 4381.2 2713.4 2856.9 2897.4 2919.2 2923.1 1020.8 1053.0 1092.5 1101.4 1113.2 8951.1 9054.6 9116.6 9122.5 9149.5 3662.2 3745.3 3799.2 3829.9 3853.5 7301.1 7316.9 7342.1 7343.9 7368.2 4273.1 4280.4 4283.9 4286.9 4289.9 3890.3 3962.1 4043.8 4071.6 4084.3 3151.4 3158.0 3210.5 3220.8 3253.4 928.3 937.6 973.4 1000.2 1010.2 759.1 760.8 770.8 771.4 774.8 4563.1 4581.3 4623.5 4680.2 4786.9 846.3 880.9 887.1 889.2 889.3 3058.1 3065.5 3125.7 3184.6 3211.5 7924.4 8134.0 8136.0 8143.0 8161.8 8094.4 8117.8 8121.7 8128.2 8144.1 6533.3 6539.7 6639.2 6646.3 6660.1 4331.6 4524.5 4575.3 4620.1 4652.0 7366.9 7517.7 7552.7 7566.9 7572.5 7560.1 7671.1 7745.4 7748.6 7749.8 5934.2 6138.5 6143.3 6263.6 6265.9 6577.1 6658.8 6672.4 6711.5 6714.3 6060.6 6110.7 6120.9 6124.8 6283.7 5849.6 5921.5 5989.5 6036.8 6087.6 5403.4 5520.1 5552.5 5554.5 5564.9 3988.6 4025.7 4066.8 4085.3 4120.3 3944.2 3969.9 3976.1 4047.5 4092.4 07:51:38 INFO - PROCESS | 7866 | 07:51:38 INFO - PROCESS | 7866 | [#4] prototype.html Cycles:180 Average:4246.92 Median:4815.31 stddev:1221.17 (25.4%) stddev-sans-first:1188.59 07:51:38 INFO - PROCESS | 7866 | Values: 325.1 333.5 338.7 341.5 343.9 4813.5 4943.8 4983.3 5046.8 5055.7 4764.3 4894.2 4948.9 4969.7 4970.3 3940.5 3992.1 3995.8 4000.4 4006.1 3916.0 3981.6 4009.8 4022.9 4031.4 3946.7 3949.0 3966.2 3974.0 3983.0 3954.4 3957.0 3962.4 3965.7 3968.8 3546.0 3564.4 3571.8 3574.6 3577.5 4676.9 4843.6 4854.0 4918.7 4959.9 4428.1 4486.3 4488.4 4492.5 4524.5 5211.3 5224.2 5239.9 5246.6 5246.7 3416.1 3583.0 3860.3 3862.0 3884.4 5440.4 5448.4 5452.8 5456.5 5456.8 3694.3 3696.7 3697.1 3711.9 3716.8 3733.8 3751.2 3756.3 3760.5 3777.4 4147.7 4302.4 4310.0 4312.1 4313.4 5185.2 5197.2 5213.8 5219.8 5223.8 1212.5 1236.4 1236.8 1239.2 1251.8 810.9 821.6 826.2 828.4 832.1 4372.7 4417.0 4420.3 4427.8 4434.2 5163.4 5163.8 5168.1 5170.6 5189.4 4412.1 4423.3 4429.9 4431.6 4435.0 2613.9 2736.9 2750.9 2754.4 2764.9 4763.1 4798.8 4810.4 4818.0 4854.7 5026.7 5319.3 5320.6 5322.5 5332.2 4781.2 4792.5 4801.8 4819.6 4834.5 5187.9 5202.1 5205.9 5206.3 5208.7 4895.3 4984.9 5123.2 5126.4 5146.0 4788.6 4817.1 4839.7 4848.3 4878.5 3609.3 3612.8 3615.2 3615.6 3621.9 5009.4 5194.5 5214.0 5264.9 5322.7 4978.3 5037.0 5043.3 5043.7 5060.2 4980.7 5009.3 5068.3 5078.4 5081.4 4726.6 4929.4 4940.9 4952.8 4995.7 5042.6 5066.5 5075.4 5097.9 5106.8 4829.3 4870.5 4881.5 4886.3 4896.8 07:51:38 INFO - PROCESS | 7866 | 07:51:38 INFO - PROCESS | 7866 | [#5] yui.html Cycles:180 Average:15040.38 Median:475.37 stddev:19019.19 (4000.9%) stddev-sans-first:19041.92 07:51:38 INFO - PROCESS | 7866 | Values: 667.5 690.9 729.6 744.0 755.8 12283.3 12456.3 12457.9 12463.9 12553.3 13156.3 13275.4 13282.9 13311.6 13374.3 649.6 666.2 790.1 791.3 814.4 807.5 808.6 811.2 812.1 813.3 858.7 862.7 865.8 868.1 868.3 855.1 858.4 858.8 858.8 859.2 622.2 625.4 626.6 626.8 627.9 13671.5 13723.1 13746.3 13772.0 14015.3 13631.3 14482.8 14493.6 14545.3 14559.1 10434.0 10491.4 10504.2 10509.1 10683.1 3274.6 3304.2 3314.5 3324.2 3342.6 62702.4 62933.4 63508.7 64100.4 64509.7 10310.6 10360.9 10443.2 10615.4 10867.2 19643.8 19652.1 19687.1 19700.5 19764.9 6751.8 6770.9 6895.6 7109.7 7138.2 3604.6 3661.2 3708.8 3718.6 3731.9 2849.9 2894.6 2902.6 2905.3 2913.9 466.1 474.7 476.0 482.4 483.6 540.3 564.7 566.9 567.1 570.1 8144.3 8855.1 8968.2 9204.9 9517.7 622.5 638.0 640.5 644.6 650.2 4024.7 4335.8 4362.5 4372.9 4406.8 64727.0 66324.3 66826.7 67636.7 70196.3 57807.4 58143.7 58875.4 62577.0 63070.7 54070.9 54672.2 54814.7 55028.0 55243.4 8163.9 8509.7 8524.0 8560.5 8728.0 36861.3 37598.4 37927.6 38005.8 38381.8 44501.0 44997.6 46549.8 47144.5 48727.8 10232.3 10367.1 10591.0 10633.6 10679.8 11592.9 11598.6 11676.9 12095.3 12504.9 10880.1 10953.9 11117.8 11166.4 11523.6 10343.7 10348.6 10783.2 10798.3 11132.1 10157.3 10172.0 10176.8 10206.3 10356.4 8772.6 9044.8 9385.0 9400.6 9633.3 7856.9 8601.5 8875.0 8931.3 9011.2 07:51:38 INFO - PROCESS | 7866 | -------- Summary: end -------- 07:51:38 INFO - PROCESS | 7866 | 07:51:39 INFO - TEST-INFO | 7866: exit 0 07:51:39 INFO - TEST-OK | dromaeo_css | took 1119756ms 07:51:39 INFO - TEST-START | kraken 07:51:39 INFO - operating with platform_type : linux_ 07:51:39 INFO - Initialising browser for kraken test... 07:51:39 INFO - TEST-INFO | started process 8249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljg8Vm/profile http://localhost:43377/getInfo.html) 07:51:44 INFO - PROCESS | 8249 | 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] 07:51:44 INFO - PROCESS | 8249 | __metrics Screen width/height:1600/1200 07:51:44 INFO - PROCESS | 8249 | colorDepth:24 07:51:44 INFO - PROCESS | 8249 | Browser inner width/height: 1024/697 07:51:44 INFO - PROCESS | 8249 | __metrics 07:51:45 INFO - PROCESS | 8249 | 1485877905338 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6274:36 < canClose@browser.js:5140:12 < forceQuit@jar:file:///tmp/tmpljg8Vm/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpljg8Vm/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpljg8Vm/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpljg8Vm/profile/extensions/talos-powers@TalosPowersService.js:55:9 07:51:45 ERROR - PROCESS | 8249 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3284: TypeError: this.tabs is undefined 07:51:46 INFO - TEST-INFO | 8249: exit 0 07:51:46 INFO - Browser initialized. 07:51:46 INFO - Running cycle 1/1 for kraken test... 07:51:46 INFO - TEST-INFO | started process 8368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljg8Vm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:58 INFO - PROCESS | 8368 | RSS: Main: 163659776 07:51:58 INFO - PROCESS | 8368 | 07:52:01 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43377/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:02 INFO - PROCESS | 8368 | RSS: Main: 169066496 07:52:02 INFO - PROCESS | 8368 | 07:52:04 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43377/tests/kraken/driver.html?testName=audio-dft) 07:52:05 INFO - PROCESS | 8368 | RSS: Main: 166596608 07:52:05 INFO - PROCESS | 8368 | 07:52:08 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43377/tests/kraken/driver.html?testName=audio-fft) 07:52:08 INFO - PROCESS | 8368 | RSS: Main: 161992704 07:52:08 INFO - PROCESS | 8368 | 07:52:11 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43377/tests/kraken/driver.html?testName=audio-oscillator) 07:52:11 INFO - PROCESS | 8368 | RSS: Main: 162656256 07:52:11 INFO - PROCESS | 8368 | 07:52:13 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:14 INFO - PROCESS | 8368 | RSS: Main: 163188736 07:52:14 INFO - PROCESS | 8368 | 07:52:17 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43377/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:18 INFO - PROCESS | 8368 | RSS: Main: 168034304 07:52:18 INFO - PROCESS | 8368 | 07:52:21 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43377/tests/kraken/driver.html?testName=imaging-desaturate) 07:52:22 INFO - PROCESS | 8368 | RSS: Main: 164204544 07:52:22 INFO - PROCESS | 8368 | 07:52:25 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43377/tests/kraken/driver.html?testName=json-parse-financial) 07:52:26 INFO - PROCESS | 8368 | RSS: Main: 165023744 07:52:26 INFO - PROCESS | 8368 | 07:52:27 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:52:28 INFO - PROCESS | 8368 | RSS: Main: 165318656 07:52:28 INFO - PROCESS | 8368 | 07:52:30 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:52:31 INFO - PROCESS | 8368 | RSS: Main: 165113856 07:52:31 INFO - PROCESS | 8368 | 07:52:33 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:52:33 INFO - PROCESS | 8368 | RSS: Main: 165376000 07:52:33 INFO - PROCESS | 8368 | 07:52:36 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:52:37 INFO - PROCESS | 8368 | RSS: Main: 166621184 07:52:37 INFO - PROCESS | 8368 | 07:52:40 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:52:41 INFO - PROCESS | 8368 | RSS: Main: 169046016 07:52:41 INFO - PROCESS | 8368 | 07:52:42 INFO - PROCESS | 8368 | Cycle 1(1): loaded http://localhost:43377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43377/tests/kraken/driver.html?testName=ai-astar) 07:52:43 INFO - PROCESS | 8368 | RSS: Main: 169926656 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | __start_tp_report 07:52:43 INFO - PROCESS | 8368 | _x_x_mozilla_page_load 07:52:43 INFO - PROCESS | 8368 | _x_x_mozilla_page_load_details 07:52:43 INFO - PROCESS | 8368 | |i|pagename|runs| 07:52:43 INFO - PROCESS | 8368 | |0;ai-astar;110;118;116;117;116;118;117;117;117;118 07:52:43 INFO - PROCESS | 8368 | |1;audio-beat-detection;153;134;124;175;132;131;129;137;156;131 07:52:43 INFO - PROCESS | 8368 | |2;audio-dft;165;164;163;166;175;163;164;165;163;164 07:52:43 INFO - PROCESS | 8368 | |3;audio-fft;76;77;77;108;76;78;79;77;98;76 07:52:43 INFO - PROCESS | 8368 | |4;audio-oscillator;86;87;105;84;84;85;106;84;84;115 07:52:43 INFO - PROCESS | 8368 | |5;imaging-gaussian-blur;118;118;118;118;118;118;121;118;118;118 07:52:43 INFO - PROCESS | 8368 | |6;imaging-darkroom;153;150;149;150;149;152;150;151;150;150 07:52:43 INFO - PROCESS | 8368 | |7;imaging-desaturate;96;96;96;96;95;96;96;96;96;96 07:52:43 INFO - PROCESS | 8368 | |8;json-parse-financial;65;66;65;65;66;66;73;67;67;65 07:52:43 INFO - PROCESS | 8368 | |9;json-stringify-tinderbox;66;67;67;67;67;66;67;66;66;67 07:52:43 INFO - PROCESS | 8368 | |10;stanford-crypto-aes;85;84;85;89;89;86;85;85;85;93 07:52:43 INFO - PROCESS | 8368 | |11;stanford-crypto-ccm;147;142;136;148;136;132;146;133;189;144 07:52:43 INFO - PROCESS | 8368 | |12;stanford-crypto-pbkdf2;185;183;181;181;183;181;183;182;179;187 07:52:43 INFO - PROCESS | 8368 | |13;stanford-crypto-sha256-iterative;75;70;69;70;78;69;69;67;68;69 07:52:43 INFO - PROCESS | 8368 | __end_tp_report 07:52:43 INFO - PROCESS | 8368 | __start_cc_report 07:52:43 INFO - PROCESS | 8368 | _x_x_mozilla_cycle_collect,814 07:52:43 INFO - PROCESS | 8368 | __end_cc_report 07:52:43 INFO - PROCESS | 8368 | __startTimestamp1485877963163__endTimestamp 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | ------- Summary: start ------- 07:52:43 INFO - PROCESS | 8368 | Number of tests: 14 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#0] ai-astar Cycles:10 Average:116.40 Median:117.00 stddev:2.37 (2.0%) stddev-sans-first:0.78 07:52:43 INFO - PROCESS | 8368 | Values: 110.0 118.0 116.0 117.0 116.0 118.0 117.0 117.0 117.0 118.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:135.50 stddev:15.98 (11.8%) stddev-sans-first:16.26 07:52:43 INFO - PROCESS | 8368 | Values: 153.0 134.0 124.0 175.0 132.0 131.0 129.0 137.0 156.0 131.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:3.58 (2.2%) stddev-sans-first:3.80 07:52:43 INFO - PROCESS | 8368 | Values: 165.0 164.0 163.0 166.0 175.0 163.0 164.0 165.0 163.0 164.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#3] audio-fft Cycles:10 Average:82.20 Median:77.00 stddev:11.25 (14.6%) stddev-sans-first:11.71 07:52:43 INFO - PROCESS | 8368 | Values: 76.0 77.0 77.0 108.0 76.0 78.0 79.0 77.0 98.0 76.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:84.00 stddev:11.83 (14.1%) stddev-sans-first:12.35 07:52:43 INFO - PROCESS | 8368 | Values: 86.0 87.0 105.0 84.0 84.0 85.0 106.0 84.0 84.0 115.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 07:52:43 INFO - PROCESS | 8368 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 121.0 118.0 118.0 118.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:1.26 (0.8%) stddev-sans-first:0.93 07:52:43 INFO - PROCESS | 8368 | Values: 153.0 150.0 149.0 150.0 149.0 152.0 150.0 151.0 150.0 150.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:52:43 INFO - PROCESS | 8368 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.00 stddev:2.42 (3.7%) stddev-sans-first:2.50 07:52:43 INFO - PROCESS | 8368 | Values: 65.0 66.0 65.0 65.0 66.0 66.0 73.0 67.0 67.0 65.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:52:43 INFO - PROCESS | 8368 | Values: 66.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 66.0 67.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.50 stddev:2.84 (3.3%) stddev-sans-first:2.95 07:52:43 INFO - PROCESS | 8368 | Values: 85.0 84.0 85.0 89.0 89.0 86.0 85.0 85.0 85.0 93.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:145.00 stddev:16.45 (11.3%) stddev-sans-first:17.43 07:52:43 INFO - PROCESS | 8368 | Values: 147.0 142.0 136.0 148.0 136.0 132.0 146.0 133.0 189.0 144.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:183.00 stddev:2.27 (1.2%) stddev-sans-first:2.22 07:52:43 INFO - PROCESS | 8368 | Values: 185.0 183.0 181.0 181.0 183.0 181.0 183.0 182.0 179.0 187.0 07:52:43 INFO - PROCESS | 8368 | 07:52:43 INFO - PROCESS | 8368 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:69.50 stddev:3.41 (4.9%) stddev-sans-first:3.18 07:52:43 INFO - PROCESS | 8368 | Values: 75.0 70.0 69.0 70.0 78.0 69.0 69.0 67.0 68.0 69.0 07:52:43 INFO - PROCESS | 8368 | -------- Summary: end -------- 07:52:43 INFO - PROCESS | 8368 | 07:52:44 INFO - TEST-INFO | 8368: exit 0 07:52:44 INFO - TEST-OK | kraken | took 64498ms 07:52:44 INFO - SUITE-END | took 1184s 07:52:44 INFO - Completed test suite (00:19:44) 07:52:44 INFO - javascript benchmark 07:52:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6263.084427281487, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.648642433271, 2603.375189954411, 2616.005917751255, 2625.8161928665, 2644.5372059889514, 4722.527747225285, 4837.274408838676, 4856.150173719599, 4861.197902346117, 4879.926801097987, 4766.189747742884, 4800.879978000552, 4833.178359678855, 4871.244957031657, 4879.3656824612835, 4356.3465480178065, 4470.396496472983, 4478.283474644058, 4534.6372290216705, 4545.227311357061, 4486.214912390335, 4525.366448697185, 4529.841455549056, 4534.478534968488, 4546.522615125414, 4325.286327755916, 4364.301711726141, 4377.6935614507, 4489.46126464823, 4508.954910450886, 4415.845445409427, 4426.667999900021, 4455.1535208310315, 4475.7985890635, 4485.035717320791, 4380.7152535085115, 4415.116976604692, 4416.447944006999, 4419.491758447755, 4424.314231294123, 4709.152352576535, 4737.0, 4780.139574876521, 4800.855974320741, 4842.515748425165, 5070.873228169288, 5093.821716239914, 5102.464241254652, 5118.385793704742, 5169.069567477853, 5113.360829896263, 5113.795448182068, 5115.437301896788, 5118.6416950813455, 5131.743412829381, 4810.326554282403, 4824.589909857701, 4826.613870890355, 4865.56209941107, 4874.683145595596, 5136.897262054813, 5166.121759300928, 5169.534741873174, 5186.5850731941355, 5239.030779305841, 4964.255361695775, 5023.8492845214705, 5025.924611130836, 5026.170681837529, 5027.346444962204, 5078.7460626968505, 5088.465711100355, 5090.949090509122, 5095.133827249377, 5114.258432527263, 5081.923771143436, 5100.1074811907765, 5101.795928162906, 5122.308488354024, 5124.615653825978, 5140.588752899759, 5141.562967147759, 5153.665011774297, 5159.329287192641, 5178.378594568676, 3972.781497017692, 4004.479417675742, 4010.318245898204, 4031.475908131924, 4058.188362327546, 3541.805200713934, 3545.663161999606, 3556.519869817593, 3576.159602493412, 3584.0860580551794, 4399.406080179135, 4411.073674528385, 4412.117576484652, 4430.977845110819, 4454.131444368382, 5077.923831142536, 5136.383633963948, 5140.1004824155625, 5147.948520514822, 5163.044836705147, 4441.467023957146, 4443.755593442392, 4447.977760111179, 4456.398386217819, 4462.286034234572, 4680.15757163707, 4720.504347043579, 4727.149113159596, 4746.952530474651, 4757.072370887713, 4824.228123500223, 4848.95151048485, 4857.975710121426, 4867.537583929521, 4895.339129217653, 5047.772850221675, 5070.721110338966, 5213.504717051874, 5220.269162317202, 5264.236685680631, 4756.667033307635, 4797.856064318076, 4808.879778005438, 4818.277258411266, 4864.294677271847, 4936.062148191832, 5000.4749501303295, 5045.899082018413, 5109.5912327013, 5110.080185566485, 5179.45615710345, 5223.4776522347465, 5235.790568377222, 5256.9737151314, 5258.0, 5051.797928082836, 5053.267276244997, 5055.418626857959, 5064.316317297118, 5105.387353517602, 4906.190478571139, 4940.407151141886, 4951.603871690329, 4991.9500804991485, 5015.874603134805, 4795.784189711541, 4969.950300496948, 4970.229614409773, 4973.850784476472, 4974.104661161025, 5041.117804384291, 5053.393592768891, 5056.949430505648, 5072.619553533574, 5085.0, 4815.783289752039, 4833.323334733211, 4877.414710234652, 4915.557599816034, 4989.201727723546], "value": 4699.389064063787, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.1199992013696, 524.8582882621693, 533.3679589686224, 542.9737795566383, 568.2640979930989, 38782.61217387825, 41185.3822192667, 41273.0, 44355.33466997997, 44492.77753611228, 41407.79296103515, 41513.16973660525, 41722.37416438748, 41825.7908710456, 41845.58154418455, 7721.9227807722045, 7855.332296754783, 7891.644875980566, 9677.0, 9998.750031249205, 9860.802783944317, 9946.35348702332, 9956.103950644441, 9962.701118966443, 9976.0, 9944.5524951377, 9980.850287245661, 9989.850152247722, 9990.400575965428, 10003.149732272766, 9875.160611348045, 9909.702708918743, 9946.20430365569, 9954.352967057119, 9960.80078398428, 9854.50727463624, 9870.259730520167, 9871.309008369417, 9905.20758339331, 9917.454540000297, 35711.10722231965, 35799.284014319564, 35800.462993055124, 36102.097447563756, 36182.276354473026, 3458.429359155736, 3487.7035451986612, 3488.66857648523, 3522.894313170609, 3533.1343820764077, 23829.642555361683, 24058.759412405827, 24181.274561763174, 26319.0, 26709.19872403831, 3386.4243078676436, 3431.897043088711, 3439.0886415099767, 3451.913702157466, 3462.9480557791653, 244972.0, 245220.0, 246906.0, 247445.0, 247843.0, 48094.27858582124, 48210.758946205046, 48258.758706206245, 48323.0, 48417.273740893914, 50768.238476422885, 50796.492035079915, 50813.49186508162, 50943.49056509462, 50988.74505627522, 12130.45412956419, 12135.817962730565, 12219.26684398939, 12314.076444266715, 12315.13794034427, 8474.237318641352, 8741.956290218508, 9733.172680322252, 10024.448655324028, 10079.59681612742, 16139.515814525583, 16266.268017939221, 16312.836871631369, 16365.83634163667, 16561.83438165603, 6699.76550820719, 6713.530052896251, 6758.695858686371, 6836.726530938707, 6954.374106330454, 786.8898354230412, 795.2842441802309, 809.0897740042452, 817.6606708216143, 830.7632324787406, 27809.304767380978, 27812.304692382448, 27924.58113128305, 28256.29359266035, 28729.138125856258, 932.8274269260208, 934.4720233068294, 942.2791564453199, 950.2303134461108, 959.3236768078488, 14636.87538060122, 15117.244137793066, 15300.234988250542, 15485.612859678598, 15577.766333505006, 364939.0, 366063.0, 367306.0, 367451.0, 369337.0, 50957.49042509602, 51223.7438812811, 51418.0, 51828.48171518312, 51848.74075629598, 1204.4827535514648, 1205.9638210853689, 1223.5839814463125, 1226.7301193737542, 1228.619128070301, 25734.356641084123, 26749.0, 27453.862730686218, 27701.30746731348, 27781.305467363476, 33276.500852486744, 33382.0, 33398.499022514196, 33495.0, 33603.327933440705, 231141.0, 231447.0, 232052.0, 232223.0, 232982.0, 23451.530969380176, 24268.393290167885, 24384.51230975406, 25399.746002539738, 25529.489410212063, 36752.96226227265, 36975.26049479049, 37168.93387381584, 37639.62360376361, 37773.81113094417, 31984.200394990312, 31996.52005219877, 32246.35507289888, 32350.676493234765, 32561.0, 31823.36353272968, 32241.838790805898, 32321.838390807894, 32355.35289294248, 33119.50320745239, 31107.37785244328, 31595.0, 31630.209244769067, 31747.206319841265, 32023.359532808747, 28286.15141545757, 28894.71105289004, 29601.85199073991, 29743.25641858971, 29761.25596860096, 22637.547249055257, 22801.657975130056, 22808.771912280667, 23028.884855575616, 23046.884765576066], "value": 17030.182965542426, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.14546949833095, 383.4650662326054, 385.21608526648276, 385.41994298580613, 414.34533437169273, 15092.47176348828, 16583.66832663346, 17132.143392830356, 18719.625607487844, 18758.90620546897, 11016.944915275413, 12269.079819013565, 16317.428889988852, 17424.041677707723, 17430.912845435785, 4598.678092533524, 4721.834735784249, 4727.3618061561765, 4742.0, 4776.522347765231, 4608.377868987677, 4719.575238228559, 4761.0, 5132.692038477703, 5158.045761534109, 5098.923516147261, 5141.357330333708, 5144.742762861842, 5154.74226288686, 5164.457731938149, 4714.95285047152, 4731.550502702238, 4897.094037603037, 5110.872228194306, 5143.331366922295, 4646.210144275481, 4647.18674232008, 4653.837115700934, 4661.09108723799, 4670.416197975253, 12488.0, 12575.93712031434, 21479.355619331443, 21586.35240942774, 21679.24122655715, 2194.5391467791783, 2234.162189179058, 2250.0437314141423, 2261.9434514137115, 2272.2047283450825, 9367.53162341887, 9817.950910245474, 10044.0, 13577.0, 14010.649733756636, 1732.3676857946884, 1749.6063385738107, 1770.0707128757376, 1798.5413719501573, 1830.9084545772657, 70956.0, 71377.28622713758, 71404.0, 72353.2764672357, 72712.27287727108, 10339.483025848678, 10463.790724185474, 10513.684589462327, 10790.946045269724, 10810.0270975611, 14710.33803478846, 14762.409503619734, 14786.186759728103, 14798.48205312809, 14826.92586537082, 6654.367835055662, 6871.759488417882, 6913.827154321182, 6989.580625162506, 7096.432285417154, 6212.596181248205, 6257.624542527463, 6442.0, 6455.61266324022, 6457.031445283245, 4422.778861056934, 4481.775911204427, 4483.641308695362, 4555.63554915606, 4625.074985002945, 1872.6629206742916, 1940.5924755801157, 1955.2081407030175, 1967.2426115945464, 1971.9112639931238, 800.1478425476848, 808.5068108453838, 823.0164952881249, 837.7696133563197, 852.7654894903951, 16800.663986720443, 17028.57428564271, 18263.72604410935, 18339.093433485836, 18421.63156736858, 823.9505629662119, 827.3009307135461, 836.3601844588894, 839.1063517353998, 840.5083026429608, 9420.717378478657, 10021.849672254923, 10033.247506437046, 10064.748381290527, 10123.64567240143, 504854.0, 508086.0, 508650.0, 521985.0, 525191.0, 67127.0, 67382.0, 88674.55662721774, 91178.0, 93467.53266233625, 897.228383590112, 913.0914739833908, 916.6333466613274, 922.6632279218037, 924.066692640438, 14747.0, 15140.772888406462, 15845.445409411077, 15952.122633254818, 16117.758233626271, 38149.80925095357, 38863.80568097141, 38919.63781267642, 39054.80472597619, 39624.207515850096, 55081.1737823941, 55219.0, 55465.44534554603, 56694.716526417105, 56898.14652780294, 7705.22947705225, 7718.6140692964, 7855.646495907584, 7871.448998570274, 8010.078840933367, 8482.406231563731, 11545.826812597987, 11790.0, 11868.881311186778, 11926.165168438127, 9587.760305992406, 9961.950190249003, 10158.238132140266, 10309.278350515391, 10653.254272200871, 9863.0, 9940.900590993997, 10392.116670083127, 10427.68716938493, 10741.0, 10043.497825108569, 10465.319754216256, 10593.258471906893, 10679.89320106789, 11040.558377664804, 6527.0, 6665.800025999228, 6773.796786096425, 7081.752138675121, 8234.135415781257, 10050.69847904564, 10140.442275674908, 10298.433586152534, 10429.269951103654, 10464.581416743245], "value": 8265.09447235462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.5084667826225, 1313.4746101559374, 1318.0707601141196, 1324.5761356365954, 1339.524468813571, 6161.137440758297, 6476.1257230273895, 6640.966795166029, 7079.398251148652, 7105.573665580069, 6709.329067093288, 6854.0404343391965, 6968.860622787553, 6982.16214054313, 7055.259197784236, 2036.4603380104284, 2072.29541955735, 2073.5749171419825, 2077.480629842539, 2082.021449918536, 2073.8444616653737, 2083.468715477551, 2116.0689296709397, 2119.8940052997364, 2148.731408573928, 2124.2777455665073, 2131.9040643171093, 2140.5076832328573, 2143.710599069121, 2145.7961493658077, 2086.6348389031937, 2096.6330892093824, 2113.3765539165984, 2114.5242320477923, 2115.2279418012467, 2065.297798748418, 2086.7078608994752, 2094.8009939055764, 2100.2649072824543, 2129.1802655977403, 6922.7923162304705, 6944.236134025253, 6961.895571566431, 6964.721411143548, 6971.337722916315, 4250.574942505756, 4363.192809330284, 4369.257226271541, 4370.628496577795, 4381.233284175289, 2713.3759235375974, 2856.871440785149, 2897.4350001749667, 2919.2409973406857, 2923.0938409093037, 1020.7601213714771, 1052.9947350263276, 1092.5302120088359, 1101.3997371432588, 1113.2318700096907, 8951.149640784115, 9054.5925433355, 9116.58975346111, 9122.498262595554, 9149.451032938112, 3662.1760103976926, 3745.3258413485833, 3799.2021675447913, 3829.8659546915724, 3853.499045124172, 7301.08736407949, 7316.853662926712, 7342.082239720035, 7343.88984165238, 7368.189499155089, 4273.102648443862, 4280.422143010654, 4283.914321713548, 4286.87139385819, 4289.914201715948, 3890.3386424307937, 3962.1481381503113, 4043.7978101094827, 4071.572484889044, 4084.2852500812833, 3151.4327421064427, 3157.952630710541, 3210.5184222366365, 3220.790648607833, 3253.4469140246215, 928.3408779766306, 937.5640327247726, 973.352720440913, 1000.1998401278947, 1010.1766311807258, 759.1383779410298, 760.7679657704454, 770.7880332908495, 771.3559178086249, 774.795430288173, 4563.087382523442, 4581.312803079565, 4623.514530974267, 4680.227762419231, 4786.904261914742, 846.3229416466925, 880.8898887639045, 887.1084560017271, 889.2397000564554, 889.3374436045187, 3058.113147187291, 3065.4788685923445, 3125.6561778204377, 3184.6496885342594, 3211.5066494080365, 7924.366050715929, 8134.0, 8135.959320203361, 8143.022837259448, 8161.836763264701, 8094.392920530984, 8117.797055073553, 8121.715739949073, 8128.227818357246, 8144.104148543655, 6533.346665333524, 6539.738410463623, 6639.170103737033, 6646.335366463411, 6660.067590537328, 4331.566843315643, 4524.547545245581, 4575.3137029444515, 4620.075984802986, 4652.046330502307, 7366.926330736838, 7517.661705223388, 7552.697892084255, 7566.924330756622, 7572.545647261182, 7560.130584982578, 7671.07947046358, 7745.419093568117, 7748.57382843949, 7749.845003100019, 5934.169216309807, 6138.508919286535, 6143.293521245114, 6263.6241825490615, 6265.937340626535, 6577.112089867998, 6658.76694315716, 6672.399484046459, 6711.46308295345, 6714.294999025227, 6060.606060606046, 6110.663913484801, 6120.908186377297, 6124.755009799736, 6283.685815709105, 5849.64902105875, 5921.496672782861, 5989.460948514655, 6036.8188954331445, 6087.634741915499, 5403.351597808288, 5520.1167813149705, 5552.52803511706, 5554.50009499147, 5564.916526252028, 3988.581198974182, 4025.6578190854107, 4066.755994640331, 4085.264652362603, 4120.299549076604, 3944.1914407546956, 3969.92060158801, 3976.085500334997, 4047.494063242095, 4092.447519584818], "value": 3752.477584914038, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.1140641751227, 333.51640121823357, 338.6748721227621, 341.5252798609931, 343.92180514088335, 4813.518648135185, 4943.777530011149, 4983.312348861843, 5046.798128074877, 5055.747212639362, 4764.285357196422, 4894.192458244385, 4948.876278093049, 4969.726665033421, 4970.304157417955, 3940.5271367435803, 3992.0618654616214, 3995.7602543847315, 4000.3999400090074, 4006.135613036678, 3915.9804200978956, 3981.6217459341315, 4009.7594144351287, 4022.919541609166, 4031.3549832026883, 3946.7237293389476, 3948.960510394888, 3966.226585815767, 3973.9801300993454, 3982.9601703983026, 3954.387070004154, 3956.980215098935, 3962.434838238894, 3965.6827453803626, 3968.8412463501427, 3545.982270088659, 3564.41187204111, 3571.839152275521, 3574.6246644102257, 3577.481265216555, 4676.936606522733, 4843.58829499493, 4854.0, 4918.729469879156, 4959.876003099916, 4428.136513379892, 4486.304622783474, 4488.41650585425, 4492.483364413101, 4524.547545245449, 5211.296474975906, 5224.216367544861, 5239.921401178985, 5246.554042906358, 5246.737663116829, 3416.121133376658, 3582.960941327038, 3860.305145073886, 3862.0, 3884.4173373994126, 5440.4287549807095, 5448.37343705475, 5452.809151679672, 5456.508914197741, 5456.7544460499375, 3694.3350196964802, 3696.7042636589545, 3697.1126929536717, 3711.870084547028, 3716.832742526593, 3733.775973441602, 3751.1934933988778, 3756.323861704919, 3760.511133552621, 3777.3956167013694, 4147.668186545069, 4302.419173411612, 4309.978450107729, 4312.094460163401, 4313.374560688682, 5185.196294574347, 5197.24639927216, 5213.791448342024, 5219.791208351623, 5223.791048358099, 1212.5089338817793, 1236.3509157692283, 1236.8021116621298, 1239.2254840724547, 1251.7621651886295, 810.8986376702912, 821.572782153277, 826.1944604011161, 828.4201059258543, 832.1137988042715, 4372.650187984954, 4417.0, 4420.270655341897, 4427.822887084545, 4434.179676759745, 5163.4114290567695, 5163.8381364192755, 5168.080034780337, 5170.6122040847085, 5189.351331083614, 4412.124846940038, 4423.301785910592, 4429.867103986821, 4431.578999994996, 4435.0, 2613.9480507801286, 2736.86315684215, 2750.917472475829, 2754.394033312668, 2764.9170524884285, 4763.1426343258545, 4798.776312040407, 4810.42274927004, 4818.012307477029, 4854.660173787872, 5026.748662566857, 5319.255304257407, 5320.627556071116, 5322.467753224647, 5332.173513105475, 4781.163296423112, 4792.496787837227, 4801.7995501124715, 4819.59033482158, 4834.516548345278, 5187.870303242449, 5202.127234195762, 5205.92191117126, 5206.349206349207, 5208.661437006583, 4895.290182923527, 4984.925226121539, 5123.205903085028, 5126.4360920297995, 5146.0, 4788.569028787426, 4817.098150498107, 4839.685420447659, 4848.321235027029, 4878.463369029475, 3609.296187243462, 3612.8438899551893, 3615.222727113683, 3615.584207816135, 3621.8732344367822, 5009.396992962363, 5194.506521880416, 5214.001948879334, 5264.894702106013, 5322.733863306742, 4978.303037574815, 5036.992601479792, 5043.268726034631, 5043.747812609428, 5060.2156665716875, 4980.676256043345, 5009.323741294878, 5068.265101560327, 5078.441371449064, 5081.415637201769, 4726.598239149574, 4929.383827021622, 4940.851774446773, 4952.7771250294545, 4995.700257984533, 5042.621803364689, 5066.544011039025, 5075.365579302587, 5097.923531146962, 5106.770195341144, 4829.323894654681, 4870.488598697086, 4881.487443818348, 4886.340344053508, 4896.828610998598], "value": 3860.789687085521, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.459357920085, 690.9343612356824, 729.595074733523, 743.9628018599069, 755.8148253677849, 12283.324417157053, 12456.31490268036, 12457.875421245784, 12463.937680311608, 12553.309567973769, 13156.276404797733, 13275.40260688269, 13282.933585332059, 13311.600651980456, 13374.331283435813, 649.5907578225734, 666.2138676361891, 790.0835031363605, 791.3392317414965, 814.352589691197, 807.4711064252924, 808.5633757770826, 811.2455416462687, 812.0742353716768, 813.2843098073716, 858.7080392666492, 862.7368652560998, 865.8095219051798, 868.0928429790883, 868.2619773192768, 855.1448551448551, 858.3948316436897, 858.8024754306482, 858.845407826591, 859.2138193552892, 622.2004723929729, 625.3808729357949, 626.6240255846501, 626.8401557602828, 627.9152314437538, 13671.453141874412, 13723.1079979801, 13746.312684365741, 13772.0, 14015.29923503831, 13631.318434078355, 14482.782758258634, 14493.637659058608, 14545.27273636314, 14559.126452412784, 10434.0, 10491.370517768959, 10504.212184086224, 10509.106725928305, 10683.14534837211, 3274.5743053402907, 3304.1574398528223, 3314.5359649649067, 3324.2188085799817, 3342.615599206098, 62702.37297627056, 62933.37066629321, 63508.682456587885, 64100.35899640991, 64509.67745161291, 10310.639127630497, 10360.948195258976, 10443.164546836388, 10615.363078215178, 10867.239293249397, 19643.803561964483, 19652.11565479557, 19687.114079866442, 19700.507487312647, 19764.90117549403, 6751.763688270887, 6770.93229067703, 6895.620740859201, 7109.680064397115, 7138.179109402381, 3604.621514740967, 3661.2494438640547, 3708.8331025103935, 3718.6095459976855, 3731.9440208396895, 2849.928751781222, 2894.623698919127, 2902.6081479000486, 2905.302727345464, 2913.898013569515, 466.10042617747393, 474.71517089745873, 476.0194000359271, 482.4307317365472, 483.6469377354551, 540.2733323679645, 564.6640249051808, 566.8526183192399, 567.1379503155181, 570.0707846210732, 8144.348452123816, 8855.114488551093, 8968.242879099289, 9204.861927070966, 9517.666881659108, 622.5299898576545, 637.9872402551923, 640.5164101103637, 644.6422235659254, 650.177525430331, 4024.71826972115, 4335.783210839445, 4362.454693163355, 4372.890677733082, 4406.757628330409, 64727.0, 66324.33675663278, 66826.66586667036, 67636.6618166906, 70196.29803702, 57807.42192578105, 58143.709281453324, 58875.41124588785, 62577.0, 63070.684646576476, 54070.918581628146, 54672.17991730127, 54814.72592637011, 55028.0, 55243.447565524635, 8163.877541836759, 8509.74470765878, 8523.95738021306, 8560.48637081777, 8727.952645682559, 36861.26277474489, 37598.43602346021, 37927.62072379241, 38005.80997095107, 38381.80809095937, 44501.0, 44997.55002450065, 46549.767251163525, 47144.528554714016, 48727.756361217966, 10232.283740138417, 10367.118794902217, 10591.0, 10633.574657013942, 10679.786404272027, 11592.88407115918, 11598.594049208237, 11676.88323116758, 12095.274283543016, 12504.937475312565, 10880.129589632968, 10953.945230273797, 11117.833232501358, 11166.44167791591, 11523.596674116367, 10343.741406464898, 10348.637797677045, 10783.19126065564, 10798.298110622783, 11132.109431245319, 10157.339772914736, 10172.0, 10176.796464070825, 10206.336588121749, 10356.378617282988, 8772.56137193125, 9044.81910361776, 9385.0, 9400.623975040922, 9633.32566720323, 7856.882146767917, 8601.526916019679, 8874.955625221832, 8931.330150238888, 9011.188992990663], "value": 6297.602245900677, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 116.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 134.0, 124.0, 175.0, 132.0, 131.0, 129.0, 137.0, 156.0, 131.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 166.0, 175.0, 163.0, 164.0, 165.0, 163.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 108.0, 76.0, 78.0, 79.0, 77.0, 98.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 105.0, 84.0, 84.0, 85.0, 106.0, 84.0, 84.0, 115.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 121.0, 118.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 149.0, 150.0, 149.0, 152.0, 150.0, 151.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 73.0, 67.0, 67.0, 65.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 89.0, 89.0, 86.0, 85.0, 85.0, 85.0, 93.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 142.0, 136.0, 148.0, 136.0, 132.0, 146.0, 133.0, 189.0, 144.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 181.0, 181.0, 183.0, 181.0, 183.0, 182.0, 179.0, 187.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 69.0, 70.0, 78.0, 69.0, 69.0, 67.0, 68.0, 69.0], "value": 70.4, "unit": "score"}]}]} 07:52:44 INFO - Return code: 0 07:52:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:52:44 ERROR - # TBPL SUCCESS # 07:52:44 INFO - Running post-action listener: _resource_record_post_action 07:52:44 INFO - [mozharness: 2017-01-31 15:52:44.999108Z] Finished run-tests step (success) 07:52:44 INFO - Running post-run listener: _resource_record_post_run 07:52:45 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 2269184; Write bytes: 398102528; Read time: 632; Write time: 421668 07:52:45 INFO - TinderboxPrint: CPU usage
13.5% 07:52:45 INFO - TinderboxPrint: I/O read bytes / time
2,269,184 / 632 07:52:45 INFO - TinderboxPrint: I/O write bytes / time
398,102,528 / 421,668 07:52:45 INFO - TinderboxPrint: CPU idle
8,289.4 (86.5%) 07:52:45 INFO - TinderboxPrint: CPU user
1,235.8 (12.9%) 07:52:45 INFO - TinderboxPrint: Swap in / out
0 / 0 07:52:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100044800; Read time: 0; Write time: 137380 07:52:45 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 2265088; Write bytes: 298057728; Read time: 624; Write time: 284288 07:52:45 INFO - Running post-run listener: _upload_blobber_files 07:52:45 INFO - Blob upload gear active. 07:52:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:52:45 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 07:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:52:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:47 INFO - (blobuploader) - INFO - Done attempting. 07:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:47 INFO - (blobuploader) - INFO - Done attempting. 07:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:51 INFO - (blobuploader) - INFO - Done attempting. 07:52:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:52:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:52 INFO - (blobuploader) - INFO - Done attempting. 07:52:52 INFO - (blobuploader) - INFO - Iteration through files over. 07:52:52 INFO - Return code: 0 07:52:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:52:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:52:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cb658ce080021417e011b933c92f2ea8e4de44b178bf9d9c1de48d19c53f93af4d321e62db97c9e34aabae97e73316fa3006305276b4f6dc9b55c90bb854edb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f46e3314a40145cb7792dedde2f7d8761b59605227081f01f399d67660ad9f47c95f561c760bf781d4f386d7ee3b292d54dd27dbbf6874cdf9e331f13c9ce03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dd707f958b3181048dba924aaa982895c0c9625c52d1cff9a338122b5bfefe4050a08afb8b4d47482ba50dc0f5752235d4afbd40c0e3641312e6f65d79efb70", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee7c91040704720dfb0d0ad846909f37616e552c700a6ec192c8fb347f7dc1b874f30e42877cccbfe7d17fd71630d66eb4119b72096757a86ee84b10c6057a7f"} 07:52:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:52:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:52:52 INFO - Contents: 07:52:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cb658ce080021417e011b933c92f2ea8e4de44b178bf9d9c1de48d19c53f93af4d321e62db97c9e34aabae97e73316fa3006305276b4f6dc9b55c90bb854edb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f46e3314a40145cb7792dedde2f7d8761b59605227081f01f399d67660ad9f47c95f561c760bf781d4f386d7ee3b292d54dd27dbbf6874cdf9e331f13c9ce03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dd707f958b3181048dba924aaa982895c0c9625c52d1cff9a338122b5bfefe4050a08afb8b4d47482ba50dc0f5752235d4afbd40c0e3641312e6f65d79efb70", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee7c91040704720dfb0d0ad846909f37616e552c700a6ec192c8fb347f7dc1b874f30e42877cccbfe7d17fd71630d66eb4119b72096757a86ee84b10c6057a7f"} 07:52:52 INFO - Running post-run listener: copy_logs_to_upload_dir 07:52:52 INFO - Copying logs to upload dir... 07:52:52 INFO - mkdir: /builds/slave/test/build/upload/logs 07:52:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.265886 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-31 07:52:51.751682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 07:52:51.755036) ========= 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=5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cb658ce080021417e011b933c92f2ea8e4de44b178bf9d9c1de48d19c53f93af4d321e62db97c9e34aabae97e73316fa3006305276b4f6dc9b55c90bb854edb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f46e3314a40145cb7792dedde2f7d8761b59605227081f01f399d67660ad9f47c95f561c760bf781d4f386d7ee3b292d54dd27dbbf6874cdf9e331f13c9ce03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dd707f958b3181048dba924aaa982895c0c9625c52d1cff9a338122b5bfefe4050a08afb8b4d47482ba50dc0f5752235d4afbd40c0e3641312e6f65d79efb70", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee7c91040704720dfb0d0ad846909f37616e552c700a6ec192c8fb347f7dc1b874f30e42877cccbfe7d17fd71630d66eb4119b72096757a86ee84b10c6057a7f"} build_url:https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011488 build_url: 'https://queue.taskcluster.net/v1/task/OBbgE_NrTWWYQNczn6-_GQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cb658ce080021417e011b933c92f2ea8e4de44b178bf9d9c1de48d19c53f93af4d321e62db97c9e34aabae97e73316fa3006305276b4f6dc9b55c90bb854edb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f46e3314a40145cb7792dedde2f7d8761b59605227081f01f399d67660ad9f47c95f561c760bf781d4f386d7ee3b292d54dd27dbbf6874cdf9e331f13c9ce03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0dd707f958b3181048dba924aaa982895c0c9625c52d1cff9a338122b5bfefe4050a08afb8b4d47482ba50dc0f5752235d4afbd40c0e3641312e6f65d79efb70", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee7c91040704720dfb0d0ad846909f37616e552c700a6ec192c8fb347f7dc1b874f30e42877cccbfe7d17fd71630d66eb4119b72096757a86ee84b10c6057a7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 07:52:51.783231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 07:52:51.783889) ========= 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=5cf47e208febbcd81da23b2e0000026f-1485876721.865947-1973935784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 07:52:51.868442) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 07:52:51.869207) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 07:52:51.869852) ========= ========= Total master_lag: 0.18 =========